cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
525
Views
0
Helpful
13
Replies
Highlighted

2901 - Caller id not working

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

Everyone's tags (1)
13 REPLIES 13
VIP Mentor

2901 - Caller id not working

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"

Please rate all useful posts
Advisor

2901 - Caller id not working

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

2901 - Caller id not working

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

VIP Mentor

2901 - Caller id not working

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"

Please rate all useful posts
Engager

2901 - Caller id not working

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

2901 - Caller id not working

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#

VIP Mentor

2901 - Caller id not working

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"

Please rate all useful posts

2901 - Caller id not working

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.

VIP Mentor

2901 - Caller id not working

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"

Please rate all useful posts

2901 - Caller id not working

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#

VIP Mentor

2901 - Caller id not working

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"

Please rate all useful posts

2901 - Caller id not working

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

2901 - Caller id not working

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.

CreatePlease to create content
Content for Community-Ad
August's Community Spotlight Awards