Cisco Support Community
cancel
Showing results for 
Search instead for 
Did you mean: 
Announcements

Welcome to Cisco Support Community. We would love to have your feedback.

For an introduction to the new site, click here. If you'd prefer to explore, try our test area to get started. And see here for current known issues.

2901 Gateway Calls don´t enter

Hello Friends,

I have a CUCM 7.1.5 and Remote Gateway, but Calls don´t enter:

Internal Calls to 4 digits OK

GW < CUCM  OK

GW > CUCM OK

GW > PSTN OK

GW < PSTN NOK

I attached some files.

Everyone's tags (3)
5 REPLIES
Hall of Fame Super Silver

2901 Gateway Calls don´t enter

Are you using MGCP or H323 for these?

If H323 then you need "plar" config on your voice-ports to direct the call to desired extension, i.e:

voice-port 0/0/0

connection plar opx

If MGCP ensure you have the "Attendant DN" set on the voice port in CUCM with proper destiantion and CSS.

HTH,

Chris

VIP Super Bronze

2901 Gateway Calls don´t enter

Claudio,

Can you send the ff logs

debug mgcp packet

debug vpm signal

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts "The essence of christianity is not the enthronement but the obliteration of self --William Barclay"

2901 Gateway Calls don´t enter

Hello Friend,

I sent you the information....Can you give me any idea please?

2901 Gateway Calls don´t enter

Chris and aokanlawon:

Attendant DN is set with 7390 OK.

CSS Gateway and CSS 7390 internal number are OK.

_____________________________________________________________

DEBUG VPM and MGCP PACKET

CS120464_AFPM_TEMU#debug vpm signal

Voice Port Module signaling debugging is enabled

CS120464_AFPM_TEMU#

*Nov  8 18:37:37.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:37:37.914: htsp_timer - 125 msec

*Nov  8 18:37:38.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:37:38.042: htsp_timer - 10000 msec

*Nov  8 18:37:38.042: htsp_timer3 - 5600 msec

*Nov  8 18:37:38.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:37:38.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:37:38.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:37:39.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:37:39.246: fxols_ringing_not

*Nov  8 18:37:39.246: htsp_timer_stop

*Nov  8 18:37:39.246: htsp_timer - 10000 msec

*Nov  8 18:37:42.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:37:43.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:37:43.642: htsp_timer_stop3

*Nov  8 18:37:44.242: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:37:44.242: fxols_ringing_not

*Nov  8 18:37:44.242: htsp_timer_stop

*Nov  8 18:37:44.242: htsp_timer_stop3

*Nov  8 18:37:44.242: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:37:44.242: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:37:44.242: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:38  orig called=

*Nov  8 18:37:44.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:37:44.246: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:37:44.246: fxols_wait_setup_ack:

*Nov  8 18:37:44.246: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:37:44.246: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:37:44.246: htsp_timer_stop

*Nov  8 18:37:44.262: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:37:44.262: htsp_call_bridged invoked

*Nov  8 18:37:44.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:37:44.498: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:37:44.498: htsp_timer2 - 350 msec

*Nov  8 18:37:44.850: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:37:44.850: htsp_timer_stop

*Nov  8 18:37:44.850: htsp_timer_stop2

*Nov  8 18:37:44.850: htsp_timer_stop3

*Nov  8 18:37:44.874: htsp_timer_stop3

*Nov  8 18:37:44.894: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:37:44.894: htsp_timer_stop

*Nov  8 18:37:44.894: htsp_timer_stop2

*Nov  8 18:37:44.894: htsp_timer_stop3

*Nov  8 18:37:44.894: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:37:44.894: htsp_timer - 2000 msec

*Nov  8 18:37:46.894: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:37:46.898: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:37:47.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:37:47.914: htsp_timer - 125 msec

*Nov  8 18:37:48.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:37:48.042: htsp_timer - 10000 msec

*Nov  8 18:37:48.042: htsp_timer3 - 5600 msec

*Nov  8 18:37:48.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:37:48.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:37:48.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:37:49.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:37:49.246: fxols_ringing_not

*Nov  8 18:37:49.246: htsp_timer_stop

*Nov  8 18:37:49.246: htsp_timer - 10000 msec

*Nov  8 18:37:52.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:37:53.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:37:53.642: htsp_timer_stop3

*Nov  8 18:37:54.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:37:54.246: fxols_ringing_not

*Nov  8 18:37:54.246: htsp_timer_stop

*Nov  8 18:37:54.246: htsp_timer_stop3

*Nov  8 18:37:54.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:37:54.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:37:54.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:38  orig called=

*Nov  8 18:37:54.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:37:54.246: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:37:54.246: fxols_wait_setup_ack:

*Nov  8 18:37:54.246: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:37:54.246: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:37:54.246: htsp_timer_stop

*Nov  8 18:37:54.262: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:37:54.262: htsp_call_bridged invoked

*Nov  8 18:37:54.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:37:54.502: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:37:54.502: htsp_timer2 - 350 msec

*Nov  8 18:37:54.854: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:37:54.854: htsp_timer_stop

*Nov  8 18:37:54.854: htsp_timer_stop2

*Nov  8 18:37:54.854: htsp_timer_stop3

*Nov  8 18:37:54.878: htsp_timer_stop3

*Nov  8 18:37:54.894: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:37:54.894: htsp_timer_stop

*Nov  8 18:37:54.894: htsp_timer_stop2

*Nov  8 18:37:54.894: htsp_timer_stop3

*Nov  8 18:37:54.894: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:37:54.894: htsp_timer - 2000 msec

*Nov  8 18:37:56.894: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:37:56.894: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:37:57.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:37:57.914: htsp_timer - 125 msec

*Nov  8 18:37:58.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:37:58.042: htsp_timer - 10000 msec

*Nov  8 18:37:58.042: htsp_timer3 - 5600 msec

*Nov  8 18:37:58.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:37:58.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:37:58.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:37:59.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:37:59.246: fxols_ringing_not

*Nov  8 18:37:59.246: htsp_timer_stop

