Voice Port Module signaling debugging is enabled
Office-IP-PBX#
*Sep 19 10:21:29.654: htsp_process_event: [0/1/3, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing
*Sep 19 10:21:29.654: htsp_timer - 125 msec
*Sep 19 10:21:29.782: htsp_process_event: [0/1/3, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait_ring_min_timer
*Sep 19 10:21:29.782: htsp_timer - 10000 msec
*Sep 19 10:21:29.782: htsp_timer3 - 5600 msec
*Sep 19 10:21:29.782: [0/1/3] htsp_start_caller_id_rx:BELLCORE
*Sep 19 10:21:29.782: htsp_start_caller_id_rx create dsp_stream_manager
*Sep 19 10:21:29.782: [0/1/3] htsp_dsm_create_success returns 1
*Sep 19 10:21:30.730: htsp_process_event: [0/1/3, FXOLS_RINGING, E_DSP_SIG_0100]
*Sep 19 10:21:30.730: fxols_ringing_not
*Sep 19 10:21:30.730: htsp_timer_stop
*Sep 19 10:21:30.730: htsp_timer - 10000 msec
*Sep 19 10:21:34.634: htsp_process_event: [0/1/3, FXOLS_RINGING, E_DSP_SIG_0000]
*Sep 19 10:21:35.382: htsp_process_event: [0/1/3, FXOLS_RINGING, E_HTSP_EVENT_TIMER3]fxols_snoop_clid_stop
*Sep 19 10:21:35.382: htsp_timer_stop3
*Sep 19 10:21:35.710: htsp_process_event: [0/1/3, FXOLS_RINGING, E_DSP_SIG_0100]
*Sep 19 10:21:35.710: fxols_ringing_not
*Sep 19 10:21:35.710: htsp_timer_stop
*Sep 19 10:21:35.710: htsp_timer_stop3
*Sep 19 10:21:35.710: [0/1/3] htsp_stop_caller_id_rx. message length 0htsp_setup_ind
*Sep 19 10:21:35.710: [0/1/3] get_fxo_caller_id:Caller ID receive failed. parseCallerIDString:no data.
*Sep 19 10:21:35.710: [0/1/3] get_local_station_id calling num= calling name= calling time=09/19 10:21 orig called=
*Sep 19 10:21:35.714: [0/1/3] htsp_dsm_close_done
*Sep 19 10:21:35.714: htsp_process_event: [0/1/3, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]
*Sep 19 10:21:35.714: fxols_wait_setup_ack:
*Sep 19 10:21:35.714: htsp_timer - 6000 msec
*Sep 19 10:21:35.722: htsp_timer_stop3
*Sep 19 10:21:35.722: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_HTSP_PROCEEDING]fxols_offhook_prochtsp_setup_req
*Sep 19 10:21:35.722: htsp_process_event: [50/0/1.1, EFXS_ONHOOK, E_HTSP_SETUP_REQ]efxs_onhook_setup
*Sep 19 10:21:35.722: htsp_ephone_start_caller_id_tx calling num= calling name = called num=4001 orig called num=
*Sep 19 10:21:35.726: [50/0/1.1] set signal state = 0x0 timestamp = 0
*Sep 19 10:21:35.726: efxs_onhook_setup: local target is available
htsp_alerthtsp_alert_notify
*Sep 19 10:21:35.730: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_HTSP_ALERT]fxols_offhook_alert
*Sep 19 10:21:39.634: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_DSP_SIG_0000]fxols_proceed_ring
*Sep 19 10:21:39.634: htsp_timer_stop
*Sep 19 10:21:39.634: htsp_timer_stop2
*Sep 19 10:21:40.710: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_DSP_SIG_0100]fxols_proceed_clear
*Sep 19 10:21:40.710: htsp_timer_stop2
*Sep 19 10:21:40.710: htsp_timer - 6000 msec
*Sep 19 10:21:44.634: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_DSP_SIG_0000]fxols_proceed_ring
*Sep 19 10:21:44.634: htsp_timer_stop
*Sep 19 10:21:44.634: htsp_timer_stop2
*Sep 19 10:21:45.710: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_DSP_SIG_0100]fxols_proceed_clear
*Sep 19 10:21:45.710: htsp_timer_stop2
*Sep 19 10:21:45.710: htsp_timer - 6000 msec
*Sep 19 10:21:49.634: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_DSP_SIG_0000]fxols_proceed_ring
*Sep 19 10:21:49.634: htsp_timer_stop
*Sep 19 10:21:49.634: htsp_timer_stop2
*Sep 19 10:21:50.710: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_DSP_SIG_0100]fxols_proceed_clear
*Sep 19 10:21:50.710: htsp_timer_stop2
*Sep 19 10:21:50.710: htsp_timer - 6000 msec
Office-IP-PBX#
Office-IP-PBX#u all
All possible debugging has been turned off
Office-IP-PBX#
*Sep 19 10:21:54.350: htsp_process_event: [50/0/1.1, EFXS_WAIT_OFFHOOK, E_DSP_SIG_1100]efxs_waitoff_offhook
*Sep 19 10:21:54.354: [50/0/1.1] set signal state = 0x4 timestamp = 0 htsp_dial
*Sep 19 10:21:54.354: htsp_process_event: [50/0/1.1, EFXS_CONNECT, E_DSP_DIALING_DONE]
*Sep 19 10:21:54.354: htsp_call_bridged invoked
*Sep 19 10:21:54.358: htsp_call_bridged invoked
*Sep 19 10:21:54.358: htsp_process_event: [0/1/3, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_connect
*Sep 19 10:21:54.358: [0/1/3] set signal state = 0xC timestamp = 0
*Sep 19 10:21:54.358: htsp_timer_stop
*Sep 19 10:21:54.362: htsp_process_event: [50/0/1.1, EFXS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]efxs_connect_cutthru
*Sep 19 10:21:54.362: [50/0/1.1] set signal state = 0x7 timestamp = 0
*Sep 19 10:21:54.370: htsp_process_event: [0/1/3, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_connect_proc_voice