we have 2801 router that connected with 2 anloga lines (FXO Card), but now we have a problem with disconnect problem, the phone still connected after the PSTN Caller Disconnect, and our policy tell that the agents shouldn't end the call, so we want when the PSTN caller end the call we need the phone to return to idle state.
and according for the below link, i configure the custom disconnect tone, and in the attachment you can find tow disconnect tones.
http://ciscoflair.blogspot.com/2009/05/cisco-fxo-disconnect-issue.html
the configuration of the custom disconnect tone
voice class dualtone-detect-params 1
cadence-variation 3
voice class custom-cptone Custom1
dualtone disconnect
frequency 420
cadence 245 255 245 255 245 255
and the below you can find the configuration of the voice port, and you can find the debug vpm port 0/3/0, debug vpm signal, for a call that disconnected immediately, and for a call the take long time to disconnected.
this is the configuration of the voice port:
voice-port 0/3/0
supervisory disconnect dualtone mid-call
supervisory custom-cptone Custom1
supervisory dualtone-detect-params 1
no battery-reversal
cptone NL
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 50
timing guard-out 300
caller-id enable
caller-id alerting line-reversal
caller-id alerting dsp-pre-allocate
this is the debug of a call that is disconnected immediately:
Jan 25 11:48:32.262: [0/3/0] htsp_dsm_feature_notify_cb returns 2 id=DSM_FEATURE_SM_CALLERID_RX
Jan 25 11:48:32.262: htsp_process_event: [0/3/0, FXOLS_ONHOOK, E_HTSP_CALLERID_RX_DONE]
Jan 25 11:48:32.262: [0/3/0] htsp_stop_caller_id_rx. message length 11
Jan 25 11:48:32.262: [0/3/0] htsp_dsm_close_done
Jan 25 11:48:34.026: htsp_process_event: [0/3/0, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing
Jan 25 11:48:34.026: htsp_timer - 125 msec
Jan 25 11:48:34.154: htsp_process_event: [0/3/0, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait_ring_min_timer
Jan 25 11:48:34.154: htsp_timer - 10000 msec
Jan 25 11:48:35.305: htsp_process_event: [0/3/0, FXOLS_RINGING, E_DSP_SIG_0100]
Jan 25 11:48:35.305: fxols_ringing_not
Jan 25 11:48:35.305: htsp_timer_stop
Jan 25 11:48:35.305: htsp_timer_stop3 htsp_setup_ind
Jan 25 11:48:35.305: [0/3/0] get_fxo_caller_id:Caller ID received. Message type=129 length=11 checksum=00
Jan 25 11:48:35.309: [0/3/0] Caller ID String 44 30 36 35 36 37 39 31 34 31
Jan 25 11:48:35.309: [0/3/0] get_fxo_caller_id calling num=065679141 calling name= calling time=01/25 13:48
Jan 25 11:48:35.313: htsp_process_event: [0/3/0, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]
Jan 25 11:48:35.313: fxols_wait_setup_ack:
Jan 25 11:48:35.313: [0/3/0] set signal state = 0xC timestamp = 0fxols_check_auto_call
Jan 25 11:48:35.321: htsp_process_event: [0/3/0, FXOLS_PROCEEDING, E_HTSP_PROCEEDING]fxols_offhook_proc
Jan 25 11:48:35.321: htsp_timer - 120000 msechtsp_alert_notify
Jan 25 11:48:35.389: htsp_process_event: [0/3/0, FXOLS_PROCEEDING, E_HTSP_ALERT]fxols_offhook_alerthtsp_call_service_msghtsp_call_service_msg not EFXS (2)
Jan 25 11:48:35.509: htsp_call_bridged invokedhtsp_call_service_msghtsp_call_service_msg not EFXS (2)
Jan 25 11:48:35.513: htsp_process_event: [0/3/0, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_connect
Jan 25 11:48:35.513: htsp_timer_stop
Jan 25 11:48:35.521: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_connect_proc_voice
Jan 25 11:48:35.585: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_DSP_SIG_0110]fxols_rvs_battery
Jan 25 11:48:35.585: htsp_timer_stop2
sh voice po su
IN OUT
PORT CH SIG-TYPE ADMIN OPER STATUS STATUS EC
=============== == ============ ===== ==== ======== ======== ==
0/3/0 -- fxo-ls up up idle off-hook y
0/3/1 -- fxo-ls up dorm idle on-hook y
50/0/1 1 efxs up up on-hook idle y
50/0/1 2 efxs up up on-hook idle y
PWR FAILOVER PORT PSTN FAILOVER PORT
================= ==================
Jan 25 11:48:43.857: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_DSP_SUP_DISCONNECT]fxols_conn_sup_disc
Jan 25 11:48:43.857: htsp_timer2 - 5000 msec
Madaba_Maint#
Jan 25 11:48:48.856: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_confirm
Jan 25 11:48:48.856: htsp_timer_stop
Jan 25 11:48:48.856: htsp_timer_stop2
Jan 25 11:48:48.856: htsp_timer_stop3
Jan 25 11:48:48.860: htsp_timer_stop3
Jan 25 11:48:48.876: htsp_process_event: [0/3/0, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_offhook_release
Jan 25 11:48:48.876: htsp_timer_stop
Jan 25 11:48:48.876: htsp_timer_stop2
Jan 25 11:48:48.876: htsp_timer_stop3
Jan 25 11:48:48.876: [0/3/0] set signal state = 0x4 timestamp = 0
Jan 25 11:48:48.876: htsp_timer - 300 msec
Jan 25 11:48:49.148: htsp_process_event: [0/3/0, FXOLS_GUARD_OUT, E_DSP_SIG_0110]
Jan 25 11:48:49.176: htsp_process_event: [0/3/0, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_out_timeout
Jan 25 11:48:49.176: fxols_dsp_prealloc_clid_wait. Line reversal alerting DSP preallocation done
Jan 25 11:48:49.176: [0/3/0] htsp_start_caller_id_rx:ETSI_DTMF
Jan 25 11:48:49.176: htsp_start_caller_id_rx create dsp_stream_manager
Jan 25 11:48:49.176: htsp_process_event: [0/3/0, FXOLS_ONHOOK, E_DSP_SIG_0100]
Jan 25 11:48:49.176: [0/3/0] htsp_dsm_create_success returns 1
Madaba_Maint#sh voice po su
IN OUT
PORT CH SIG-TYPE ADMIN OPER STATUS STATUS EC
=============== == ============ ===== ==== ======== ======== ==
0/3/0 -- fxo-ls up dorm idle on-hook y
0/3/1 -- fxo-ls up dorm idle on-hook y
50/0/1 1 efxs up up on-hook idle y
50/0/1 2 efxs up up on-hook idle y
this is a debug for a call that is take a long time to disconnected:
Jan 25 11:49:42.267: [0/3/0] htsp_dsm_feature_notify_cb returns 2 id=DSM_FEATURE_SM_CALLERID_RX
Jan 25 11:49:42.267: htsp_process_event: [0/3/0, FXOLS_ONHOOK, E_HTSP_CALLERID_RX_DONE]
Jan 25 11:49:42.267: [0/3/0] htsp_stop_caller_id_rx. message length 11
Jan 25 11:49:42.271: [0/3/0] htsp_dsm_close_done
Jan 25 11:49:43.999: htsp_process_event: [0/3/0, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing
Jan 25 11:49:43.999: htsp_timer - 125 msec
Jan 25 11:49:44.127: htsp_process_event: [0/3/0, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait_ring_min_timer
Jan 25 11:49:44.127: htsp_timer - 10000 msec
Jan 25 11:49:45.279: htsp_process_event: [0/3/0, FXOLS_RINGING, E_DSP_SIG_0100]
Jan 25 11:49:45.279: fxols_ringing_not
Jan 25 11:49:45.279: htsp_timer_stop
Jan 25 11:49:45.279: htsp_timer_stop3 htsp_setup_ind
Jan 25 11:49:45.279: [0/3/0] get_fxo_caller_id:Caller ID received. Message type=129 length=11 checksum=00
Jan 25 11:49:45.279: [0/3/0] Caller ID String 44 30 36 35 36 37 39 31 34 31
Jan 25 11:49:45.279: [0/3/0] get_fxo_caller_id calling num=065679141 calling name= calling time=01/25 13:49
Jan 25 11:49:45.283: htsp_process_event: [0/3/0, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]
Jan 25 11:49:45.283: fxols_wait_setup_ack:
Jan 25 11:49:45.287: [0/3/0] set signal state = 0xC timestamp = 0fxols_check_auto_call
Jan 25 11:49:45.291: htsp_process_event: [0/3/0, FXOLS_PROCEEDING, E_HTSP_PROCEEDING]fxols_offhook_proc
Jan 25 11:49:45.291: htsp_timer - 120000 msechtsp_alert_notify
Jan 25 11:49:45.379: htsp_process_event: [0/3/0, FXOLS_PROCEEDING, E_HTSP_ALERT]fxols_offhook_alerthtsp_call_service_msghtsp_call_service_msg not EFXS (2)
Jan 25 11:49:45.495: htsp_call_bridged invokedhtsp_call_service_msghtsp_call_service_msg not EFXS (2)
Jan 25 11:49:45.503: htsp_process_event: [0/3/0, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_connect
Jan 25 11:49:45.503: htsp_timer_stop
Jan 25 11:49:45.507: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_connect_proc_voice
Jan 25 11:49:45.559: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_DSP_SIG_0110]fxols_rvs_battery
Jan 25 11:49:45.559: htsp_timer_stop2
sh voice po su
IN OUT
PORT CH SIG-TYPE ADMIN OPER STATUS STATUS EC
=============== == ============ ===== ==== ======== ======== ==
0/3/0 -- fxo-ls up up idle off-hook y
0/3/1 -- fxo-ls up dorm idle on-hook y
50/0/1 1 efxs up up on-hook idle y
50/0/1 2 efxs up up on-hook idle y
Jan 25 11:50:30.387: htsp_timer_stop3
Jan 25 11:50:30.399: htsp_process_event: [0/3/0, FXOLS_CONNECT, E_HTSP_RELEASE_REQ]fxols_offhook_release
Jan 25 11:50:30.399: htsp_timer_stop
Jan 25 11:50:30.399: htsp_timer_stop2
Jan 25 11:50:30.399: htsp_timer_stop3
Jan 25 11:50:30.399: [0/3/0] set signal state = 0x4 timestamp = 0
Jan 25 11:50:30.399: htsp_timer - 300 msec
Jan 25 11:50:30.671: htsp_process_event: [0/3/0, FXOLS_GUARD_OUT, E_DSP_SIG_0110]
Jan 25 11:50:30.699: htsp_process_event: [0/3/0, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_out_timeout
Jan 25 11:50:30.699: fxols_dsp_prealloc_clid_wait. Line reversal alerting DSP preallocation done
Jan 25 11:50:30.699: [0/3/0] htsp_start_caller_id_rx:ETSI_DTMF
Jan 25 11:50:30.699: htsp_start_caller_id_rx create dsp_stream_manager
Jan 25 11:50:30.699: htsp_process_event: [0/3/0, FXOLS_ONHOOK, E_DSP_SIG_0100]
Jan 25 11:50:30.699: [0/3/0] htsp_dsm_create_success returns 1
So what can we do? what is the wronge of my configuration?