*Nov  8 18:37:59.246: htsp_timer - 10000 msec

*Nov  8 18:38:02.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:38:03.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:38:03.642: htsp_timer_stop3

*Nov  8 18:38:04.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:04.246: fxols_ringing_not

*Nov  8 18:38:04.246: htsp_timer_stop

*Nov  8 18:38:04.246: htsp_timer_stop3

*Nov  8 18:38:04.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:38:04.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:38:04.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:39  orig called=

*Nov  8 18:38:04.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:38:04.246: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:38:04.246: fxols_wait_setup_ack:

*Nov  8 18:38:04.246: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:38:04.250: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:38:04.250: htsp_timer_stop

*Nov  8 18:38:04.262: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:04.266: htsp_call_bridged invoked

*Nov  8 18:38:04.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:04.502: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:38:04.502: htsp_timer2 - 350 msec

*Nov  8 18:38:04.854: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:38:04.854: htsp_timer_stop

*Nov  8 18:38:04.854: htsp_timer_stop2

*Nov  8 18:38:04.854: htsp_timer_stop3

*Nov  8 18:38:04.878: htsp_timer_stop3

*Nov  8 18:38:04.894: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:38:04.894: htsp_timer_stop

*Nov  8 18:38:04.894: htsp_timer_stop2

*Nov  8 18:38:04.894: htsp_timer_stop3

*Nov  8 18:38:04.894: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:38:04.894: htsp_timer - 2000 msec

*Nov  8 18:38:06.894: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:38:06.894: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:38:07.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:38:07.914: htsp_timer - 125 msec

*Nov  8 18:38:08.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:38:08.042: htsp_timer - 10000 msec

*Nov  8 18:38:08.042: htsp_timer3 - 5600 msec

*Nov  8 18:38:08.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:38:08.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:38:08.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:38:09.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:09.246: fxols_ringing_not

*Nov  8 18:38:09.246: htsp_timer_stop

*Nov  8 18:38:09.246: htsp_timer - 10000 msec

*Nov  8 18:38:12.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:38:13.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:38:13.642: htsp_timer_stop3

*Nov  8 18:38:14.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:14.246: fxols_ringing_not

*Nov  8 18:38:14.246: htsp_timer_stop

*Nov  8 18:38:14.246: htsp_timer_stop3

*Nov  8 18:38:14.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:38:14.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:38:14.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:39  orig called=

*Nov  8 18:38:14.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:38:14.250: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:38:14.250: fxols_wait_setup_ack:

*Nov  8 18:38:14.250: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:38:14.250: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:38:14.250: htsp_timer_stop

*Nov  8 18:38:14.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:14.266: htsp_call_bridged invoked

*Nov  8 18:38:14.270: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:14.502: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:38:14.502: htsp_timer2 - 350 msec

*Nov  8 18:38:14.854: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:38:14.854: htsp_timer_stop

*Nov  8 18:38:14.854: htsp_timer_stop2

*Nov  8 18:38:14.854: htsp_timer_stop3

*Nov  8 18:38:14.878: htsp_timer_stop3

*Nov  8 18:38:14.894: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:38:14.894: htsp_timer_stop

*Nov  8 18:38:14.894: htsp_timer_stop2

*Nov  8 18:38:14.894: htsp_timer_stop3

*Nov  8 18:38:14.894: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:38:14.894: htsp_timer - 2000 msec

*Nov  8 18:38:16.894: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:38:16.894: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:38:17.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:38:17.914: htsp_timer - 125 msec

*Nov  8 18:38:18.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:38:18.042: htsp_timer - 10000 msec

*Nov  8 18:38:18.042: htsp_timer3 - 5600 msec

*Nov  8 18:38:18.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:38:18.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:38:18.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:38:19.242: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:19.242: fxols_ringing_not

*Nov  8 18:38:19.242: htsp_timer_stop

*Nov  8 18:38:19.242: htsp_timer - 10000 msec

*Nov  8 18:38:22.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:38:23.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:38:23.642: htsp_timer_stop3

*Nov  8 18:38:24.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:24.246: fxols_ringing_not

*Nov  8 18:38:24.246: htsp_timer_stop

*Nov  8 18:38:24.246: htsp_timer_stop3

*Nov  8 18:38:24.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:38:24.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:38:24.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:39  orig called=

*Nov  8 18:38:24.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:38:24.250: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:38:24.250: fxols_wait_setup_ack:

*Nov  8 18:38:24.250: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:38:24.250: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:38:24.250: htsp_timer_stop

*Nov  8 18:38:24.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:24.266: htsp_call_bridged invoked

*Nov  8 18:38:24.270: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:24.506: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:38:24.506: htsp_timer2 - 350 msec

*Nov  8 18:38:24.858: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:38:24.858: htsp_timer_stop

*Nov  8 18:38:24.858: htsp_timer_stop2

*Nov  8 18:38:24.858: htsp_timer_stop3

*Nov  8 18:38:24.882: htsp_timer_stop3

*Nov  8 18:38:24.902: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:38:24.902: htsp_timer_stop

*Nov  8 18:38:24.902: htsp_timer_stop2

*Nov  8 18:38:24.902: htsp_timer_stop3

*Nov  8 18:38:24.902: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:38:24.902: htsp_timer - 2000 msec

*Nov  8 18:38:26.902: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:38:26.902: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:38:27.910: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:38:27.910: htsp_timer - 125 msec

*Nov  8 18:38:28.038: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:38:28.038: htsp_timer - 10000 msec

*Nov  8 18:38:28.038: htsp_timer3 - 5600 msec

*Nov  8 18:38:28.038: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:38:28.038: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:38:28.038: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:38:29.242: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:29.242: fxols_ringing_not

*Nov  8 18:38:29.242: htsp_timer_stop

*Nov  8 18:38:29.242: htsp_timer - 10000 msec

*Nov  8 18:38:32.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:38:33.638: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:38:33.638: htsp_timer_stop3

*Nov  8 18:38:34.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:34.246: fxols_ringing_not

