DSL flap statistics help

Tool output

Time Event Elapsed since last failure event, s Elapsed since last online event, s
Jan 1 00:01:30.767 LOM (loss of margin)

Jan 1 00:01:30.767 LOS(loss of signal) 0
Jan 1 00:01:50.935 Showtime 20.168
Jan 1 00:02:03.535 LOS(loss of signal) 32.768 12.6
Jan 1 00:02:21.007 Showtime 17.472 30.072

Original log

Jan  1 00:01:30.767 ATM0 DSL: Defect: LOM
Jan  1 00:01:30.767 DSL: Defect: LOS LOF: retraining
Jan  1 00:01:30.767 DSL: Received response: 0x41
Jan  1 00:01:31.307 ATM0:atmsar_oam_enqueue_vc,pak = 0x82C78F84
Jan  1 00:01:31.307 atmsar_vc_tx_start(821DF0B4).
Jan  1 00:01:31.307 atmsar_transmit_pak_wrapper: deq(82C78F84). vcd: 1.
Jan  1 00:01:31.307 atmsar_transmit_pak_wrapper : encap = Raw
Jan  1 00:01:31.439 ATM0: vcd = 1, safe_start called from periodic
Jan  1 00:01:32.307 ATM0:atmsar_oam_enqueue_vc,pak = 0x82E43B40
Jan  1 00:01:32.307 atmsar_vc_tx_start(821DF0B4).
Jan  1 00:01:32.307 atmsar_transmit_pak_wrapper: deq(82E43B40). vcd: 1.
Jan  1 00:01:32.307 atmsar_transmit_pak_wrapper : encap = Raw
Jan  1 00:01:32.439 ATM0: vcd = 1, safe_start called from periodic
Jan  1 00:01:33.267  atmsar_atm_lineaction(ATM0): state=0
Jan  1 00:01:33.267 ATM0: atmsar_1a_teardown_vc,vcinfo = 0x82A4BBDC
Jan  1 00:01:33.267  atmsar_1a_teardown_vc(ATM0): vc:1 vpi:0 vci:38
Jan  1 00:01:33.267 DSL: SM: [DMTDSL_SHOWTIME -> DMTDSL_RE_OPEN]
Jan  1 00:01:33.267 DSL: Send ADSL_CLOSE command.
Jan  1 00:01:33.267 DSL(ATM0): Sent command 0x4
Jan  1 00:01:33.795 DSL: Received response: 0x25
Jan  1 00:01:33.795 DSL: Connection closed
Jan  1 00:01:33.795 DSL: SM: [DMTDSL_RE_OPEN -> DMTDSL_DO_OPEN]
Jan  1 00:01:33.795 DSL: Send ADSL_OPEN command.
Jan  1 00:01:33.795 DSL(ATM0): Using subfunction 0x0
Jan  1 00:01:33.795 LOCAL:Max noise margin for power cutoff 31
Jan  1 00:01:33.795 DSL(ATM0): Sent command 0x5
Jan  1 00:01:34.239 Service policy input  policy output  applied on 0/38
Jan  1 00:01:34.239 DBS is not configured for this VC.
Jan  1 00:01:34.243 %LINK-3-UPDOWN: Interface Virtual-Access2, changed state to down
Jan  1 00:01:34.251 %DIALER-6-UNBIND: Interface Vi2 unbound from profile Di0
Jan  1 00:01:35.243 %LINEPROTO-5-UPDOWN: Line protocol on Interface Virtual-Access2, changed state to down
Jan  1 00:01:35.267 %LINK-3-UPDOWN: Interface ATM0, changed state to down
Jan  1 00:01:35.267  atmsar_atm_lineaction(ATM0): state=0
Jan  1 00:01:36.267 %LINEPROTO-5-UPDOWN: Line protocol on Interface ATM0, changed state to down
Jan  1 00:01:36.295 DSL(ATM0): 1: Modem state = 0x8
Jan  1 00:01:38.795 DSL(ATM0): 2: Modem state = 0x8
Jan  1 00:01:39.075 ATM0: atmsar_vc_dlcx
Jan  1 00:01:41.295 DSL(ATM0): 3: Modem state = 0x8
Jan  1 00:01:43.795 DSL(ATM0): 4: Modem state = 0x10
Jan  1 00:01:46.295 DSL(ATM0): 5: Modem state = 0x10
Jan  1 00:01:48.795 DSL(ATM0): 6: Modem state = 0x10
Jan  1 00:01:50.935 DSL: Received response: 0x24
Jan  1 00:01:50.935 DSL: Showtime!
Jan  1 00:01:51.035 DSL(ATM0): Sent command 0x31
Jan  1 00:01:51.035 DSL: Received response: 0x12
Jan  1 00:01:51.035 DSL(ATM0): operation mode 0x0001
Jan  1 00:01:51.035 ATM0 atmsar_update_us_bandwidth(): upstream bw =288 Kbps
Jan  1 00:01:51.035 DSL: SM: [DMTDSL_DO_OPEN -> DMTDSL_SHOWTIME]
Jan  1 00:01:59.075 ATM0: atmsar_vc_dlcx
Jan  1 00:01:59.075 (ATM0)1a_enable: delay activation of vcd=1, vc=0x82A4BBDC
Jan  1 00:01:59.075 atmsar enable ATM0
Jan  1 00:01:59.075 ATM0: atmsar_bringup_interface: Interface and atm_db flags are UP
Jan  1 00:02:01.075 %LINK-3-UPDOWN: Interface ATM0, changed state to up
Jan  1 00:02:01.075  atmsar_atm_lineaction(ATM0): state=4
Jan  1 00:02:02.075 %LINEPROTO-5-UPDOWN: Line protocol on Interface ATM0, changed state to up
Jan  1 00:02:03.535 DSL: Defect: LOS LOF: retraining
Jan  1 00:02:03.535 DSL: Received response: 0x41
Jan  1 00:02:05.599 ATM0: atmsar_1a_setup_vc, vcinfo = 0x82A4BBDC
Jan  1 00:02:05.599 ATM0 atmsar_vc_setup: vcd 1
Jan  1 00:02:05.599 atmsar_setup_cos(ATM0): vc:1 wred_name: max_q:0
Jan  1 00:02:05.599 ATM0: VC setup successful (vcd = 1)
Jan  1 00:02:05.599 ATM0: atmsar_atm_get_stats,vcinfo = 0x0
Jan  1 00:02:06.035  atmsar_atm_lineaction(ATM0): state=0
Jan  1 00:02:06.035 ATM0: atmsar_1a_teardown_vc,vcinfo = 0x82A4BBDC
Jan  1 00:02:06.035  atmsar_1a_teardown_vc(ATM0): vc:1 vpi:0 vci:38
Jan  1 00:02:06.035 DSL: SM: [DMTDSL_SHOWTIME -> DMTDSL_RE_OPEN]
Jan  1 00:02:06.035 DSL: Send ADSL_CLOSE command.
Jan  1 00:02:06.035 DSL(ATM0): Sent command 0x4
Jan  1 00:02:06.563 DSL: Received response: 0x25
Jan  1 00:02:06.563 DSL: Connection closed
Jan  1 00:02:06.563 DSL: SM: [DMTDSL_RE_OPEN -> DMTDSL_DO_OPEN]
Jan  1 00:02:06.563 DSL: Send ADSL_OPEN command.
Jan  1 00:02:06.563 DSL(ATM0): Using subfunction 0x0
Jan  1 00:02:06.563 LOCAL:Max noise margin for power cutoff 31
Jan  1 00:02:06.563 DSL(ATM0): Sent command 0x5
Jan  1 00:02:08.035 %LINK-3-UPDOWN: Interface ATM0, changed state to down
Jan  1 00:02:08.035  atmsar_atm_lineaction(ATM0): state=0
Jan  1 00:02:09.035 %LINEPROTO-5-UPDOWN: Line protocol on Interface ATM0, changed state to down
Jan  1 00:02:09.063 DSL(ATM0): 1: Modem state = 0x8
Jan  1 00:02:09.075 ATM0: atmsar_vc_dlcx
Jan  1 00:02:11.563 DSL(ATM0): 2: Modem state = 0x8
Jan  1 00:02:14.063 DSL(ATM0): 3: Modem state = 0x10
Jan  1 00:02:16.563 DSL(ATM0): 4: Modem state = 0x10
Jan  1 00:02:19.063 DSL(ATM0): 5: Modem state = 0x10
Jan  1 00:02:21.007 DSL: Received response: 0x24
Jan  1 00:02:21.007 DSL: Showtime!
Jan  1 00:02:21.107 DSL(ATM0): Sent command 0x31
Jan  1 00:02:21.107 DSL: Received response: 0x12
Jan  1 00:02:21.107 DSL(ATM0): operation mode 0x0001
Jan  1 00:02:21.107 ATM0 atmsar_update_us_bandwidth(): upstream bw =288 Kbps
Jan  1 00:02:21.107 DSL: SM: [DMTDSL_DO_OPEN -> DMTDSL_SHOWTIME]
Jan  1 00:02:29.075 ATM0: atmsar_vc_dlcx
Jan  1 00:02:29.075 (ATM0)1a_enable: delay activation of vcd=1, vc=0x82A4BBDC
Jan  1 00:02:29.075 atmsar enable ATM0
Jan  1 00:02:29.075 ATM0: atmsar_bringup_interface: Interface and atm_db flags are UP
Jan  1 00:02:31.075 %LINK-3-UPDOWN: Interface ATM0, changed state to up
Jan  1 00:02:31.075  atmsar_atm_lineaction(ATM0): state=4
Jan  1 00:02:32.075 %LINEPROTO-5-UPDOWN: Line protocol on Interface ATM0, changed state to up
Jan  1 00:02:35.455 ATM0: atmsar_1a_setup_vc, vcinfo = 0x82A4BBDC
Jan  1 00:02:35.455 ATM0 atmsar_vc_setup: vcd 1
Jan  1 00:02:35.455 atmsar_setup_cos(ATM0): vc:1 wred_name: max_q:0
Jan  1 00:02:35.455 ATM0: VC setup successful (vcd = 1)
Jan  1 00:02:36.411 %DIALER-6-BIND: Interface Vi2 bound to profile Di0