User Access Verification Password: VARTR001>enable Password: VARTR001#terminal monitor VARTR001#show debug General OS: Modem control/process activation debugging is on Dial on demand: Dial on demand events debugging is on PPP: PPP authentication debugging is on PPP protocol negotiation debugging is on Chat Scripts: Chat scripts activity debugging is on Modem Autoconfig: Modem Configuration Database debugging is on VARTR001#ping 69.215.29.13 Type escape sequence to abort. Sending 5, 100-byte ICMP Echos to 69.215.29.13, timeout is 2 seconds: *Mar 1 04:06:50.101: Modem Registers - IMR:0x0 LED:0x0 RstCntrl:0x0 MSR:0xFF *Mar 1 04:06:50.101: As1 DDR: place call *Mar 1 04:06:50.101: As1 DDR: Dialing cause ip (s=10.70.7.2, d=69.215.29.13) *Mar 1 04:06:50.101: As1 DDR: Attempting to dial 9727464003 *Mar 1 04:06:50.101: CHAT1: Attempting async line dialer script *Mar 1 04:06:50.101: Modem Registers - IMR:0x0 LED:0x0 RstCntrl:0x0 MSR:0xFF *Mar 1 04:06:50.105: CHAT1: Dialing using Modem script: dialnow & System script: dlogin *Mar 1 04:06:50.105: CHAT1: process started *Mar 1 04:06:50.105: CHAT1: Asserting DTR *Mar 1 04:06:50.105: CHAT1: Chat script dialnow started *Mar 1 04:06:50.109: CHAT1: Sending string: AT *Mar 1 04:06:50.109: CHAT1: Expecting string: OK *Mar 1 04:06:50.109: CHAT1: Completed match for expect: OK *Mar 1 04:06:50.113: CHAT1: Sending string: \pATDT\T<9727464003> *Mar 1 04:06:50.366: CHAT1: Expecting string: CONNECT..... Success rate is 0 percent (0/5) VARTR001# *Mar 1 04:07:17.009: Modem 0/0 SCM : in modem state 'Connect' dte = 115200 modulation= V90 protocol = LAPM compression_type = V42Btx_speed = 16800 rx_speed = 41333 *Mar 1 04:07:17.009: CHAT1: Completed match for expect: CONNECT *Mar 1 04:07:17.013: CHAT1: Sending string: \c *Mar 1 04:07:17.013: CHAT1: Chat script dialnow finished, status = Success *Mar 1 04:07:17.013: CHAT1: Chat script dlogin started *Mar 1 04:07:17.013: CHAT1: Expecting string: Login: *Mar 1 04:07:18.027: CHAT1: Completed match for expect: Login: *Mar 1 04:07:18.027: CHAT1: Sending string: uuuuu@truevine.net *Mar 1 04:07:18.031: CHAT1: Expecting string: Password: *Mar 1 04:07:18.147: CHAT1: Completed match for expect: Password: *Mar 1 04:07:18.147: CHAT1: Sending string: pppp12065 *Mar 1 04:07:18.147: CHAT1: Expecting string: PPP *Mar 1 04:07:18.412: CHAT1: Completed match for expect: PPP *Mar 1 04:07:18.412: CHAT1: Chat script dlogin finished, status = Success *Mar 1 04:07:18.412: Modem 0/0 Modi: switching to PPP mode *Mar 1 04:07:18.420: TTY1: no timer type 1 to destroy *Mar 1 04:07:18.420: TTY1: no timer type 0 to destroy *Mar 1 04:07:18.424: TTY1: no timer type 2 to destroy *Mar 1 04:07:20.427: %LINK-3-UPDOWN: Interface Async1, changed state to up *Mar 1 04:07:20.427: As1 DDR: Dialer statechange to up *Mar 1 04:07:20.427: As1 DDR: Dialer call has been placed *Mar 1 04:07:20.427: As1 PPP: Using dialer call direction *Mar 1 04:07:20.427: As1 PPP: Treating connection as a callout *Mar 1 04:07:20.431: As1 PPP: Phase is ESTABLISHING, Active Open *Mar 1 04:07:20.431: Modem 0/0: PPP escape map: Tx map = FFFFFFFF, Rx map = 0 *Mar 1 04:07:20.431: As1 PPP: Authorization required *Mar 1 04:07:20.431: As1 LCP: O CONFREQ [Closed] id 81 len 24 *Mar 1 04:07:20.431: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:20.431: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:20.435: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:20.435: As1 LCP: PFC (0x0702) *Mar 1 04:07:20.435: As1 LCP: ACFC (0x0802) *Mar 1 04:07:20.559: As1 LCP: I CONFREQ [REQsent] id 1 len 14 *Mar 1 04:07:20.559: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:20.559: As1 LCP: PFC (0x0702) *Mar 1 04:07:20.559: As1 LCP: ACFC (0x0802) *Mar 1 04:07:20.563: As1 LCP: O CONFACK [REQsent] id 1 len 14 *Mar 1 04:07:20.563: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:20.563: As1 LCP: PFC (0x0702) *Mar 1 04:07:20.563: As1 LCP: ACFC (0x0802) *Mar 1 04:07:20.563: As1 LCP: I CONFREJ [ACKsent] id 81 len 8 *Mar 1 04:07:20.563: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:20.567: As1 LCP: O CONFREQ [ACKsent] id 82 len 25 *Mar 1 04:07:20.567: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:20.567: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:20.567: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:20.567: As1 LCP: PFC (0x0702) *Mar 1 04:07:20.567: As1 LCP: ACFC (0x0802) *Mar 1 04:07:20.695: As1 LCP: I CONFREJ [ACKsent] id 82 len 9 *Mar 1 04:07:20.695: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:20.699: As1 LCP: O CONFREQ [ACKsent] id 83 len 24 *Mar 1 04:07:20.699: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:20.699: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:20.699: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:20.699: As1 LCP: PFC (0x0702) *Mar 1 04:07:20.699: As1 LCP: ACFC (0x0802) *Mar 1 04:07:21.645: As1 LCP: I CONFREJ [ACKsent] id 83 len 8 *Mar 1 04:07:21.645: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:21.645: As1 LCP: O CONFREQ [ACKsent] id 84 len 25 *Mar 1 04:07:21.649: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:21.649: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:21.649: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:21.649: As1 LCP: PFC (0x0702) *Mar 1 04:07:21.649: As1 LCP: ACFC (0x0802) *Mar 1 04:07:21.773: As1 LCP: I CONFREJ [ACKsent] id 84 len 9 *Mar 1 04:07:21.773: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:21.773: As1 LCP: O CONFREQ [ACKsent] id 85 len 24 *Mar 1 04:07:21.773: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:21.773: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:21.773: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:21.773: As1 LCP: PFC (0x0702) *Mar 1 04:07:21.777: As1 LCP: ACFC (0x0802) *Mar 1 04:07:23.764: As1 LCP: TIMEout: State ACKsent *Mar 1 04:07:23.764: As1 LCP: O CONFREQ [ACKsent] id 86 len 24 *Mar 1 04:07:23.764: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:23.764: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:23.764: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:23.768: As1 LCP: PFC (0x0702) *Mar 1 04:07:23.768: As1 LCP: ACFC (0x0802) *Mar 1 04:07:23.772: As1 LCP: I CONFREJ [ACKsent] id 85 len 8 *Mar 1 04:07:23.772: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:23.772: As1 LCP: ID 85 didn't match 86, discarding packet *Mar 1 04:07:23.865: As1 LCP: I CONFREJ [ACKsent] id 86 len 8 *Mar 1 04:07:23.869: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:23.869: As1 LCP: O CONFREQ [ACKsent] id 87 len 25 *Mar 1 04:07:23.869: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:23.869: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:23.869: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:23.869: As1 LCP: PFC (0x0702) *Mar 1 04:07:23.873: As1 LCP: ACFC (0x0802) *Mar 1 04:07:23.973: As1 LCP: I CONFREJ [ACKsent] id 87 len 9 *Mar 1 04:07:23.973: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:23.973: As1 LCP: O CONFREQ [ACKsent] id 88 len 24 *Mar 1 04:07:23.973: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:23.973: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:23.973: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:23.977: As1 LCP: PFC (0x0702) *Mar 1 04:07:23.977: As1 LCP: ACFC (0x0802) *Mar 1 04:07:24.077: As1 LCP: I CONFREJ [ACKsent] id 88 len 8 *Mar 1 04:07:24.077: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:24.077: As1 LCP: O CONFREQ [ACKsent] id 89 len 25 *Mar 1 04:07:24.077: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:24.077: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:24.081: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:24.081: As1 LCP: PFC (0x0702) *Mar 1 04:07:24.081: As1 LCP: ACFC (0x0802) *Mar 1 04:07:24.185: As1 LCP: I CONFREJ [ACKsent] id 89 len 9 *Mar 1 04:07:24.185: As1 LCP: AuthProto CHAP (0x0305C22305) *Mar 1 04:07:24.185: As1 LCP: O CONFREQ [ACKsent] id 90 len 24 *Mar 1 04:07:24.185: As1 LCP: ACCM 0x000A0000 (0x0206000A0000) *Mar 1 04:07:24.185: As1 LCP: AuthProto PAP (0x0304C023) *Mar 1 04:07:24.189: As1 LCP: MagicNumber 0x0A266FD3 (0x05060A266FD3) *Mar 1 04:07:24.189: As1 LCP: PFC (0x0702) *Mar 1 04:07:24.189: As1 LCP: ACFC (0x0802) *Mar 1 04:07:24.189: As1 LCP: I TERMREQ [ACKsent] id 3 len 4 *Mar 1 04:07:24.189: As1 LCP: O TERMACK [ACKsent] id 3 len 4 *Mar 1 04:07:24.193: Modem 0/0: PPP escape map: Tx map = FFFFFFFF, Rx map = 0 *Mar 1 04:07:24.193: As1 PPP: Authorization required *Mar 1 04:07:26.196: As1 LCP: TIMEout: State REQsent *Mar 1 04:07:26.196: TTY1: Async Int reset: Dropping DTR *Mar 1 04:07:26.196: As1 LCP: State is Listen *Mar 1 04:07:27.138: Modem (0/0) DCD Asserted *Mar 1 04:07:27.358: TTY1: DSR was dropped *Mar 1 04:07:27.358: tty1: Modem: READY->(unknown) *Mar 1 04:07:28.200: %LINK-5-CHANGED: Interface Async1, changed state to reset *Mar 1 04:07:28.200: As1 PPP: Sending Acct Event[Down] id[13] *Mar 1 04:07:28.200: As1 LCP: State is Closed *Mar 1 04:07:28.204: As1 PPP: Phase is DOWN *Mar 1 04:07:28.376: TTY1: dropping DTR, hanging up *Mar 1 04:07:28.376: tty1: Modem: HANGUP->(unknown) *Mar 1 04:07:29.386: TTY1: cleanup pending. Delaying DTR *Mar 1 04:07:30.395: TTY1: cleanup pending. Delaying DTR *Mar 1 04:07:31.197: Modem 0/0 Modi: switching to character mode *Mar 1 04:07:31.201: TTY1: no timer type 0 to destroy *Mar 1 04:07:31.201: TTY1: no timer type 1 to destroy *Mar 1 04:07:31.201: TTY1: no timer type 3 to destroy *Mar 1 04:07:31.201: TTY1: no timer type 4 to destroy *Mar 1 04:07:31.201: TTY1: no timer type 10 to destroy *Mar 1 04:07:31.205: TTY1: no timer type 2 to destroy *Mar 1 04:07:31.205: Async1: allowing modem_process to continue hangup *Mar 1 04:07:32.423: TTY1: restoring DTR *Mar 1 04:07:33.208: %LINK-3-UPDOWN: Interface Async1, changed state to down *Mar 1 04:07:33.428: TTY1: DSR was dropped *Mar 1 04:07:33.428: tty1: Modem: READY->HANGUP *Mar 1 04:07:33.428: TTY1: dropping DTR, hanging up *Mar 1 04:07:33.428: tty1: Modem: HANGUP->IDLE *Mar 1 04:07:35.444: TTY1: restoring DTR *Mar 1 04:07:43.200: As1 DDR: re-enable timeout VARTR001#