*Nov  8 18:38:34.246: htsp_timer_stop

*Nov  8 18:38:34.246: htsp_timer_stop3

*Nov  8 18:38:34.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:38:34.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:38:34.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:39  orig called=

*Nov  8 18:38:34.250: [0/0/1] htsp_dsm_close_done

*Nov  8 18:38:34.250: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:38:34.250: fxols_wait_setup_ack:

*Nov  8 18:38:34.250: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:38:34.250: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:38:34.250: htsp_timer_stop

*Nov  8 18:38:34.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:34.266: htsp_call_bridged invoked

*Nov  8 18:38:34.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:34.502: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:38:34.502: htsp_timer2 - 350 msec

*Nov  8 18:38:34.854: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:38:34.854: htsp_timer_stop

*Nov  8 18:38:34.854: htsp_timer_stop2

*Nov  8 18:38:34.854: htsp_timer_stop3

*Nov  8 18:38:34.878: htsp_timer_stop3

*Nov  8 18:38:34.898: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:38:34.898: htsp_timer_stop

*Nov  8 18:38:34.898: htsp_timer_stop2

*Nov  8 18:38:34.898: htsp_timer_stop3

*Nov  8 18:38:34.898: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:38:34.898: htsp_timer - 2000 msec

*Nov  8 18:38:36.898: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:38:36.902: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:38:37.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:38:37.914: htsp_timer - 125 msec

*Nov  8 18:38:38.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:38:38.042: htsp_timer - 10000 msec

*Nov  8 18:38:38.042: htsp_timer3 - 5600 msec

*Nov  8 18:38:38.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:38:38.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:38:38.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:38:39.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:39.246: fxols_ringing_not

*Nov  8 18:38:39.246: htsp_timer_stop

*Nov  8 18:38:39.246: htsp_timer - 10000 msec

*Nov  8 18:38:42.962: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:38:43.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:38:43.642: htsp_timer_stop3

*Nov  8 18:38:44.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:44.246: fxols_ringing_not

*Nov  8 18:38:44.246: htsp_timer_stop

*Nov  8 18:38:44.246: htsp_timer_stop3

*Nov  8 18:38:44.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:38:44.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:38:44.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:39  orig called=

*Nov  8 18:38:44.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:38:44.246: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:38:44.246: fxols_wait_setup_ack:

*Nov  8 18:38:44.246: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:38:44.246: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:38:44.246: htsp_timer_stop

*Nov  8 18:38:44.262: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:44.262: htsp_call_bridged invoked

*Nov  8 18:38:44.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:44.502: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:38:44.502: htsp_timer2 - 350 msec

*Nov  8 18:38:44.854: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:38:44.854: htsp_timer_stop

*Nov  8 18:38:44.854: htsp_timer_stop2

*Nov  8 18:38:44.854: htsp_timer_stop3

*Nov  8 18:38:44.878: htsp_timer_stop3

*Nov  8 18:38:44.894: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:38:44.894: htsp_timer_stop

*Nov  8 18:38:44.894: htsp_timer_stop2

*Nov  8 18:38:44.894: htsp_timer_stop3

*Nov  8 18:38:44.894: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:38:44.894: htsp_timer - 2000 msec

*Nov  8 18:38:46.894: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:38:46.894: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:38:47.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:38:47.914: htsp_timer - 125 msec

*Nov  8 18:38:48.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:38:48.042: htsp_timer - 10000 msec

*Nov  8 18:38:48.042: htsp_timer3 - 5600 msec

*Nov  8 18:38:48.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:38:48.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:38:48.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:38:49.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:49.246: fxols_ringing_not

*Nov  8 18:38:49.246: htsp_timer_stop

*Nov  8 18:38:49.246: htsp_timer - 10000 msec

*Nov  8 18:38:52.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:38:53.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:38:53.642: htsp_timer_stop3

*Nov  8 18:38:54.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:54.246: fxols_ringing_not

*Nov  8 18:38:54.246: htsp_timer_stop

*Nov  8 18:38:54.246: htsp_timer_stop3

*Nov  8 18:38:54.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:38:54.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:38:54.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:39  orig called=

*Nov  8 18:38:54.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:38:54.250: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:38:54.250: fxols_wait_setup_ack:

*Nov  8 18:38:54.250: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:38:54.250: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:38:54.250: htsp_timer_stop

*Nov  8 18:38:54.262: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:54.266: htsp_call_bridged invoked

*Nov  8 18:38:54.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:38:54.506: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:38:54.506: htsp_timer2 - 350 msec

*Nov  8 18:38:54.858: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:38:54.858: htsp_timer_stop

*Nov  8 18:38:54.858: htsp_timer_stop2

*Nov  8 18:38:54.858: htsp_timer_stop3

*Nov  8 18:38:54.886: htsp_timer_stop3

*Nov  8 18:38:54.906: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:38:54.906: htsp_timer_stop

*Nov  8 18:38:54.906: htsp_timer_stop2

*Nov  8 18:38:54.906: htsp_timer_stop3

*Nov  8 18:38:54.906: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:38:54.906: htsp_timer - 2000 msec

*Nov  8 18:38:56.906: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:38:56.906: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:38:57.914: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:38:57.914: htsp_timer - 125 msec

*Nov  8 18:38:58.042: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:38:58.042: htsp_timer - 10000 msec

*Nov  8 18:38:58.042: htsp_timer3 - 5600 msec

*Nov  8 18:38:58.042: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:38:58.042: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:38:58.042: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:38:59.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:38:59.246: fxols_ringing_not

*Nov  8 18:38:59.246: htsp_timer_stop

*Nov  8 18:38:59.246: htsp_timer - 10000 msec

*Nov  8 18:39:02.914: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:39:03.642: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:39:03.642: htsp_timer_stop3

*Nov  8 18:39:04.246: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:39:04.246: fxols_ringing_not

*Nov  8 18:39:04.246: htsp_timer_stop

*Nov  8 18:39:04.246: htsp_timer_stop3

