Stange problem accepting calls on FXO

Unanswered Question
Jun 7th, 2007
User Badges:

Having a strange issue with an VIC2-4FXO where after a reboot on of the ports will see an incomming call, but never does anything with it. Yet, if I plug another line into that port it works as expected when called.


To get around this, I just swapped the lines, and modified the config. Everything was fine until I rebooted...it happened again.


To fix it, ive just swapped the lines around back to normal and changed the dial-peers and plar....


My debug of the problem looks like this:


Jun 8 01:50:04.241: htsp_process_event: [0/0/3, FXOGS_ONHOOK, E_DSP_SIG_0000]fxogs_onhook_ringing

Jun 8 01:50:04.241: htsp_timer_stop

Jun 8 01:50:04.241: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_PENDING, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:04.241: htsp_timer - 125 msec

Jun 8 01:50:04.369: htsp_process_event: [0/0/3, FXOGS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxogs_wait_ring_min_timer

Jun 8 01:50:04.369: htsp_timer - 10000 msec

Jun 8 01:50:04.369: htsp_timer3 - 5600 msec

Jun 8 01:50:04.369: [0/0/3] htsp_start_caller_id_rx:BELLCORE

Jun 8 01:50:04.369: [0/0/3] htsp_dsm_create_success returns 1

Jun 8 01:50:05.337: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_0100]

Jun 8 01:50:05.337: fxogs_ringing_not:

Jun 8 01:50:05.337: htsp_timer_stop

Jun 8 01:50:05.337: htsp_timer_stop2

Jun 8 01:50:05.337: htsp_timer - 10000 msec

Jun 8 01:50:05.740: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_1100]

Jun 8 01:50:05.740: fxogs_ringing_no_tipgnd

Jun 8 01:50:05.740: htsp_timer_stop

Jun 8 01:50:05.740: htsp_timer_stop2

Jun 8 01:50:05.740: htsp_timer2 - 350 msec

Jun 8 01:50:06.100: htsp_process_event: [0/0/3, FXOGS_RINGING, E_HTSP_EVENT_TIMER2]fxogs_ringing_disc

Jun 8 01:50:06.100: [0/0/3] htsp_stop_caller_id_rx. message length 0

Jun 8 01:50:06.100: htsp_timer_stop

Jun 8 01:50:06.100: htsp_timer_stop2

Jun 8 01:50:06.100: htsp_timer_stop3

Jun 8 01:50:06.100: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_IDLE, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:06.104: flex_dsprm_close_cleanup

Jun 8 01:50:06.104: [0/0/3] htsp_dsm_close_done

Jun 8 01:50:07.236: htsp_process_event: [0/0/3, FXOGS_ONHOOK, E_DSP_SIG_0000]fxogs_onhook_ringing

Jun 8 01:50:07.236: htsp_timer_stop

Jun 8 01:50:07.236: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_PENDING, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:07.236: htsp_timer - 125 msec

Jun 8 01:50:07.364: htsp_process_event: [0/0/3, FXOGS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxogs_wait_ring_min_timer

Jun 8 01:50:07.364: htsp_timer - 10000 msec

Jun 8 01:50:07.364: htsp_timer3 - 5600 msec

Jun 8 01:50:07.364: [0/0/3] htsp_start_caller_id_rx:BELLCORE

Jun 8 01:50:07.364: [0/0/3] htsp_dsm_create_success returns 1

Jun 8 01:50:08.336: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_0100]

Jun 8 01:50:08.340: fxogs_ringing_not:

Jun 8 01:50:08.340: htsp_timer_stop

Jun 8 01:50:08.340: htsp_timer_stop2

Jun 8 01:50:08.340: htsp_timer - 10000 msec

Jun 8 01:50:08.740: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_1100]

Jun 8 01:50:08.740: fxogs_ringing_no_tipgnd

Jun 8 01:50:08.740: htsp_timer_stop

Jun 8 01:50:08.740: htsp_timer_stop2

Jun 8 01:50:08.740: htsp_timer2 - 350 msec

Jun 8 01:50:09.104: htsp_process_event: [0/0/3, FXOGS_RINGING, E_HTSP_EVENT_TIMER2]fxogs_ringing_disc

Jun 8 01:50:09.104: [0/0/3] htsp_stop_caller_id_rx. message length 0


  • 1
  • 2
  • 3
  • 4
  • 5
Overall Rating: 0 (0 ratings)
Loading.
paul_alexander Thu, 06/07/2007 - 22:42
User Badges:

Jun 8 01:50:09.104: htsp_timer_stop

Jun 8 01:50:09.104: htsp_timer_stop2

Jun 8 01:50:09.104: htsp_timer_stop3

Jun 8 01:50:09.104: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_IDLE, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:09.108: flex_dsprm_close_cleanup

Jun 8 01:50:09.108: [0/0/3] htsp_dsm_close_done

Jun 8 01:50:10.248: htsp_process_event: [0/0/3, FXOGS_ONHOOK, E_DSP_SIG_0000]fxogs_onhook_ringing

