I want to configure asyn callback in router 2511. IOS version is 12.0(10). Clients are Windows 9x/NT.
I call the RAS and get authentication, after router received callback number from client, the call hang up but there isnt callback. The router cannot initiate callback function properly.
Here is the debug:
As1 MCB: Initiate Callback for callback at 0913214108 using Async
As1 MCB: Async-callback failed
TTY1: DSR was dropped
Any one help me, please
-----------
The configuration is below:
version 12.0
service password-encryption
!
hostname Router
!
boot system flash
enable secret 5 $1$XpI9$5zIQu14lpRMz53STOwOHy1
!
username back callback-dialstring "" callback-line 1 password ok
ip subnet-zero
ip domain-name hnpt.com
ip name-server 10.10.24.4
chat-script resetModem "" "atz" OK "at&s0=1" OK
chat-script startModem "" "atz" OK "at&s0=1" OK
chat-script callback ABORT ERROR ABORT BUSY "" "AT" OK "ATDT \T" TIMEOUT 45 CONNECT \c
chat-script offhook "" "ATH1" OK \c
!
interface Ethernet0
ip address 10.10.24.1 255.255.254.0
no ip directed-broadcast
no ip route-cache
!
interface Async1
ip unnumbered Ethernet0
no ip directed-broadcast
ip mtu 512
encapsulation ppp
no ip route-cache
ip tcp header-compression passive
no ip mroute-cache
async default routing
async mode dedicated
peer default ip address pool local-pool
ppp callback accept
ppp authentication pap callin
!
ip local pool local-pool 10.10.24.238 10.10.24.254
ip default-gateway 10.10.24.2
no ip classless
!
line con 0
transport input none
line 1
session-timeout 5
autoselect during-login
script startup startModem
script modem-off-hook offhook
script callback callback
login local
modem answer-timeout 3
modem autoconfigure type usr_sportster
modem InOut
transport input all
autohangup
callback forced-wait 10
speed 115200
flowcontrol hardware
!
--------------
I debug some output:
General OS:
Modem control/process activation debugging is on
PPP authentication debugging is on
PPP protocol negotiation debugging is on
Chat scripts activity debugging is on
Callback activity debugging is on
And the result is:
1d22h: TTY1: DSR came up
1d22h: TTY1: destroy timer type 1
1d22h: TTY1: destroy timer type 0
1d22h: TTY1: create timer type 2, 300 seconds
1d22h: tty1: Modem: IDLE->READY
1d22h: As1 LCP: I CONFREQ [Closed] id 0 len 23
1d22h: As1 LCP: ACCM 0x00000000 (0x020600000000)
1d22h: As1 LCP: MagicNumber 0x00002477 (0x050600002477)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: Callback 6 (0x0D0306)
1d22h: As1 LCP: Lower layer not up, Fast Starting
1d22h: As1 PPP: Treating connection as a dedicated line
1d22h: As1 PPP: Phase is ESTABLISHING, Active Open
1d22h: As1 LCP: O CONFREQ [Closed] id 44 len 24
1d22h: As1 LCP: ACCM 0x000A0000 (0x0206000A0000)
1d22h: As1 LCP: AuthProto PAP (0x0304C023)
1d22h: As1 LCP: MagicNumber 0x1A7AD1B6 (0x05061A7AD1B6)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: O CONFACK [REQsent] id 0 len 23
1d22h: As1 LCP: ACCM 0x00000000 (0x020600000000)
1d22h: As1 LCP: MagicNumber 0x00002477 (0x050600002477)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: Callback 6 (0x0D0306)
*Mar 2 22:35:00: %LINK-3-UPDOWN: Interface Async1, changed state to up
1d22h: As1 LCP: I CONFACK [ACKsent] id 44 len 24
1d22h: As1 LCP: ACCM 0x000A0000 (0x0206000A0000)
1d22h: As1 LCP: AuthProto PAP (0x0304C023)
1d22h: As1 LCP: MagicNumber 0x1A7AD1B6 (0x05061A7AD1B6)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: State is Open
1d22h: As1 PPP: Phase is AUTHENTICATING, by this end
1d22h: As1 LCP: I IDENTIFY [Open] id 1 len 18 magic 0x00002477 MSRASV4.00
1d22h: As1 LCP: I IDENTIFY [Open] id 2 len 20 magic 0x00002477 MSRAS-1-KING
1d22h: As1 PAP: I AUTH-REQ id 22 len 22 from "callback"
1d22h: As1 PAP: Authenticating peer callback
1d22h: As1 PAP: O AUTH-ACK id 22 len 5
1d22h: As1 MCB: User callback Callback Number - Client ANY
1d22h: Async1 PPP: O MCB Request(1) id 208 len 9
1d22h: Async1 MCB: O 1 D0 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 208 Callback Type Client-Num delay 0
1d22h: As1 PPP: Phase is CBCP
*Mar 2 22:35:01: %LINEPROTO-5-UPDOWN: Line protocol on Interface Async1, change
d state to up
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 209 len 9
1d22h: Async1 MCB: O 1 D1 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 209 Callback Type Client-Num delay 0
1d22h: TTY16: autoconfigure probe started
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 210 len 9
1d22h: Async1 MCB: O 1 D2 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 210 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 211 len 9
1d22h: Async1 MCB: O 1 D3 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 211 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 212 len 9
1d22h: Async1 MCB: O 1 D4 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 212 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 213 len 9
1d22h: Async1 MCB: O 1 D5 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 213 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 214 len 9
1d22h: Async1 MCB: O 1 D6 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 214 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 215 len 9
1d22h: Async1 MCB: O 1 D7 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 215 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 216 len 9
1d22h: Async1 MCB: O 1 D8 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 216 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 217 len 9
1d22h: Async1 MCB: O 1 D9 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 217 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 218 len 9
1d22h: Async1 MCB: O 1 DA 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 218 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 219 len 9
1d22h: Async1 MCB: O 1 DB 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 219 Callback Type Client-Num delay 0
1d22h: Async1 PPP: I MCB Response(2) id 219 len 19
1d22h: Async1 MCB: I 2 DB 0 13 2 F C 1 30 39 31 33 32 31 34 31
30 38 0
1d22h: As1 MCB: Received response
1d22h: As1 MCB: Response CBK-Client-Num 2 15 12, addr 1-0913214108
1d22h: Async1 PPP: O MCB Ack(3) id 220 len 19
1d22h: Async1 MCB: O 3 DC 0 13 2 F C 1 30 39 31 33 32 31 34 31
30 38 0
1d22h: As1 MCB: O Ack Id 220 Callback Type Client-Num delay 12
1d22h: As1 MCB: Negotiated MCB with peer
1d22h: As1 LCP: I TERMREQ [Open] id 3 len 8 (0x00000000)
1d22h: As1 LCP: O TERMACK [Open] id 3 len 4
1d22h: As1 MCB: Peer terminating the link
1d22h: As1 PPP: Phase is TERMINATING
1d22h: As1 MCB: Link terminated by peer, Callback Needed
1d22h: As1 MCB: Initiate Callback for callback at 0913214108 using Async
1d22h: As1 MCB: Async-callback failed
===== > ERROR CODE HERE
1d22h: TTY1: DSR was dropped
1d22h: tty1: Modem: READY->HANGUP
*Mar 2 22:35:25: %LINEPROTO-5-UPDOWN: Line protocol on Interface Async1, change
d state to down
1d22h: TTY1: dropping DTR, hanging up
1d22h: TTY1: Async Int reset: Dropping DTR
1d22h: tty1: Modem: HANGUP->IDLE
1d22h: As1 LCP: TIMEout: State TERMsent
1d22h: As1 LCP: State is Closed
1d22h: As1 PPP: Phase is DOWN
1d22h: As1 PPP: Phase is ESTABLISHING, Passive Open
1d22h: As1 LCP: State is Listen
1d22h: TTY1: cleanup pending. Delaying DTR
*Mar 2 22:35:28: %LINK-5-CHANGED: Interface Async1, changed state to reset
1d22h: As1 LCP: State is Closed
1d22h: As1 PPP: Phase is DOWN
1d22h: TTY1: cleanup pending. Delaying DTR
1d22h: TTY1: cleanup pending. Delaying DTR
1d22h: TTY1: cleanup pending. Delaying DTR
1d22h: TTY16: autoconfigure probe started
1d22h: TTY1: destroy timer type 0
1d22h: TTY1: destroy timer type 1
1d22h: TTY1: destroy timer type 3
1d22h: TTY1: destroy timer type 4
1d22h: TTY1: destroy timer type 2 (OK)
1d22h: Async1: allowing modem_process to continue hangup
1d22h: TTY1: restoring DTR
*Mar 2 22:35:33: %LINK-3-UPDOWN: Interface Async1, changed state to down
1d22h: As1 LCP: State is Closed
1d22h: As1 PPP: Phase is DOWN
Any one help me, please
Thank you
Tiger@ptic.com.vn
I call the RAS and get authentication, after router received callback number from client, the call hang up but there isnt callback. The router cannot initiate callback function properly.
Here is the debug:
As1 MCB: Initiate Callback for callback at 0913214108 using Async
As1 MCB: Async-callback failed
TTY1: DSR was dropped
Any one help me, please
-----------
The configuration is below:
version 12.0
service password-encryption
!
hostname Router
!
boot system flash
enable secret 5 $1$XpI9$5zIQu14lpRMz53STOwOHy1
!
username back callback-dialstring "" callback-line 1 password ok
ip subnet-zero
ip domain-name hnpt.com
ip name-server 10.10.24.4
chat-script resetModem "" "atz" OK "at&s0=1" OK
chat-script startModem "" "atz" OK "at&s0=1" OK
chat-script callback ABORT ERROR ABORT BUSY "" "AT" OK "ATDT \T" TIMEOUT 45 CONNECT \c
chat-script offhook "" "ATH1" OK \c
!
interface Ethernet0
ip address 10.10.24.1 255.255.254.0
no ip directed-broadcast
no ip route-cache
!
interface Async1
ip unnumbered Ethernet0
no ip directed-broadcast
ip mtu 512
encapsulation ppp
no ip route-cache
ip tcp header-compression passive
no ip mroute-cache
async default routing
async mode dedicated
peer default ip address pool local-pool
ppp callback accept
ppp authentication pap callin
!
ip local pool local-pool 10.10.24.238 10.10.24.254
ip default-gateway 10.10.24.2
no ip classless
!
line con 0
transport input none
line 1
session-timeout 5
autoselect during-login
script startup startModem
script modem-off-hook offhook
script callback callback
login local
modem answer-timeout 3
modem autoconfigure type usr_sportster
modem InOut
transport input all
autohangup
callback forced-wait 10
speed 115200
flowcontrol hardware
!
--------------
I debug some output:
General OS:
Modem control/process activation debugging is on
PPP authentication debugging is on
PPP protocol negotiation debugging is on
Chat scripts activity debugging is on
Callback activity debugging is on
And the result is:
1d22h: TTY1: DSR came up
1d22h: TTY1: destroy timer type 1
1d22h: TTY1: destroy timer type 0
1d22h: TTY1: create timer type 2, 300 seconds
1d22h: tty1: Modem: IDLE->READY
1d22h: As1 LCP: I CONFREQ [Closed] id 0 len 23
1d22h: As1 LCP: ACCM 0x00000000 (0x020600000000)
1d22h: As1 LCP: MagicNumber 0x00002477 (0x050600002477)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: Callback 6 (0x0D0306)
1d22h: As1 LCP: Lower layer not up, Fast Starting
1d22h: As1 PPP: Treating connection as a dedicated line
1d22h: As1 PPP: Phase is ESTABLISHING, Active Open
1d22h: As1 LCP: O CONFREQ [Closed] id 44 len 24
1d22h: As1 LCP: ACCM 0x000A0000 (0x0206000A0000)
1d22h: As1 LCP: AuthProto PAP (0x0304C023)
1d22h: As1 LCP: MagicNumber 0x1A7AD1B6 (0x05061A7AD1B6)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: O CONFACK [REQsent] id 0 len 23
1d22h: As1 LCP: ACCM 0x00000000 (0x020600000000)
1d22h: As1 LCP: MagicNumber 0x00002477 (0x050600002477)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: Callback 6 (0x0D0306)
*Mar 2 22:35:00: %LINK-3-UPDOWN: Interface Async1, changed state to up
1d22h: As1 LCP: I CONFACK [ACKsent] id 44 len 24
1d22h: As1 LCP: ACCM 0x000A0000 (0x0206000A0000)
1d22h: As1 LCP: AuthProto PAP (0x0304C023)
1d22h: As1 LCP: MagicNumber 0x1A7AD1B6 (0x05061A7AD1B6)
1d22h: As1 LCP: PFC (0x0702)
1d22h: As1 LCP: ACFC (0x0802)
1d22h: As1 LCP: State is Open
1d22h: As1 PPP: Phase is AUTHENTICATING, by this end
1d22h: As1 LCP: I IDENTIFY [Open] id 1 len 18 magic 0x00002477 MSRASV4.00
1d22h: As1 LCP: I IDENTIFY [Open] id 2 len 20 magic 0x00002477 MSRAS-1-KING
1d22h: As1 PAP: I AUTH-REQ id 22 len 22 from "callback"
1d22h: As1 PAP: Authenticating peer callback
1d22h: As1 PAP: O AUTH-ACK id 22 len 5
1d22h: As1 MCB: User callback Callback Number - Client ANY
1d22h: Async1 PPP: O MCB Request(1) id 208 len 9
1d22h: Async1 MCB: O 1 D0 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 208 Callback Type Client-Num delay 0
1d22h: As1 PPP: Phase is CBCP
*Mar 2 22:35:01: %LINEPROTO-5-UPDOWN: Line protocol on Interface Async1, change
d state to up
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 209 len 9
1d22h: Async1 MCB: O 1 D1 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 209 Callback Type Client-Num delay 0
1d22h: TTY16: autoconfigure probe started
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 210 len 9
1d22h: Async1 MCB: O 1 D2 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 210 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 211 len 9
1d22h: Async1 MCB: O 1 D3 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 211 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 212 len 9
1d22h: Async1 MCB: O 1 D4 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 212 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 213 len 9
1d22h: Async1 MCB: O 1 D5 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 213 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 214 len 9
1d22h: Async1 MCB: O 1 D6 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 214 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 215 len 9
1d22h: Async1 MCB: O 1 D7 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 215 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 216 len 9
1d22h: Async1 MCB: O 1 D8 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 216 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 217 len 9
1d22h: Async1 MCB: O 1 D9 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 217 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 218 len 9
1d22h: Async1 MCB: O 1 DA 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 218 Callback Type Client-Num delay 0
1d22h: As1 MCB: Timeout in state WAIT_RESPONSE
1d22h: Async1 PPP: O MCB Request(1) id 219 len 9
1d22h: Async1 MCB: O 1 DB 0 9 2 5 0 1 0
1d22h: As1 MCB: O Request Id 219 Callback Type Client-Num delay 0
1d22h: Async1 PPP: I MCB Response(2) id 219 len 19
1d22h: Async1 MCB: I 2 DB 0 13 2 F C 1 30 39 31 33 32 31 34 31
30 38 0
1d22h: As1 MCB: Received response
1d22h: As1 MCB: Response CBK-Client-Num 2 15 12, addr 1-0913214108
1d22h: Async1 PPP: O MCB Ack(3) id 220 len 19
1d22h: Async1 MCB: O 3 DC 0 13 2 F C 1 30 39 31 33 32 31 34 31
30 38 0
1d22h: As1 MCB: O Ack Id 220 Callback Type Client-Num delay 12
1d22h: As1 MCB: Negotiated MCB with peer
1d22h: As1 LCP: I TERMREQ [Open] id 3 len 8 (0x00000000)
1d22h: As1 LCP: O TERMACK [Open] id 3 len 4
1d22h: As1 MCB: Peer terminating the link
1d22h: As1 PPP: Phase is TERMINATING
1d22h: As1 MCB: Link terminated by peer, Callback Needed
1d22h: As1 MCB: Initiate Callback for callback at 0913214108 using Async
1d22h: As1 MCB: Async-callback failed
===== > ERROR CODE HERE
1d22h: TTY1: DSR was dropped
1d22h: tty1: Modem: READY->HANGUP
*Mar 2 22:35:25: %LINEPROTO-5-UPDOWN: Line protocol on Interface Async1, change
d state to down
1d22h: TTY1: dropping DTR, hanging up
1d22h: TTY1: Async Int reset: Dropping DTR
1d22h: tty1: Modem: HANGUP->IDLE
1d22h: As1 LCP: TIMEout: State TERMsent
1d22h: As1 LCP: State is Closed
1d22h: As1 PPP: Phase is DOWN
1d22h: As1 PPP: Phase is ESTABLISHING, Passive Open
1d22h: As1 LCP: State is Listen
1d22h: TTY1: cleanup pending. Delaying DTR
*Mar 2 22:35:28: %LINK-5-CHANGED: Interface Async1, changed state to reset
1d22h: As1 LCP: State is Closed
1d22h: As1 PPP: Phase is DOWN
1d22h: TTY1: cleanup pending. Delaying DTR
1d22h: TTY1: cleanup pending. Delaying DTR
1d22h: TTY1: cleanup pending. Delaying DTR
1d22h: TTY16: autoconfigure probe started
1d22h: TTY1: destroy timer type 0
1d22h: TTY1: destroy timer type 1
1d22h: TTY1: destroy timer type 3
1d22h: TTY1: destroy timer type 4
1d22h: TTY1: destroy timer type 2 (OK)
1d22h: Async1: allowing modem_process to continue hangup
1d22h: TTY1: restoring DTR
*Mar 2 22:35:33: %LINK-3-UPDOWN: Interface Async1, changed state to down
1d22h: As1 LCP: State is Closed
1d22h: As1 PPP: Phase is DOWN
Any one help me, please
Thank you
Tiger@ptic.com.vn