*Nov  8 18:39:04.246: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:39:04.246: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:39:04.246: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:40  orig called=

*Nov  8 18:39:04.246: [0/0/1] htsp_dsm_close_done

*Nov  8 18:39:04.250: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:39:04.250: fxols_wait_setup_ack:

*Nov  8 18:39:04.250: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:39:04.250: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:39:04.250: htsp_timer_stop

*Nov  8 18:39:04.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:39:04.266: htsp_call_bridged invoked

*Nov  8 18:39:04.266: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:39:04.502: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:39:04.502: htsp_timer2 - 350 msec

*Nov  8 18:39:04.854: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:39:04.854: htsp_timer_stop

*Nov  8 18:39:04.854: htsp_timer_stop2

*Nov  8 18:39:04.854: htsp_timer_stop3

*Nov  8 18:39:04.878: htsp_timer_stop3

*Nov  8 18:39:04.894: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:39:04.894: htsp_timer_stop

*Nov  8 18:39:04.894: htsp_timer_stop2

*Nov  8 18:39:04.894: htsp_timer_stop3

*Nov  8 18:39:04.894: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:39:04.894: htsp_timer - 2000 msec

*Nov  8 18:39:06.894: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:39:06.894: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

______________________________________________________________________________________

CS120464_AFPM_TEMU#debug mgcp packet

Media Gateway Control Protocol packets debugging for all endpoints is on

CS120464_AFPM_TEMU#

*Nov  8 18:41:31.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:41:31.114: htsp_timer - 125 msec

*Nov  8 18:41:31.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:41:31.242: htsp_timer - 10000 msec

*Nov  8 18:41:31.242: htsp_timer3 - 5600 msec

*Nov  8 18:41:31.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:41:31.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:41:31.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:41:31.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188539 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:41:31.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188539

<---

*Nov  8 18:41:32.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:41:32.446: fxols_ringing_not

*Nov  8 18:41:32.446: htsp_timer_stop

*Nov  8 18:41:32.446: htsp_timer - 10000 msec

*Nov  8 18:41:36.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:41:36.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:41:36.842: htsp_timer_stop3

*Nov  8 18:41:37.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:41:37.446: fxols_ringing_not

*Nov  8 18:41:37.446: htsp_timer_stop

*Nov  8 18:41:37.446: htsp_timer_stop3

*Nov  8 18:41:37.446: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:41:37.446: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:41:37.446: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:42  orig called=

*Nov  8 18:41:37.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:41:37.450: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188540 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:41:37.450: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:41:37.450: fxols_wait_setup_ack:

*Nov  8 18:41:37.450: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:41:37.450: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:41:37.450: htsp_timer_stop

*Nov  8 18:41:37.462: MGCP Packet received from 10.153.50.10:2427--->

200 73188540

<---

*Nov  8 18:41:37.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16252 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a62e000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:41:37.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:41:37.466: htsp_call_bridged invoked

*Nov  8 18:41:37.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:41:37.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16252 OK

I: 609

v=0

o=- 1545 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 31088 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:41:37.482: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16253 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:41:37.482: MGCP Packet sent to 10.153.50.10:2427--->

200 16253 OK

<---

*Nov  8 18:41:37.702: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:41:37.702: htsp_timer2 - 350 msec

*Nov  8 18:41:38.054: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:41:38.054: htsp_timer_stop

*Nov  8 18:41:38.054: htsp_timer_stop2

*Nov  8 18:41:38.054: htsp_timer_stop3

*Nov  8 18:41:38.054: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188541 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:41:38.066: MGCP Packet received from 10.153.50.10:2427--->

200 73188541

<---

*Nov  8 18:41:38.066: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16254 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:41:38.066: MGCP Packet sent to 10.153.50.10:2427--->

200 16254 OK

<---

*Nov  8 18:41:38.078: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16255 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a62e000000F5

I: 609

X: 0

<---

*Nov  8 18:41:38.078: htsp_timer_stop3

*Nov  8 18:41:38.094: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:41:38.094: htsp_timer_stop

*Nov  8 18:41:38.094: htsp_timer_stop2

*Nov  8 18:41:38.094: htsp_timer_stop3

*Nov  8 18:41:38.094: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:41:38.094: htsp_timer - 2000 msec

*Nov  8 18:41:38.098: MGCP Packet sent to 10.153.50.10:2427--->

250 16255 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:41:40.094: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:41:40.094: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:41:41.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:41:41.114: htsp_timer - 125 msec

*Nov  8 18:41:41.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:41:41.242: htsp_timer - 10000 msec

*Nov  8 18:41:41.242: htsp_timer3 - 5600 msec

*Nov  8 18:41:41.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:41:41.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:41:41.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:41:42.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:41:42.446: fxols_ringing_not

*Nov  8 18:41:42.446: htsp_timer_stop

*Nov  8 18:41:42.446: htsp_timer - 10000 msec

*Nov  8 18:41:46.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:41:46.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188542 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:41:46.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188542

<---

*Nov  8 18:41:46.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:41:46.842: htsp_timer_stop3

*Nov  8 18:41:47.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:41:47.446: fxols_ringing_not

*Nov  8 18:41:47.446: htsp_timer_stop

*Nov  8 18:41:47.446: htsp_timer_stop3

*Nov  8 18:41:47.446: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:41:47.446: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:41:47.446: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:42  orig called=

*Nov  8 18:41:47.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:41:47.450: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188543 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:41:47.450: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:41:47.450: fxols_wait_setup_ack:

*Nov  8 18:41:47.450: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:41:47.450: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:41:47.450: htsp_timer_stop

*Nov  8 18:41:47.462: MGCP Packet received from 10.153.50.10:2427--->

200 73188543

<---

*Nov  8 18:41:47.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16256 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a630000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:41:47.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:41:47.466: htsp_call_bridged invoked

*Nov  8 18:41:47.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:41:47.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16256 OK

I: 60A

v=0

o=- 1546 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 27548 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:41:47.482: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16257 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:41:47.482: MGCP Packet sent to 10.153.50.10:2427--->

