04-27-2013 05:09 AM - edited 03-16-2019 05:02 PM
Dear,
In Oman, am using 2901 router with 25 ip phones. My problem is , am not able receive caller id and i have checked with my service provider & they had enabled caller id feature on their side. Kindly help me on this
04-27-2013 05:15 AM
Is this a CCME setup? What type of integration do oyu have to your service provider? Is it a SIP trunk or ISDN PRI, BRI of just FXO ports?
Please rate all useful posts
"opportunity is a haughty goddess who waste no time with those who are unprepared"
04-27-2013 05:15 AM
Hi Britto,
Are u using CME ?
Can u post the config of router with show version? What type of card is there on router?
regds,
aman
04-27-2013 05:55 AM
Dear,
Thank You.
Please find the require details below
----------------------------------------------------------------------------------------------------------------------------------------------
voice-port 0/1/0
supervisory disconnect anytone
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
!
voice-port 0/1/1
supervisory disconnect anytone
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/1/2
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
--More-- voice-port 0/1/3
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/2/0
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 101 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/2/1
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
--More-- !
voice-port 0/2/2
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/2/3
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
voice-port 0/1/0
supervisory disconnect anytone
--More-- timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
!
voice-port 0/1/1
supervisory disconnect anytone
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/1/2
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
--More-- voice-port 0/1/3
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/2/0
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 101 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/2/1
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
--More-- !
voice-port 0/2/2
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
!
voice-port 0/2/3
timeouts call-disconnect 5
timeouts wait-release 5
timing hookflash-out 500
connection plar opx immediate 100 cut-through-wait
caller-id enable
caller-id alerting dsp-pre-allocate
04-27-2013 06:06 AM
Please di a test call and send (let us know the calling and called number)
debug vpm signal
Can you also confirm if this is a CCME setup
Please rate all useful posts
"opportunity is a haughty goddess who waste no time with those who are unprepared"
04-27-2013 06:18 AM
Hello
Can you share the output of the below
•debug vpm signal
•debug vtsp dsp
•debug vtsp session
Please clarrify you use (CME or CUCM) , version and if you use protocol (H323 , MGCP).
Thank you
please rate if this will help
04-27-2013 06:24 AM
Dear,
Thanks a lot.
Its CME and using H323.
Please find the output of debug vpm signal below
VR#
Apr 27 13:22:27.966: htsp_process_event: [50/0/31.1, EFXS_ONHOOK, E_DSP_SIG_1100
]efxs_onhook_offhook htsp_setup_ind
Apr 27 13:22:27.966: [50/0/31.1] get_local_station_id calling num=123 calling na
me=Britto, Vimalraj calling time=04/27 13:22 orig called=
Apr 27 13:22:27.970: htsp_process_event: [50/0/31.1, EFXS_WAIT_SETUP_ACK, E_HTSP
_SETUP_ACK]efxs_check_auto_call
Apr 27 13:22:28.202: htsp_digit_ready(50/0/31.1): digit = 9
Apr 27 13:22:28.402: htsp_digit_ready(50/0/31.1): digit = 9
Apr 27 13:22:28.602: htsp_digit_ready(50/0/31.1): digit = 6
Apr 27 13:22:28.802: htsp_digit_ready(50/0/31.1): digit = 6
VR#
Apr 27 13:22:29.002: htsp_digit_ready(50/0/31.1): digit = 5
Apr 27 13:22:29.202: htsp_digit_ready(50/0/31.1): digit = 6
Apr 27 13:22:29.402: htsp_digit_ready(50/0/31.1): digit = 0
Apr 27 13:22:29.602: htsp_digit_ready(50/0/31.1): digit = 3
Apr 27 13:22:29.802: htsp_digit_ready(50/0/31.1): digit = 5
Apr 27 13:22:29.802: htsp_timer_stop3
Apr 27 13:22:29.802: [0/1/3] htsp_stop_caller_id_rx. message length 0
Apr 27 13:22:29.802: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_PROCEE
DING]efxs_offhook_proceeding
Apr 27 13:22:29.802: [50/0/31.1] set signal state = 0x8 timestamp = 0htsp_setup_
req
Apr 27 13:22:29.806: [0/1/3] htsp_dsm_close_done
VR#
Apr 27 13:22:29.806: htsp_process_event: [0/1/3, FXOLS_ONHOOK, E_HTSP_SETUP_REQ]
fxols_onhook_setup
Apr 27 13:22:29.806: [0/1/3] set signal state = 0xC timestamp = 0
Apr 27 13:22:29.806: htsp_timer - 1300 msec
Apr 27 13:22:30.102: htsp_process_event: [0/1/3, FXOLS_WAIT_DIAL_TONE, E_DSP_SIG
_0110]fxols_disc_clear
Apr 27 13:22:30.102: htsp_timer_stop2
Apr 27 13:22:30.102: htsp_timer - 1300 msec
VR#
Apr 27 13:22:31.402: htsp_process_event: [0/1/3, FXOLS_WAIT_DIAL_TONE, E_HTSP_EV
ENT_TIMER]fxols_wait_dial_timer htsp_dial
VR#
Apr 27 13:22:33.022: htsp_process_event: [0/1/3, FXOLS_WAIT_DIAL_DONE, E_DSP_DIA
LING_DONE]fxols_wait_dial_done htsp_progress
Apr 27 13:22:33.022: htsp_timer - 350 msec
Apr 27 13:22:33.026: htsp_call_bridged invoked
Apr 27 13:22:33.026: htsp_call_bridged invokedhtsp_progress_notifyhtsp_call_feat
ure:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 0
Apr 27 13:22:33.026: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_CALLER
ID_WAITING]
Apr 27 13:22:33.026: efxs_callerid_update
Apr 27 13:22:33.026: efxs_callerid_update process caller_id_string
Apr 27 13:22:33.026: efxs_callerid_update process caller_id_string OK
Apr 27 13:22:33.026: efxs_callerid_update number= [996656035] name= []
Apr 27 13:22:33.026: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_VOICE_
CUT_THROUGH]efxs_offhook_cutthru
Apr 27 13:22:33.026: [50/0/31.1] set signal state = 0x7 timestamp = 0
Apr 27 13:22:33.026: htsp_process_event: [0/1/3, FXOLS_WAIT_CUT_THRU, E_HTSP_VOI
CE_CUT_THROUGH]fxols_handle_cut_thru
Apr 27 13:22:33.026: htsp_timer_stop htsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 1
Apr 27 13:22:33.030: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_CONNEC
T]efxs_offhook_connect
Apr 27 13:22:33.030: [50/0/31.1] set signal state = 0x6 timestamp = 0
VR#
Apr 27 13:22:33.030: htsp_process_event: [50/0/31.1, EFXS_CONNECT, E_HTSP_CALLER
ID_WAITING]
Apr 27 13:22:33.030: efxs_callerid_update
Apr 27 13:22:33.030: efxs_callerid_update process caller_id_string
Apr 27 13:22:33.030: efxs_callerid_update process caller_id_string OK
Apr 27 13:22:33.030: efxs_callerid_update number= [996656035] name= []
VR#unde all
All possible debugging has been turned off
VR#
Apr 27 13:22:42.958: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 5
75CA3B9AE7411E28E3EEEA55F0A0083, SetupTime 13:22:27.968 UTC Sat Apr 27 2013, Pee
rAddress 123, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call
clearing (16), ConnectTime 13:22:33.028 UTC Sat Apr 27 2013, DisconnectTime 13:2
2:42.958 UTC Sat Apr 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, Transmit
Packets 490, TransmitBytes 78400, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:22:42.958: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:22:27.966,cgn:123,cdn:,frs:0,fid:1776,fcid:575CA3B9AE7411E28E3EEEA55F0A0083,
legID:559,bguid:575CA3B9AE7411E28E3EEEA55F0A0083
Apr 27 13:22:42.974: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 5
75CA3B9AE7411E28E3EEEA55F0A0083, SetupTime 13:22:29.804 UTC Sat Apr 27 2013, Pee
rAddress 996656035, PeerSubAddress , DisconnectCause 10 , DisconnectText normal
call clearing (16), ConnectTime 13:22:33.024 UTC Sat Apr 27 2013, DisconnectTim
e 13:22:42.974 UTC Sat Apr 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, Tr
ansmitPackets 496, TransmitBytes 79360, ReceivePackets 490, ReceiveBytes 82320
VR#
Apr 27 13:22:42.974: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:22:29.802,cgn:123,cdn:996656035,frs:0,fid:1777,fcid:575CA3B9AE7411E28E3EEEA5
5F0A0083,legID:55A,bguid:575CA3B9AE7411E28E3EEEA55F0A0083
VR#und all
All possible debugging has been turned off
VR#
VR#
Apr 27 13:22:27.966: htsp_process_event: [50/0/31.1, EFXS_ONHOOK, E_DSP_SIG_1100
]efxs_onhook_offhook htsp_setup_ind
Apr 27 13:22:27.966: [50/0/31.1] get_local_station_id calling num=123 calling na
me=Britto, Vimalraj calling time=04/27 13:22 orig called=
Apr 27 13:22:27.970: htsp_process_event: [50/0/31.1, EFXS_WAIT_SETUP_ACK, E_HTSP
_SETUP_ACK]efxs_check_auto_call
Apr 27 13:22:28.202: htsp_digit_ready(50/0/31.1): digit = 9
Apr 27 13:22:28.402: htsp_digit_ready(50/0/31.1): digit = 9
Apr 27 13:22:28.602: htsp_digit_ready(50/0/31.1): digit = 6
Apr 27 13:22:28.802: htsp_digit_ready(50/0/31.1): digit = 6
VR#
Apr 27 13:22:29.002: htsp_digit_ready(50/0/31.1): digit = 5
Apr 27 13:22:29.202: htsp_digit_ready(50/0/31.1): digit = 6
Apr 27 13:22:29.402: htsp_digit_ready(50/0/31.1): digit = 0
Apr 27 13:22:29.602: htsp_digit_ready(50/0/31.1): digit = 3
Apr 27 13:22:29.802: htsp_digit_ready(50/0/31.1): digit = 5
Apr 27 13:22:29.802: htsp_timer_stop3
Apr 27 13:22:29.802: [0/1/3] htsp_stop_caller_id_rx. message length 0
Apr 27 13:22:29.802: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_PROCEE
DING]efxs_offhook_proceeding
Apr 27 13:22:29.802: [50/0/31.1] set signal state = 0x8 timestamp = 0htsp_setup_
req
Apr 27 13:22:29.806: [0/1/3] htsp_dsm_close_done
VR#
Apr 27 13:22:29.806: htsp_process_event: [0/1/3, FXOLS_ONHOOK, E_HTSP_SETUP_REQ]
fxols_onhook_setup
Apr 27 13:22:29.806: [0/1/3] set signal state = 0xC timestamp = 0
Apr 27 13:22:29.806: htsp_timer - 1300 msec
Apr 27 13:22:30.102: htsp_process_event: [0/1/3, FXOLS_WAIT_DIAL_TONE, E_DSP_SIG
_0110]fxols_disc_clear
Apr 27 13:22:30.102: htsp_timer_stop2
Apr 27 13:22:30.102: htsp_timer - 1300 msec
VR#
Apr 27 13:22:31.402: htsp_process_event: [0/1/3, FXOLS_WAIT_DIAL_TONE, E_HTSP_EV
ENT_TIMER]fxols_wait_dial_timer htsp_dial
VR#
Apr 27 13:22:33.022: htsp_process_event: [0/1/3, FXOLS_WAIT_DIAL_DONE, E_DSP_DIA
LING_DONE]fxols_wait_dial_done htsp_progress
Apr 27 13:22:33.022: htsp_timer - 350 msec
Apr 27 13:22:33.026: htsp_call_bridged invoked
Apr 27 13:22:33.026: htsp_call_bridged invokedhtsp_progress_notifyhtsp_call_feat
ure:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 0
Apr 27 13:22:33.026: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_CALLER
ID_WAITING]
Apr 27 13:22:33.026: efxs_callerid_update
Apr 27 13:22:33.026: efxs_callerid_update process caller_id_string
Apr 27 13:22:33.026: efxs_callerid_update process caller_id_string OK
Apr 27 13:22:33.026: efxs_callerid_update number= [996656035] name= []
Apr 27 13:22:33.026: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_VOICE_
CUT_THROUGH]efxs_offhook_cutthru
Apr 27 13:22:33.026: [50/0/31.1] set signal state = 0x7 timestamp = 0
Apr 27 13:22:33.026: htsp_process_event: [0/1/3, FXOLS_WAIT_CUT_THRU, E_HTSP_VOI
CE_CUT_THROUGH]fxols_handle_cut_thru
Apr 27 13:22:33.026: htsp_timer_stop htsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 1
Apr 27 13:22:33.030: htsp_process_event: [50/0/31.1, EFXS_OFFHOOK, E_HTSP_CONNEC
T]efxs_offhook_connect
Apr 27 13:22:33.030: [50/0/31.1] set signal state = 0x6 timestamp = 0
VR#
Apr 27 13:22:33.030: htsp_process_event: [50/0/31.1, EFXS_CONNECT, E_HTSP_CALLER
ID_WAITING]
Apr 27 13:22:33.030: efxs_callerid_update
Apr 27 13:22:33.030: efxs_callerid_update process caller_id_string
Apr 27 13:22:33.030: efxs_callerid_update process caller_id_string OK
Apr 27 13:22:33.030: efxs_callerid_update number= [996656035] name= []
VR#unde all
All possible debugging has been turned off
VR#
Apr 27 13:22:42.958: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 5
75CA3B9AE7411E28E3EEEA55F0A0083, SetupTime 13:22:27.968 UTC Sat Apr 27 2013, Pee
rAddress 123, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call
clearing (16), ConnectTime 13:22:33.028 UTC Sat Apr 27 2013, DisconnectTime 13:2
2:42.958 UTC Sat Apr 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, Transmit
Packets 490, TransmitBytes 78400, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:22:42.958: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:22:27.966,cgn:123,cdn:,frs:0,fid:1776,fcid:575CA3B9AE7411E28E3EEEA55F0A0083,
legID:559,bguid:575CA3B9AE7411E28E3EEEA55F0A0083
Apr 27 13:22:42.974: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 5
75CA3B9AE7411E28E3EEEA55F0A0083, SetupTime 13:22:29.804 UTC Sat Apr 27 2013, Pee
rAddress 996656035, PeerSubAddress , DisconnectCause 10 , DisconnectText normal
call clearing (16), ConnectTime 13:22:33.024 UTC Sat Apr 27 2013, DisconnectTim
e 13:22:42.974 UTC Sat Apr 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, Tr
ansmitPackets 496, TransmitBytes 79360, ReceivePackets 490, ReceiveBytes 82320
VR#
Apr 27 13:22:42.974: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:22:29.802,cgn:123,cdn:996656035,frs:0,fid:1777,fcid:575CA3B9AE7411E28E3EEEA5
5F0A0083,legID:55A,bguid:575CA3B9AE7411E28E3EEEA55F0A0083
VR#und all
All possible debugging has been turned off
VR#
04-27-2013 06:34 AM
From the logs, you are calling rom extension 123..Is this number part of your DDI? If not you will need to configure xlation rules to send the correct DDI to your provider
Apr 27 13:22:27.966: [50/0/31.1] get_local_station_id calling num=123 calling na
me=Britto, Vimalraj calling time=04/27 13:22 orig called=
Please rate all useful posts
"opportunity is a haughty goddess who waste no time with those who are unprepared"
04-27-2013 06:40 AM
Dear,
You are correct. My problem whenever someone call to my board number i can see "unknown number" eventhough we had a subscription with caller id enabled.
Kindly suggest me.
04-27-2013 06:45 AM
This log you sent is a test for an outbound call..You need to send logs for inbound call...
Please send the logs
Please rate all useful posts
"opportunity is a haughty goddess who waste no time with those who are unprepared"
04-27-2013 06:52 AM
Thank you.
Please find the inbound call log
VR#debug vpm signal
Voice Port Module signaling debugging is enabled
VR#
Apr 27 13:24:02.082: htsp_process_event: [0/2/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fx
ols_onhook_ringing
Apr 27 13:24:02.082: htsp_timer - 125 msec
Apr 27 13:24:02.210: htsp_process_event: [0/2/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVE
NT_TIMER]fxols_wait_ring_min_timer
Apr 27 13:24:02.210: htsp_timer - 10000 msec
Apr 27 13:24:02.210: [0/2/1] htsp_stop_caller_id_rx. message length 0
Apr 27 13:24:02.210: htsp_timer_stop3 htsp_setup_ind
Apr 27 13:24:02.210: [0/2/1] get_fxo_caller_id:Caller ID receive failed. parseC
allerIDString:no data.
Apr 27 13:24:02.210: [0/2/1] get_local_station_id calling num= calling name= cal
ling time=04/27 13:24 orig called=
Apr 27 13:24:02.210: [0/2/1] htsp_dsm_close_done
Apr 27 13:24:02.210: htsp_process_event: [0/2/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SE
TUP_ACK]
Apr 27 13:24:02.210: fxols_wait_setup_ack:
Apr 27 13:24:02.210: htsp_timer - 6000 msec
Apr 27 13:24:02.210: htsp_timer_stop3
Apr 27 13:24:02.210: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_HTSP_PROCEE
DING]fxols_offhook_prochtsp_setup_req
Apr 27 13:24:02.214: htsp_process_event: [50/0/30.1, EFXS_ONHOOK, E_HTSP_SETUP_R
EQ]efxs_onhook_setup
Apr 27 13:24:02.214: htsp_ephone_start_caller_id_tx calling num= calling name =
called num=100 orig called num=
Apr 27 13:24:02.214: [50/0/30.1] set signal state = 0x0 timestamp = 0
VR#
Apr 27 13:24:02.214: efxs_onhook_setup: local target is available
htsp_alerthtsp_alert_notify
Apr 27 13:24:02.214: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_HTSP_ALERT]
fxols_offhook_alert
Apr 27 13:24:03.118: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_DSP_SIG_010
0]fxols_proceed_clear
Apr 27 13:24:03.118: htsp_timer_stop2
Apr 27 13:24:03.118: htsp_timer - 6000 msec
VR#
Apr 27 13:24:05.886: htsp_process_event: [50/0/63.1, EFXS_ONHOOK, E_DSP_SIG_1100
]efxs_onhook_offhook htsp_setup_ind
Apr 27 13:24:05.886: [50/0/63.1] get_local_station_id calling num=103 calling na
me=SEC calling time=04/27 13:24 orig called=
Apr 27 13:24:05.890: htsp_process_event: [50/0/63.1, EFXS_WAIT_SETUP_ACK, E_HTSP
_SETUP_ACK]efxs_check_auto_call
Apr 27 13:24:05.890: htsp_process_event: [50/0/63.1, EFXS_OFFHOOK, E_DSP_SIG_010
0]efxs_offhook_onhook
Apr 27 13:24:05.890: htsp_timer - 10 msec
Apr 27 13:24:05.890: htsp_process_event: [50/0/63.1, EFXS_OFFHOOK, E_DSP_SIG_010
0]efxs_offhook_onhook
Apr 27 13:24:05.890: htsp_timer - 10 msec
Apr 27 13:24:05.902: htsp_process_event: [50/0/63.1, EFXS_OFFHOOK, E_HTSP_EVENT_
TIMER]efxs_offhook_timer
Apr 27 13:24:05.902: htsp_process_event: [50/0/63.1, EFXS_ONHOOK, E_HTSP_RELEASE
_REQ]efxs_onhook_release
Apr 27 13:24:05.902: htsp_timer_stop
Apr 27 13:24:05.902: [50/0/63.1] set signal state = 0x4 timestamp = 0
Apr 27 13:24:05.902: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 9
1BAA7F8AE7411E28E48EEA55F0A0083, SetupTime 13:24:05.892 UTC Sat Apr 27 2013, Pee
rAddress 103, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call
clearing (16), ConnectTime 13:24:05.902 UTC Sat Apr 27 2013, DisconnectTime 13:2
4:05.902 UTC Sat Apr 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, Transmit
Packets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:24:05.902: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:05.890,cgn:103,cdn:,frs:0,fid:1780,fcid:91BAA7F8AE7411E28E48EEA55F0A0083,
legID:55D,bguid:91BAA7F8AE7411E28E48EEA55F0A0083
Apr 27 13:24:05.986: htsp_process_event: [50/0/30.1, EFXS_WAIT_OFFHOOK, E_DSP_SI
G_0100]efxs_waitoff_onhook
Apr 27 13:24:05.986: htsp_timer_stop
Apr 27 13:24:05.986: htsp_process_event: [50/0/30.1, EFXS_ONHOOK, E_HTSP_RELEASE
_REQ]efxs_onhook_release
Apr 27 13:24:05.986: htsp_timer_stop
Apr 27 13:24:05.986: [50/0/30.1] set signal state = 0x4 timestamp = 0
Apr 27 13:24:05.986: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 8
F892309AE7411E28E43EEA55F0A0083, SetupTime 13:24:02.216 UTC Sat Apr 27 2013, Pee
rAddress 100, PeerSubAddress , DisconnectCause 13 , DisconnectText no user answ
er (19), ConnectTime 13:24:05.986 UTC Sat Apr 27 2013, DisconnectTime 13:24:05.9
86 UTC Sat Apr 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPacket
s 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:24:05.986: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:CFNA,ft:04/27/201
3 13:24:05.986,frs:0,fid:1781,fcid:8F892309AE7411E28E43EEA55F0A0083,legID:55B,fr
son:3,fdcnt:1,fwder:100,fwdee:,fwdto:103,frm:100,bguid:8F892309AE7411E28E43EEA55
F0A0083
Apr 27 13:24:05.986: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:02.210,cgn:,cdn:100,frs:0,fid:1779,fcid:8F892309AE7411E28E43EEA55F0A0083,
legID:55C,bguid:8F892309AE7411E28E43EEA55F0A0083
Apr 27 13:24:05.990: htsp_timer_stop3 htsp_setup_req
Apr 27 13:24:05.990: htsp_process_event: [50/0/63.1, EFXS_ONHOOK, E_HTSP_SETUP_R
EQ]efxs_onhook_setup
Apr 27 13:24:05.990: htsp_ephone_start_caller_id_tx calling num= calling name =
called num=103 orig called num=100
Apr 27 13:24:05.990: [50/0/63.1] set signal state = 0x0 timestamp = 0
Apr 27 13:24:05.990: efxs_onhook_setup: local target is available
htsp_alerthtsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 0
Apr 27 13:24:05.994: htsp_process_event: [50/0/63.1, EFXS_WAIT_OFFHOOK, E_HTSP_C
ALLERID_WAITING]
Apr 27 13:24:05.994: efxs_callerid_update
Apr 27 13:24:05.994: efxs_callerid_update process caller_id_string
Apr 27 13:24:05.994: efxs_callerid_update process caller_id_string OK
Apr 27 13:24:05.994: efxs_callerid_update number= [] name= []
Apr 27 13:24:06.018: htsp_process_event: [50/0/63.1, EFXS_WAIT_OFFHOOK, E_DSP_SI
G_1100]efxs_waitoff_offhook
Apr 27 13:24:06.018: [50/0/63.1] set signal state = 0x4 timestamp = 0 htsp_dial
Apr 27 13:24:06.018: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_DSP_DIALING
_DONE]
Apr 27 13:24:06.022: htsp_call_bridged invoked
Apr 27 13:24:06.022: htsp_call_bridged invokedhtsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 1
Apr 27 13:24:06.022: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_HTSP_CONNEC
T]fxols_offhook_connect
Apr 27 13:24:06.022: fxols_pak_suppress_enable 0/2/1 TRUE
Apr 27 13:24:06.022: htsp_timer3 - 350 msec
Apr 27 13:24:06.022: [0/2/1] set signal state = 0xC timestamp = 0
Apr 27 13:24:06.022: htsp_timer_stop
Apr 27 13:24:06.022: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_HTSP_CALLER
ID_WAITING]
Apr 27 13:24:06.022: efxs_callerid_update
Apr 27 13:24:06.022: efxs_callerid_update process caller_id_string
Apr 27 13:24:06.022: efxs_callerid_update process caller_id_string OK
Apr 27 13:24:06.022: efxs_callerid_update number= [] name= []
VR#
Apr 27 13:24:06.022: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_HTSP_VOICE_
CUT_THROUGH]efxs_connect_cutthru
Apr 27 13:24:06.022: [50/0/63.1] set signal state = 0x7 timestamp = 0
Apr 27 13:24:06.022: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT
_THROUGH]fxols_connect_proc_voice
Apr 27 13:24:06.302: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_DSP_SIG_0110]f
xols_rvs_battery
Apr 27 13:24:06.302: htsp_timer_stop2
Apr 27 13:24:06.302: htsp_timer_stop2
Apr 27 13:24:06.374: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_HTSP_EVENT_TIM
ER3]fxols_opx_cut_thru
Apr 27 13:24:06.374: htsp_timer_stop3
Apr 27 13:24:06.374: fxols_pak_suppress_enable 0/2/1 FALSE
VR#unde
Apr 27 13:24:10.530: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_DSP_SIG_010
0]efxs_offhook_onhook
Apr 27 13:24:10.530: htsp_timer - 10 msec
Apr 27 13:24:10.542: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_HTSP_EVENT_
TIMER]efxs_connect_wait_release_req
Apr 27 13:24:10.542: htsp_timer_stop
Apr 27 13:24:10.542: htsp_timer_stop3
Apr 27 13:24:10.542: htsp_timer_stop3
Apr 27 13:24:10.542: htsp_process_event: [50/0/63.1, EFXS_WAIT_RELEASE_REQ, E_HT
SP_RELEASE_REQ]efxs_waitrls_req_rlshtsp_report_onhook_sig
Apr 27 13:24:10.542: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 9
1C9E9A9AE7411E28E4CEEA55F0A0083, SetupTime 13:24:05.992 UTC Sat Apr 27 2013, Pee
rAddress 103, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call
clearing (16), ConnectTime 13:24:06.022 UTC Sat Apr 27 2013, DisconnectTime 13:2
4:10.542 UTC Sat Apr 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, Transmit
Packets 218, TransmitBytes 34880, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:24:10.542: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:CFNA,ft:04/27/201
3 13:24:05.990,frs:0,fid:1784,fcid:8F892309AE7411E28E43EEA55F0A0083,legID:55E,fr
son:3,fdcnt:1,fwder:100,fwdee:,fwdto:103,frm:100,bguid:8F892309AE7411E28E43EEA55
F0A0083
Apr 27 13:24:10.542: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:05.990,cgn:,cdn:103,frs:0,fid:1785,fcid:8F892309AE7411E28E43EEA55F0A0083,
legID:55E,bguid:8F892309AE7411E28E43EEA55F0A0083
Apr 27 13:24:10.558: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_HTSP_RELEASE_R
EQ]fxols_offhook_release
Apr 27 13:24:10.558: htsp_timer_stop
Apr 27 13:24:10.558: htsp_timer_stop2
Apr 27 13:24:10.558: htsp_timer_stop3
Apr 27 13:24:10.558: [0/2/1] set signal state = 0x4 timestamp = 0
Apr 27 13:24:10.558: htsp_timer - 2000 msec
Apr 27 13:24:10.558: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 8
F892309AE7411E28E43EEA55F0A0083, SetupTime 13:24:02.208 UTC Sat Apr 27 2013, Pee
rAddress , PeerSubAddress , DisconnectCause 10 , DisconnectText normal call cle
aring (16), ConnectTime 13:24:06.018 UTC Sat Apr 27 2013, DisconnectTime 13:24:1
0.558 UTC Sat Apr 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPac
kets 208, TransmitBytes 33280, ReceivePackets 218, ReceiveBytes 36624
Apr 27 13:24:10.558: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:CFNA,ft:04/27/201
3 13:24:05.990,frs:0,fid:1784,fcid:8F892309AE7411E28E43EEA55F0A0083,legID:55E,fr
son:3,fdcnt:1,fwder:100,fwdee:,fwdto:103,frm:100,bguid:8F892309AE7411E28E43EEA55
F0A0083
Apr 27 13:24:10.558: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:02.210,cgn:,cdn:100,frs:0,fid:1778,fcid:8F892309AE7411E28E43EEA55F0A0083,
legID:55B,bguid:8F892309AE7411E28E43EEA55F0A0083
VR#unde all
All possible debugging has been turned off
VR#
Apr 27 13:24:10.834: htsp_process_event: [0/2/1, FXOLS_GUARD_OUT, E_DSP_SIG_0110
]
VR#
VR#debug vpm signal
Voice Port Module signaling debugging is enabled
VR#
Apr 27 13:24:02.082: htsp_process_event: [0/2/1, FXOLS_ONHOOK, E_DSP_SIG_0000]fx
ols_onhook_ringing
Apr 27 13:24:02.082: htsp_timer - 125 msec
Apr 27 13:24:02.210: htsp_process_event: [0/2/1, FXOLS_WAIT_RING_MIN, E_HTSP_EVE
NT_TIMER]fxols_wait_ring_min_timer
Apr 27 13:24:02.210: htsp_timer - 10000 msec
Apr 27 13:24:02.210: [0/2/1] htsp_stop_caller_id_rx. message length 0
Apr 27 13:24:02.210: htsp_timer_stop3 htsp_setup_ind
Apr 27 13:24:02.210: [0/2/1] get_fxo_caller_id:Caller ID receive failed. parseC
allerIDString:no data.
Apr 27 13:24:02.210: [0/2/1] get_local_station_id calling num= calling name= cal
ling time=04/27 13:24 orig called=
Apr 27 13:24:02.210: [0/2/1] htsp_dsm_close_done
Apr 27 13:24:02.210: htsp_process_event: [0/2/1, FXOLS_WAIT_SETUP_ACK, E_HTSP_SE
TUP_ACK]
Apr 27 13:24:02.210: fxols_wait_setup_ack:
Apr 27 13:24:02.210: htsp_timer - 6000 msec
Apr 27 13:24:02.210: htsp_timer_stop3
Apr 27 13:24:02.210: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_HTSP_PROCEE
DING]fxols_offhook_prochtsp_setup_req
Apr 27 13:24:02.214: htsp_process_event: [50/0/30.1, EFXS_ONHOOK, E_HTSP_SETUP_R
EQ]efxs_onhook_setup
Apr 27 13:24:02.214: htsp_ephone_start_caller_id_tx calling num= calling name =
called num=100 orig called num=
Apr 27 13:24:02.214: [50/0/30.1] set signal state = 0x0 timestamp = 0
VR#
Apr 27 13:24:02.214: efxs_onhook_setup: local target is available
htsp_alerthtsp_alert_notify
Apr 27 13:24:02.214: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_HTSP_ALERT]
fxols_offhook_alert
Apr 27 13:24:03.118: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_DSP_SIG_010
0]fxols_proceed_clear
Apr 27 13:24:03.118: htsp_timer_stop2
Apr 27 13:24:03.118: htsp_timer - 6000 msec
VR#
Apr 27 13:24:05.886: htsp_process_event: [50/0/63.1, EFXS_ONHOOK, E_DSP_SIG_1100
]efxs_onhook_offhook htsp_setup_ind
Apr 27 13:24:05.886: [50/0/63.1] get_local_station_id calling num=103 calling na
me=SEC calling time=04/27 13:24 orig called=
Apr 27 13:24:05.890: htsp_process_event: [50/0/63.1, EFXS_WAIT_SETUP_ACK, E_HTSP
_SETUP_ACK]efxs_check_auto_call
Apr 27 13:24:05.890: htsp_process_event: [50/0/63.1, EFXS_OFFHOOK, E_DSP_SIG_010
0]efxs_offhook_onhook
Apr 27 13:24:05.890: htsp_timer - 10 msec
Apr 27 13:24:05.890: htsp_process_event: [50/0/63.1, EFXS_OFFHOOK, E_DSP_SIG_010
0]efxs_offhook_onhook
Apr 27 13:24:05.890: htsp_timer - 10 msec
Apr 27 13:24:05.902: htsp_process_event: [50/0/63.1, EFXS_OFFHOOK, E_HTSP_EVENT_
TIMER]efxs_offhook_timer
Apr 27 13:24:05.902: htsp_process_event: [50/0/63.1, EFXS_ONHOOK, E_HTSP_RELEASE
_REQ]efxs_onhook_release
Apr 27 13:24:05.902: htsp_timer_stop
Apr 27 13:24:05.902: [50/0/63.1] set signal state = 0x4 timestamp = 0
Apr 27 13:24:05.902: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 9
1BAA7F8AE7411E28E48EEA55F0A0083, SetupTime 13:24:05.892 UTC Sat Apr 27 2013, Pee
rAddress 103, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call
clearing (16), ConnectTime 13:24:05.902 UTC Sat Apr 27 2013, DisconnectTime 13:2
4:05.902 UTC Sat Apr 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, Transmit
Packets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:24:05.902: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:05.890,cgn:103,cdn:,frs:0,fid:1780,fcid:91BAA7F8AE7411E28E48EEA55F0A0083,
legID:55D,bguid:91BAA7F8AE7411E28E48EEA55F0A0083
Apr 27 13:24:05.986: htsp_process_event: [50/0/30.1, EFXS_WAIT_OFFHOOK, E_DSP_SI
G_0100]efxs_waitoff_onhook
Apr 27 13:24:05.986: htsp_timer_stop
Apr 27 13:24:05.986: htsp_process_event: [50/0/30.1, EFXS_ONHOOK, E_HTSP_RELEASE
_REQ]efxs_onhook_release
Apr 27 13:24:05.986: htsp_timer_stop
Apr 27 13:24:05.986: [50/0/30.1] set signal state = 0x4 timestamp = 0
Apr 27 13:24:05.986: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 8
F892309AE7411E28E43EEA55F0A0083, SetupTime 13:24:02.216 UTC Sat Apr 27 2013, Pee
rAddress 100, PeerSubAddress , DisconnectCause 13 , DisconnectText no user answ
er (19), ConnectTime 13:24:05.986 UTC Sat Apr 27 2013, DisconnectTime 13:24:05.9
86 UTC Sat Apr 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPacket
s 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:24:05.986: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:CFNA,ft:04/27/201
3 13:24:05.986,frs:0,fid:1781,fcid:8F892309AE7411E28E43EEA55F0A0083,legID:55B,fr
son:3,fdcnt:1,fwder:100,fwdee:,fwdto:103,frm:100,bguid:8F892309AE7411E28E43EEA55
F0A0083
Apr 27 13:24:05.986: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:02.210,cgn:,cdn:100,frs:0,fid:1779,fcid:8F892309AE7411E28E43EEA55F0A0083,
legID:55C,bguid:8F892309AE7411E28E43EEA55F0A0083
Apr 27 13:24:05.990: htsp_timer_stop3 htsp_setup_req
Apr 27 13:24:05.990: htsp_process_event: [50/0/63.1, EFXS_ONHOOK, E_HTSP_SETUP_R
EQ]efxs_onhook_setup
Apr 27 13:24:05.990: htsp_ephone_start_caller_id_tx calling num= calling name =
called num=103 orig called num=100
Apr 27 13:24:05.990: [50/0/63.1] set signal state = 0x0 timestamp = 0
Apr 27 13:24:05.990: efxs_onhook_setup: local target is available
htsp_alerthtsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 0
Apr 27 13:24:05.994: htsp_process_event: [50/0/63.1, EFXS_WAIT_OFFHOOK, E_HTSP_C
ALLERID_WAITING]
Apr 27 13:24:05.994: efxs_callerid_update
Apr 27 13:24:05.994: efxs_callerid_update process caller_id_string
Apr 27 13:24:05.994: efxs_callerid_update process caller_id_string OK
Apr 27 13:24:05.994: efxs_callerid_update number= [] name= []
Apr 27 13:24:06.018: htsp_process_event: [50/0/63.1, EFXS_WAIT_OFFHOOK, E_DSP_SI
G_1100]efxs_waitoff_offhook
Apr 27 13:24:06.018: [50/0/63.1] set signal state = 0x4 timestamp = 0 htsp_dial
Apr 27 13:24:06.018: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_DSP_DIALING
_DONE]
Apr 27 13:24:06.022: htsp_call_bridged invoked
Apr 27 13:24:06.022: htsp_call_bridged invokedhtsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 1
Apr 27 13:24:06.022: htsp_process_event: [0/2/1, FXOLS_PROCEEDING, E_HTSP_CONNEC
T]fxols_offhook_connect
Apr 27 13:24:06.022: fxols_pak_suppress_enable 0/2/1 TRUE
Apr 27 13:24:06.022: htsp_timer3 - 350 msec
Apr 27 13:24:06.022: [0/2/1] set signal state = 0xC timestamp = 0
Apr 27 13:24:06.022: htsp_timer_stop
Apr 27 13:24:06.022: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_HTSP_CALLER
ID_WAITING]
Apr 27 13:24:06.022: efxs_callerid_update
Apr 27 13:24:06.022: efxs_callerid_update process caller_id_string
Apr 27 13:24:06.022: efxs_callerid_update process caller_id_string OK
Apr 27 13:24:06.022: efxs_callerid_update number= [] name= []
VR#
Apr 27 13:24:06.022: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_HTSP_VOICE_
CUT_THROUGH]efxs_connect_cutthru
Apr 27 13:24:06.022: [50/0/63.1] set signal state = 0x7 timestamp = 0
Apr 27 13:24:06.022: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_HTSP_VOICE_CUT
_THROUGH]fxols_connect_proc_voice
Apr 27 13:24:06.302: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_DSP_SIG_0110]f
xols_rvs_battery
Apr 27 13:24:06.302: htsp_timer_stop2
Apr 27 13:24:06.302: htsp_timer_stop2
Apr 27 13:24:06.374: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_HTSP_EVENT_TIM
ER3]fxols_opx_cut_thru
Apr 27 13:24:06.374: htsp_timer_stop3
Apr 27 13:24:06.374: fxols_pak_suppress_enable 0/2/1 FALSE
VR#unde
Apr 27 13:24:10.530: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_DSP_SIG_010
0]efxs_offhook_onhook
Apr 27 13:24:10.530: htsp_timer - 10 msec
Apr 27 13:24:10.542: htsp_process_event: [50/0/63.1, EFXS_CONNECT, E_HTSP_EVENT_
TIMER]efxs_connect_wait_release_req
Apr 27 13:24:10.542: htsp_timer_stop
Apr 27 13:24:10.542: htsp_timer_stop3
Apr 27 13:24:10.542: htsp_timer_stop3
Apr 27 13:24:10.542: htsp_process_event: [50/0/63.1, EFXS_WAIT_RELEASE_REQ, E_HT
SP_RELEASE_REQ]efxs_waitrls_req_rlshtsp_report_onhook_sig
Apr 27 13:24:10.542: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 9
1C9E9A9AE7411E28E4CEEA55F0A0083, SetupTime 13:24:05.992 UTC Sat Apr 27 2013, Pee
rAddress 103, PeerSubAddress , DisconnectCause 10 , DisconnectText normal call
clearing (16), ConnectTime 13:24:06.022 UTC Sat Apr 27 2013, DisconnectTime 13:2
4:10.542 UTC Sat Apr 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, Transmit
Packets 218, TransmitBytes 34880, ReceivePackets 0, ReceiveBytes 0
Apr 27 13:24:10.542: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:CFNA,ft:04/27/201
3 13:24:05.990,frs:0,fid:1784,fcid:8F892309AE7411E28E43EEA55F0A0083,legID:55E,fr
son:3,fdcnt:1,fwder:100,fwdee:,fwdto:103,frm:100,bguid:8F892309AE7411E28E43EEA55
F0A0083
Apr 27 13:24:10.542: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:05.990,cgn:,cdn:103,frs:0,fid:1785,fcid:8F892309AE7411E28E43EEA55F0A0083,
legID:55E,bguid:8F892309AE7411E28E43EEA55F0A0083
Apr 27 13:24:10.558: htsp_process_event: [0/2/1, FXOLS_CONNECT, E_HTSP_RELEASE_R
EQ]fxols_offhook_release
Apr 27 13:24:10.558: htsp_timer_stop
Apr 27 13:24:10.558: htsp_timer_stop2
Apr 27 13:24:10.558: htsp_timer_stop3
Apr 27 13:24:10.558: [0/2/1] set signal state = 0x4 timestamp = 0
Apr 27 13:24:10.558: htsp_timer - 2000 msec
Apr 27 13:24:10.558: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 8
F892309AE7411E28E43EEA55F0A0083, SetupTime 13:24:02.208 UTC Sat Apr 27 2013, Pee
rAddress , PeerSubAddress , DisconnectCause 10 , DisconnectText normal call cle
aring (16), ConnectTime 13:24:06.018 UTC Sat Apr 27 2013, DisconnectTime 13:24:1
0.558 UTC Sat Apr 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPac
kets 208, TransmitBytes 33280, ReceivePackets 218, ReceiveBytes 36624
Apr 27 13:24:10.558: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:CFNA,ft:04/27/201
3 13:24:05.990,frs:0,fid:1784,fcid:8F892309AE7411E28E43EEA55F0A0083,legID:55E,fr
son:3,fdcnt:1,fwder:100,fwdee:,fwdto:103,frm:100,bguid:8F892309AE7411E28E43EEA55
F0A0083
Apr 27 13:24:10.558: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:04/27/2013
13:24:02.210,cgn:,cdn:100,frs:0,fid:1778,fcid:8F892309AE7411E28E43EEA55F0A0083,
legID:55B,bguid:8F892309AE7411E28E43EEA55F0A0083
VR#unde all
All possible debugging has been turned off
VR#
Apr 27 13:24:10.834: htsp_process_event: [0/2/1, FXOLS_GUARD_OUT, E_DSP_SIG_0110
]
VR#
04-27-2013 08:24 AM
Hi,
From the logs..your provider is not sending any caller id..
Apr 27 13:24:02.210: [0/2/1] get_fxo_caller_id:Caller ID receive failed. parseCallerIDString:no data.
This is what you can do..
Disconnect the router from the phone line and attach a caller-ID equipped telephone to verify that the CO is sending caller-ID information:
Listen and watch to see when the caller-ID information is displayed: before the first ring, after the first ring, or after the second ring?
Please rate all useful posts
"opportunity is a haughty goddess who waste no time with those who are unprepared"
05-12-2013 12:36 AM
Sorry for the dely. Thanks for your support. I was comunicating with CO and now am getting the caller id with any problem and getting caller id after the first ring & suggest me to slove this problem.
Thanks
05-13-2013 06:39 AM
Dear , the caller id is working on my board number now. But tell me how to extend the caller id function from board number to the local extensions??
Thanks in advance.
Discover and save your favorite ideas. Come back to expert answers, step-by-step guides, recent topics, and more.
New here? Get started with these tips. How to use Community New member guide