Jun 8 01:50:10.248: htsp_timer_stop

Jun 8 01:50:10.248: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_PENDING, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:10.248: htsp_timer - 125 msec

Jun 8 01:50:10.376: htsp_process_event: [0/0/3, FXOGS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxogs_wait_ring_min_timer

Jun 8 01:50:10.376: htsp_timer - 10000 msec

Jun 8 01:50:10.376: htsp_timer3 - 5600 msec

Jun 8 01:50:10.376: [0/0/3] htsp_start_caller_id_rx:BELLCORE

Jun 8 01:50:10.376: [0/0/3] htsp_dsm_create_success returns 1

Jun 8 01:50:11.340: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_0100]

Jun 8 01:50:11.340: fxogs_ringing_not:

Jun 8 01:50:11.340: htsp_timer_stop

Jun 8 01:50:11.340: htsp_timer_stop2

Jun 8 01:50:11.340: htsp_timer - 10000 msec

Jun 8 01:50:11.740: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_1100]

Jun 8 01:50:11.740: fxogs_ringing_no_tipgnd

Jun 8 01:50:11.740: htsp_timer_stop

Jun 8 01:50:11.740: htsp_timer_stop2

Jun 8 01:50:11.740: htsp_timer2 - 350 msec

Jun 8 01:50:12.092: htsp_process_event: [0/0/3, FXOGS_RINGING, E_HTSP_EVENT_TIMER2]fxogs_ringing_disc

Jun 8 01:50:12.092: [0/0/3] htsp_stop_caller_id_rx. message length 0

Jun 8 01:50:12.092: htsp_timer_stop

Jun 8 01:50:12.092: htsp_timer_stop2

Jun 8 01:50:12.092: htsp_timer_stop3

Jun 8 01:50:12.092: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_IDLE, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:12.096: flex_dsprm_close_cleanup

Jun 8 01:50:12.096: [0/0/3] htsp_dsm_close_done

Jun 8 01:50:13.240: htsp_process_event: [0/0/3, FXOGS_ONHOOK, E_DSP_SIG_0000]fxogs_onhook_ringing

Jun 8 01:50:13.240: htsp_timer_stop

Jun 8 01:50:13.240: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_PENDING, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:13.240: htsp_timer - 125 msec

Jun 8 01:50:13.368: htsp_process_event: [0/0/3, FXOGS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxogs_wait_ring_min_timer

Jun 8 01:50:13.368: htsp_timer - 10000 msec

Jun 8 01:50:13.368: htsp_timer3 - 5600 msec

Jun 8 01:50:13.368: [0/0/3] htsp_start_caller_id_rx:BELLCORE

Jun 8 01:50:13.368: [0/0/3] htsp_dsm_create_success returns 1

Jun 8 01:50:14.336: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_0100]

Jun 8 01:50:14.336: fxogs_ringing_not:

Jun 8 01:50:14.336: htsp_timer_stop

Jun 8 01:50:14.336: htsp_timer_stop2

Jun 8 01:50:14.340: htsp_timer - 10000 msec

Jun 8 01:50:14.739: htsp_process_event: [0/0/3, FXOGS_RINGING, E_DSP_SIG_1100]

Jun 8 01:50:14.739: fxogs_ringing_no_tipgnd

Jun 8 01:50:14.739: htsp_timer_stop

Jun 8 01:50:14.739: htsp_timer_stop2

Jun 8 01:50:14.739: htsp_timer2 - 350 msec

Jun 8 01:50:15.095: htsp_process_event: [0/0/3, FXOGS_RINGING, E_HTSP_EVENT_TIMER2]fxogs_ringing_disc

Jun 8 01:50:15.095: [0/0/3] htsp_stop_caller_id_rx. message length 0

Jun 8 01:50:15.095: htsp_timer_stop

Jun 8 01:50:15.095: htsp_timer_stop2

Jun 8 01:50:15.095: htsp_timer_stop3

Jun 8 01:50:15.095: TGRM: reg_invoke_tgrm_call_update(0, 0, 3, 65535, 1, TGRM_CALL_IDLE, TGRM_CALL_VOICE, TGRM_DIRECTION_IN)

Jun 8 01:50:15.099: flex_dsprm_close_cleanup

Jun 8 01:50:15.099: [0/0/3] htsp_dsm_close_done







paul_alexander Thu, 06/07/2007 - 22:46
User Badges:

voice-port 0/0/2

supervisory disconnect dualtone mid-call

cptone AU

timeouts wait-release 1

connection plar opx 811

impedance complex1

station-id name SS-Naomi

station-id number 0393842244

caller-id enable

!

voice-port 0/0/3

supervisory disconnect dualtone mid-call

cptone AU

timeouts wait-release 1

connection plar opx 806

impedance complex1

station-id name SS-Garden

station-id number 0393864241

caller-id enable



To be honest, ive had so many problems with these PSTN lines, but this is the only outstanding one.


What bugs me, is my configuration on the ports doesnt change. Its just the swapping of the lines that does.









Actions

This Discussion