200 16257 OK

<---

*Nov  8 18:41:47.706: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:41:47.706: htsp_timer2 - 350 msec

*Nov  8 18:41:48.058: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:41:48.058: htsp_timer_stop

*Nov  8 18:41:48.058: htsp_timer_stop2

*Nov  8 18:41:48.058: htsp_timer_stop3

*Nov  8 18:41:48.058: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188544 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:41:48.070: MGCP Packet received from 10.153.50.10:2427--->

200 73188544

<---

*Nov  8 18:41:48.070: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16258 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:41:48.070: MGCP Packet sent to 10.153.50.10:2427--->

200 16258 OK

<---

*Nov  8 18:41:48.082: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16259 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a630000000F5

I: 60A

X: 0

<---

*Nov  8 18:41:48.082: htsp_timer_stop3

*Nov  8 18:41:48.102: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:41:48.102: htsp_timer_stop

*Nov  8 18:41:48.102: htsp_timer_stop2

*Nov  8 18:41:48.102: htsp_timer_stop3

*Nov  8 18:41:48.102: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:41:48.102: htsp_timer - 2000 msec

*Nov  8 18:41:48.102: MGCP Packet sent to 10.153.50.10:2427--->

250 16259 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:41:50.102: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:41:50.102: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:41:51.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:41:51.114: htsp_timer - 125 msec

*Nov  8 18:41:51.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:41:51.242: htsp_timer - 10000 msec

*Nov  8 18:41:51.242: htsp_timer3 - 5600 msec

*Nov  8 18:41:51.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:41:51.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:41:51.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:41:52.442: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:41:52.442: fxols_ringing_not

*Nov  8 18:41:52.442: htsp_timer_stop

*Nov  8 18:41:52.442: htsp_timer - 10000 msec

*Nov  8 18:41:56.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:41:56.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:41:56.842: htsp_timer_stop3

*Nov  8 18:41:57.442: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:41:57.442: fxols_ringing_not

*Nov  8 18:41:57.442: htsp_timer_stop

*Nov  8 18:41:57.442: htsp_timer_stop3

*Nov  8 18:41:57.442: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:41:57.442: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:41:57.442: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:42  orig called=

*Nov  8 18:41:57.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:41:57.446: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188545 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:41:57.446: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:41:57.446: fxols_wait_setup_ack:

*Nov  8 18:41:57.446: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:41:57.446: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:41:57.446: htsp_timer_stop

*Nov  8 18:41:57.458: MGCP Packet received from 10.153.50.10:2427--->

200 73188545

<---

*Nov  8 18:41:57.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16260 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a632000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:41:57.462: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:41:57.462: htsp_call_bridged invoked

*Nov  8 18:41:57.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:41:57.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16260 OK

I: 60B

v=0

o=- 1547 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 19268 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:41:57.478: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16261 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:41:57.478: MGCP Packet sent to 10.153.50.10:2427--->

200 16261 OK

<---

*Nov  8 18:41:57.698: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:41:57.698: htsp_timer2 - 350 msec

*Nov  8 18:41:58.050: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:41:58.050: htsp_timer_stop

*Nov  8 18:41:58.050: htsp_timer_stop2

*Nov  8 18:41:58.050: htsp_timer_stop3

*Nov  8 18:41:58.050: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188546 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:41:58.062: MGCP Packet received from 10.153.50.10:2427--->

200 73188546

<---

*Nov  8 18:41:58.062: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16262 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:41:58.062: MGCP Packet sent to 10.153.50.10:2427--->

200 16262 OK

<---

*Nov  8 18:41:58.074: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16263 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a632000000F5

I: 60B

X: 0

<---

*Nov  8 18:41:58.078: htsp_timer_stop3

*Nov  8 18:41:58.094: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:41:58.094: htsp_timer_stop

*Nov  8 18:41:58.094: htsp_timer_stop2

*Nov  8 18:41:58.094: htsp_timer_stop3

*Nov  8 18:41:58.094: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:41:58.094: htsp_timer - 2000 msec

*Nov  8 18:41:58.094: MGCP Packet sent to 10.153.50.10:2427--->

250 16263 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:42:00.094: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:42:00.098: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:42:01.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:42:01.114: htsp_timer - 125 msec

*Nov  8 18:42:01.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:42:01.242: htsp_timer - 10000 msec

*Nov  8 18:42:01.242: htsp_timer3 - 5600 msec

*Nov  8 18:42:01.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:42:01.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:42:01.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:42:02.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:02.446: fxols_ringing_not

*Nov  8 18:42:02.446: htsp_timer_stop

*Nov  8 18:42:02.446: htsp_timer - 10000 msec

*Nov  8 18:42:06.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:42:06.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:42:06.842: htsp_timer_stop3

*Nov  8 18:42:07.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:07.446: fxols_ringing_not

*Nov  8 18:42:07.446: htsp_timer_stop

*Nov  8 18:42:07.446: htsp_timer_stop3

*Nov  8 18:42:07.446: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:42:07.446: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:42:07.446: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:43  orig called=

*Nov  8 18:42:07.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:42:07.446: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188547 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:42:07.446: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:42:07.446: fxols_wait_setup_ack:

*Nov  8 18:42:07.446: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:42:07.446: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:42:07.446: htsp_timer_stop

*Nov  8 18:42:07.458: MGCP Packet received from 10.153.50.10:2427--->

200 73188547

<---

*Nov  8 18:42:07.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16264 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a634000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:42:07.462: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:07.462: htsp_call_bridged invoked

*Nov  8 18:42:07.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:07.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16264 OK

I: 60C

v=0

o=- 1548 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 31592 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:42:07.478: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16265 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:42:07.482: MGCP Packet sent to 10.153.50.10:2427--->

200 16265 OK

<---

*Nov  8 18:42:07.702: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:42:07.702: htsp_timer2 - 350 msec

*Nov  8 18:42:08.054: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:42:08.054: htsp_timer_stop

*Nov  8 18:42:08.054: htsp_timer_stop2

*Nov  8 18:42:08.054: htsp_timer_stop3

*Nov  8 18:42:08.054: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188548 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:42:08.066: MGCP Packet received from 10.153.50.10:2427--->

200 73188548

<---

*Nov  8 18:42:08.066: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16266 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:42:08.066: MGCP Packet sent to 10.153.50.10:2427--->

200 16266 OK

<---

*Nov  8 18:42:08.078: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16267 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a634000000F5

I: 60C

X: 0

<---

*Nov  8 18:42:08.082: htsp_timer_stop3

*Nov  8 18:42:08.094: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:42:08.094: htsp_timer_stop

*Nov  8 18:42:08.094: htsp_timer_stop2

*Nov  8 18:42:08.094: htsp_timer_stop3

*Nov  8 18:42:08.094: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:42:08.094: htsp_timer - 2000 msec

*Nov  8 18:42:08.094: MGCP Packet sent to 10.153.50.10:2427--->

250 16267 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:42:10.094: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:42:10.094: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:42:11.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:42:11.114: htsp_timer - 125 msec

*Nov  8 18:42:11.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:42:11.242: htsp_timer - 10000 msec

*Nov  8 18:42:11.242: htsp_timer3 - 5600 msec

*Nov  8 18:42:11.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:42:11.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:42:11.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:42:12.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:12.446: fxols_ringing_not

*Nov  8 18:42:12.446: htsp_timer_stop

*Nov  8 18:42:12.446: htsp_timer - 10000 msec

*Nov  8 18:42:16.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:42:16.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188549 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:42:16.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188549

<---

*Nov  8 18:42:16.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:42:16.842: htsp_timer_stop3

*Nov  8 18:42:17.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:17.446: fxols_ringing_not

*Nov  8 18:42:17.446: htsp_timer_stop

*Nov  8 18:42:17.446: htsp_timer_stop3

*Nov  8 18:42:17.446: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:42:17.446: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:42:17.446: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:43  orig called=

*Nov  8 18:42:17.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:42:17.446: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188550 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:42:17.450: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:42:17.450: fxols_wait_setup_ack:

*Nov  8 18:42:17.450: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:42:17.450: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:42:17.450: htsp_timer_stop

*Nov  8 18:42:17.462: MGCP Packet received from 10.153.50.10:2427--->

200 73188550

<---

*Nov  8 18:42:17.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16268 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a636000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:42:17.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:17.466: htsp_call_bridged invoked

*Nov  8 18:42:17.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:17.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16268 OK

I: 60D

v=0

o=- 1549 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 17808 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:42:17.478: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16269 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:42:17.482: MGCP Packet sent to 10.153.50.10:2427--->

200 16269 OK

<---

*Nov  8 18:42:17.706: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:42:17.706: htsp_timer2 - 350 msec

*Nov  8 18:42:18.058: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:42:18.058: htsp_timer_stop

*Nov  8 18:42:18.058: htsp_timer_stop2

*Nov  8 18:42:18.058: htsp_timer_stop3

*Nov  8 18:42:18.058: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188551 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:42:18.070: MGCP Packet received from 10.153.50.10:2427--->

200 73188551

<---

*Nov  8 18:42:18.070: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16270 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:42:18.070: MGCP Packet sent to 10.153.50.10:2427--->

200 16270 OK

<---

*Nov  8 18:42:18.082: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16271 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a636000000F5

I: 60D

X: 0

<---

*Nov  8 18:42:18.086: htsp_timer_stop3

*Nov  8 18:42:18.106: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:42:18.106: htsp_timer_stop

*Nov  8 18:42:18.106: htsp_timer_stop2

*Nov  8 18:42:18.106: htsp_timer_stop3

*Nov  8 18:42:18.106: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:42:18.106: htsp_timer - 2000 msec

*Nov  8 18:42:18.106: MGCP Packet sent to 10.153.50.10:2427--->

250 16271 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:42:20.106: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:42:20.106: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:42:21.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:42:21.114: htsp_timer - 125 msec

*Nov  8 18:42:21.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:42:21.242: htsp_timer - 10000 msec

*Nov  8 18:42:21.242: htsp_timer3 - 5600 msec

*Nov  8 18:42:21.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:42:21.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:42:21.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:42:22.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:22.446: fxols_ringing_not

*Nov  8 18:42:22.446: htsp_timer_stop

*Nov  8 18:42:22.446: htsp_timer - 10000 msec

*Nov  8 18:42:26.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:42:26.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:42:26.842: htsp_timer_stop3

*Nov  8 18:42:27.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:27.446: fxols_ringing_not

*Nov  8 18:42:27.446: htsp_timer_stop

*Nov  8 18:42:27.446: htsp_timer_stop3

*Nov  8 18:42:27.446: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:42:27.446: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:42:27.446: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:43  orig called=

*Nov  8 18:42:27.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:42:27.450: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188552 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:42:27.450: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:42:27.450: fxols_wait_setup_ack:

*Nov  8 18:42:27.450: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:42:27.450: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:42:27.450: htsp_timer_stop

*Nov  8 18:42:27.462: MGCP Packet received from 10.153.50.10:2427--->

200 73188552

<---

*Nov  8 18:42:27.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16272 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a638000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:42:27.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:27.466: htsp_call_bridged invoked

*Nov  8 18:42:27.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:27.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16272 OK

I: 60E

v=0

o=- 1550 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 24260 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:42:27.482: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16273 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:42:27.482: MGCP Packet sent to 10.153.50.10:2427--->

200 16273 OK

<---

*Nov  8 18:42:27.706: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:42:27.706: htsp_timer2 - 350 msec

*Nov  8 18:42:28.058: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:42:28.058: htsp_timer_stop

*Nov  8 18:42:28.058: htsp_timer_stop2

*Nov  8 18:42:28.058: htsp_timer_stop3

*Nov  8 18:42:28.058: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188553 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:42:28.070: MGCP Packet received from 10.153.50.10:2427--->

200 73188553

<---

*Nov  8 18:42:28.070: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16274 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:42:28.070: MGCP Packet sent to 10.153.50.10:2427--->

200 16274 OK

<---

*Nov  8 18:42:28.082: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16275 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a638000000F5

I: 60E

X: 0

<---

*Nov  8 18:42:28.086: htsp_timer_stop3

*Nov  8 18:42:28.102: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:42:28.102: htsp_timer_stop

*Nov  8 18:42:28.102: htsp_timer_stop2

*Nov  8 18:42:28.102: htsp_timer_stop3

*Nov  8 18:42:28.102: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:42:28.102: htsp_timer - 2000 msec

*Nov  8 18:42:28.102: MGCP Packet sent to 10.153.50.10:2427--->

250 16275 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:42:30.102: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:42:30.102: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:42:31.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:42:31.114: htsp_timer - 125 msec

*Nov  8 18:42:31.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:42:31.242: htsp_timer - 10000 msec

*Nov  8 18:42:31.242: htsp_timer3 - 5600 msec

*Nov  8 18:42:31.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:42:31.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:42:31.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:42:32.442: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:32.442: fxols_ringing_not

*Nov  8 18:42:32.442: htsp_timer_stop

*Nov  8 18:42:32.442: htsp_timer - 10000 msec

*Nov  8 18:42:36.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:42:36.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:42:36.842: htsp_timer_stop3

*Nov  8 18:42:37.442: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:37.442: fxols_ringing_not

*Nov  8 18:42:37.442: htsp_timer_stop

*Nov  8 18:42:37.442: htsp_timer_stop3

*Nov  8 18:42:37.442: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:42:37.442: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:42:37.442: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:43  orig called=

*Nov  8 18:42:37.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:42:37.446: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188554 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:42:37.446: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:42:37.446: fxols_wait_setup_ack:

*Nov  8 18:42:37.446: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:42:37.446: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:42:37.446: htsp_timer_stop

*Nov  8 18:42:37.458: MGCP Packet received from 10.153.50.10:2427--->

200 73188554

<---

*Nov  8 18:42:37.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16276 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a63a000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:42:37.462: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:37.462: htsp_call_bridged invoked

*Nov  8 18:42:37.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:37.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16276 OK

I: 60F

v=0

o=- 1551 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 21846 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:42:37.478: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16277 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:42:37.478: MGCP Packet sent to 10.153.50.10:2427--->

200 16277 OK

<---

*Nov  8 18:42:37.698: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:42:37.698: htsp_timer2 - 350 msec

*Nov  8 18:42:38.050: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:42:38.050: htsp_timer_stop

*Nov  8 18:42:38.050: htsp_timer_stop2

*Nov  8 18:42:38.050: htsp_timer_stop3

*Nov  8 18:42:38.050: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188555 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:42:38.062: MGCP Packet received from 10.153.50.10:2427--->

200 73188555

<---

*Nov  8 18:42:38.062: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16278 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:42:38.062: MGCP Packet sent to 10.153.50.10:2427--->

200 16278 OK

<---

*Nov  8 18:42:38.074: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16279 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a63a000000F5

I: 60F

X: 0

<---

*Nov  8 18:42:38.074: htsp_timer_stop3

*Nov  8 18:42:38.094: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:42:38.094: htsp_timer_stop

*Nov  8 18:42:38.094: htsp_timer_stop2

*Nov  8 18:42:38.094: htsp_timer_stop3

*Nov  8 18:42:38.094: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:42:38.094: htsp_timer - 2000 msec

*Nov  8 18:42:38.094: MGCP Packet sent to 10.153.50.10:2427--->

250 16279 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:42:40.094: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:42:40.098: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:42:41.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:42:41.114: htsp_timer - 125 msec

*Nov  8 18:42:41.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:42:41.242: htsp_timer - 10000 msec

*Nov  8 18:42:41.242: htsp_timer3 - 5600 msec

*Nov  8 18:42:41.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:42:41.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:42:41.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:42:42.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:42.446: fxols_ringing_not

*Nov  8 18:42:42.446: htsp_timer_stop

*Nov  8 18:42:42.446: htsp_timer - 10000 msec

*Nov  8 18:42:46.114: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0000]

*Nov  8 18:42:46.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188556 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:42:46.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188556

<---

*Nov  8 18:42:46.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:42:46.842: htsp_timer_stop3

*Nov  8 18:42:47.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:47.446: fxols_ringing_not

*Nov  8 18:42:47.446: htsp_timer_stop

*Nov  8 18:42:47.446: htsp_timer_stop3

*Nov  8 18:42:47.446: [0/0/1] htsp_stop_caller_id_rx. message length 0htsp_setup_ind

*Nov  8 18:42:47.446: [0/0/1] get_fxo_caller_id:Caller ID receive failed.  parseCallerIDString:no da

ta.

*Nov  8 18:42:47.446: [0/0/1] get_local_station_id calling num= calling name=Troncal Publica calling

time=11/08 14:43  orig called=

*Nov  8 18:42:47.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:42:47.446: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188557 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hd

<---

*Nov  8 18:42:47.446: htsp_process_event: [0/0/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]

*Nov  8 18:42:47.446: fxols_wait_setup_ack:

*Nov  8 18:42:47.446: [0/0/1] set signal state = 0xC timestamp = 0fxols_check_auto_call

*Nov  8 18:42:47.446: htsp_process_event: [0/0/1, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_con

nect

*Nov  8 18:42:47.446: htsp_timer_stop

*Nov  8 18:42:47.458: MGCP Packet received from 10.153.50.10:2427--->

200 73188557

<---

*Nov  8 18:42:47.462: MGCP Packet received from 10.153.50.10:2427--->

CRCX 16280 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a63c000000F5

X: 0

L: p:20, a:PCMU, s:off, t:00

M: recvonly

R: L/hu

Q: process,loop

<---

*Nov  8 18:42:47.462: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:47.462: htsp_call_bridged invoked

*Nov  8 18:42:47.466: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_conn

ect_proc_voice

*Nov  8 18:42:47.466: MGCP Packet sent to 10.153.50.10:2427--->

200 16280 OK

I: 610

v=0

o=- 1552 0 IN IP4 10.151.73.26

s=Cisco SDP 0

c=IN IP4 10.151.73.26

t=0 0

m=audio 27758 RTP/AVP 0 100

a=rtpmap:100 X-NSE/8000

a=fmtp:100 200-202

a=X-sqn:0

a=X-cap: 1 audio RTP/AVP 100

a=X-cpar: a=rtpmap:100 X-NSE/8000

a=X-cpar: a=fmtp:100 200-202

a=X-cap: 2 image udptl t38

<---

*Nov  8 18:42:47.478: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16281 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hu, D/[0-9ABCD*#]

S: G/rt

Q: process,loop

<---

*Nov  8 18:42:47.482: MGCP Packet sent to 10.153.50.10:2427--->

200 16281 OK

<---

*Nov  8 18:42:47.702: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc

*Nov  8 18:42:47.702: htsp_timer2 - 350 msec

*Nov  8 18:42:48.054: htsp_process_event: [0/0/1, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_conf

irm

*Nov  8 18:42:48.054: htsp_timer_stop

*Nov  8 18:42:48.054: htsp_timer_stop2

*Nov  8 18:42:48.054: htsp_timer_stop3

*Nov  8 18:42:48.054: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188558 aaln/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

N: ca@10.153.50.10:2427

X: 0

O: L/hu

<---

*Nov  8 18:42:48.066: MGCP Packet received from 10.153.50.10:2427--->

200 73188558

<---

*Nov  8 18:42:48.066: MGCP Packet received from 10.153.50.10:2427--->

RQNT 16282 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

X: 0

R: L/hd

Q: process,loop

<---

*Nov  8 18:42:48.066: MGCP Packet sent to 10.153.50.10:2427--->

200 16282 OK

<---

*Nov  8 18:42:48.078: MGCP Packet received from 10.153.50.10:2427--->

DLCX 16283 AALN/S0/SU0/1@CS120464_AFPM_TEMU MGCP 0.1

C: A000000001e5a63c000000F5

I: 610

X: 0

<---

*Nov  8 18:42:48.078: htsp_timer_stop3

*Nov  8 18:42:48.094: htsp_process_event: [0/0/1, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_off

hook_release

*Nov  8 18:42:48.094: htsp_timer_stop

*Nov  8 18:42:48.094: htsp_timer_stop2

*Nov  8 18:42:48.094: htsp_timer_stop3

*Nov  8 18:42:48.094: [0/0/1] set signal state = 0x4 timestamp = 0

*Nov  8 18:42:48.094: htsp_timer - 2000 msec

*Nov  8 18:42:48.094: MGCP Packet sent to 10.153.50.10:2427--->

250 16283 OK

P: PS=0, OS=0, PR=0, OR=0, PL=0, JI=0, LA=0

<---

*Nov  8 18:42:50.094: htsp_process_event: [0/0/1, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_ou

t_timeout

*Nov  8 18:42:50.094: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0100]

*Nov  8 18:42:51.114: htsp_process_event: [0/0/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing

*Nov  8 18:42:51.114: htsp_timer - 125 msec

*Nov  8 18:42:51.242: htsp_process_event: [0/0/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait

_ring_min_timer

*Nov  8 18:42:51.242: htsp_timer - 10000 msec

*Nov  8 18:42:51.242: htsp_timer3 - 5600 msec

*Nov  8 18:42:51.242: [0/0/1] htsp_start_caller_id_rx:BELLCORE

*Nov  8 18:42:51.242: htsp_start_caller_id_rx create dsp_stream_manager

*Nov  8 18:42:51.242: [0/0/1] htsp_dsm_create_success  returns 1

*Nov  8 18:42:52.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_DSP_SIG_0100]

*Nov  8 18:42:52.446: fxols_ringing_not

*Nov  8 18:42:52.446: htsp_timer_stop

*Nov  8 18:42:52.446: htsp_timer - 10000 msec

*Nov  8 18:42:56.842: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_cli

d_stop

*Nov  8 18:42:56.842: htsp_timer_stop3

*Nov  8 18:43:01.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188559 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:43:01.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188559

<---

*Nov  8 18:43:02.446: htsp_process_event: [0/0/1, FXOLS_RINGING, E_HTSP_EVENT_TIMER]fxols_ringing_di

sc

*Nov  8 18:43:02.446: htsp_timer_stop3

*Nov  8 18:43:02.446: htsp_timer_stop

*Nov  8 18:43:02.446: [0/0/1] htsp_stop_caller_id_rx. message length 0

*Nov  8 18:43:02.446: [0/0/1] htsp_dsm_close_done

*Nov  8 18:43:16.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188560 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:43:16.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188560

<---

*Nov  8 18:43:31.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188561 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:43:31.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188561

<---

*Nov  8 18:43:46.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188562 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:43:46.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188562

<---

*Nov  8 18:44:01.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188563 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:44:01.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188563

<---

*Nov  8 18:44:16.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188564 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:44:16.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188564

<---

*Nov  8 18:44:31.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188565 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:44:31.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188565

<---

*Nov  8 18:44:46.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188566 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:44:46.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188566

<---

*Nov  8 18:45:01.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188567 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:45:01.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188567

<---

*Nov  8 18:45:16.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188568 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:45:16.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188568

<---

*Nov  8 18:45:31.738: MGCP Packet sent to 10.153.50.10:2427--->

NTFY 73188569 *@CS120464_AFPM_TEMU MGCP 0.1

X: 0

O:

<---

*Nov  8 18:45:31.750: MGCP Packet received from 10.153.50.10:2427--->

200 73188569

<---


VIP Super Bronze

2901 Gateway Calls don´t enter

Claudio,

I cant make any sense of the traces. I dont see anything useful in them. Can you collect CUCM traces using RTMT and send them over.

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts "The essence of christianity is not the enthronement but the obliteration of self --William Barclay"
239
Views
0
Helpful
5
Replies