I have a problem with a strange delay in phase of ESTABLISHING PPP, exactly 20 seconds and I don't understand it is an error of the configuration of the router or an ISP problem.
If I try the connection with the router as bridge and the PC as client PPPoE the connection it is fast, this makes me believe that the cause is the configuration of the router but I has made a lot of tests and I haven't succeeded in resolving.
Can someone help me?
Regards
Giovanni
from Italy
------------------------------------------------------
Here is a debug PPP Negotiation.
Router(config-if)#
02:13:19: %DIALER-6-BIND: Interface Vi1 bound to profile Di1
02:13:19: Vi1 PPP: Phase is DOWN, Setup
02:13:19: Vi1 PPP: Using dialer call direction
02:13:19: Vi1 PPP: Treating connection as a callout
02:13:19: Vi1 PPP: Phase is ESTABLISHING, Active Open
02:13:19: Vi1 PPP: No remote authentication for call-out
02:13:19: Vi1 LCP: O CONFREQ [Closed] id 1 len 10
02:13:19: Vi1 LCP: MagicNumber 0x120C1548 (0x0506120C1548)
02:13:19: %LINK-3-UPDOWN: Interface Virtual-Access1, changed state to up
02:13:19: Vi1 LCP: I CONFACK [REQsent] id 1 len 10
02:13:19: Vi1 LCP: MagicNumber 0x120C1548 (0x0506120C1548)
******************************************* WHY THIS DELAY ? *********************************
02:13:39: Vi1 LCP: I CONFREQ [ACKrcvd] id 2 len 18
02:13:39: Vi1 LCP: MRU 1492 (0x010405D4)
02:13:39: Vi1 LCP: AuthProto PAP (0x0304C023)
02:13:39: Vi1 LCP: MagicNumber 0x423169BF (0x0506423169BF)
02:13:39: Vi1 LCP: O CONFNAK [ACKrcvd] id 2 len 8
02:13:39: Vi1 LCP: MRU 1500 (0x010405DC)
02:13:39: Vi1 LCP: I CONFREQ [ACKrcvd] id 3 len 18
02:13:39: Vi1 LCP: MRU 1500 (0x010405DC)
02:13:39: Vi1 LCP: AuthProto PAP (0x0304C023)
02:13:39: Vi1 LCP: MagicNumber 0x423169BF (0x0506423169BF)
02:13:39: Vi1 LCP: O CONFACK [ACKrcvd] id 3 len 18
02:13:39: Vi1 LCP: MRU 1500 (0x010405DC)
02:13:39: Vi1 LCP: AuthProto PAP (0x0304C023)
02:13:39: Vi1 LCP: MagicNumber 0x423169BF (0x0506423169BF)
02:13:39: Vi1 LCP: State is Open
02:13:39: Vi1 PPP: Phase is AUTHENTICATING, by the peer
02:13:39: Vi1 PAP: Using hostname from interface PAP
02:13:39: Vi1 PAP: Using password from interface PAP
02:13:39: Vi1 PAP: O AUTH-REQ id 1 len 24 from "aliceadsl"
02:13:39: Vi1 PAP: I AUTH-ACK id 1 len 5
02:13:39: Vi1 PPP: Phase is FORWARDING, Attempting Forward
02:13:39: Vi1 PPP: Queue IPCP code[1] id[1]
02:13:39: Vi1 PPP: Phase is ESTABLISHING, Finish LCP
02:13:39: Vi1 PPP: Phase is UP
02:13:39: Vi1 IPCP: O CONFREQ [Closed] id 1 len 22
02:13:39: Vi1 IPCP: Address 0.0.0.0 (0x030600000000)
02:13:39: Vi1 IPCP: PrimaryDNS 0.0.0.0 (0x810600000000)
02:13:39: Vi1 IPCP: SecondaryDNS 0.0.0.0 (0x830600000000)
02:13:39: Vi1 PPP: Process pending ncp packets
02:13:39: Vi1 IPCP: Redirect packet to Vi1
02:13:39: Vi1 IPCP: I CONFREQ [REQsent] id 1 len 10
02:13:39: Vi1 IPCP: Address 192.168.100.1 (0x0306C0A86401)
02:13:39: Vi1 IPCP: O CONFACK [REQsent] id 1 len 10
02:13:39: Vi1 IPCP: Address 192.168.100.1 (0x0306C0A86401)
02:13:39: Vi1 IPCP: I CONFNAK [ACKsent] id 1 len 22
02:13:39: Vi1 IPCP: Address 82.48.209.243 (0x03065230D1F3)
02:13:39: Vi1 IPCP: PrimaryDNS 85.37.17.8 (0x810655251108)
02:13:39: Vi1 IPCP: SecondaryDNS 151.99.125.1 (0x830697637D01)
02:13:39: Vi1 IPCP: O CONFREQ [ACKsent] id 2 len 22
02:13:39: Vi1 IPCP: Address 82.48.209.243 (0x03065230D1F3)
02:13:39: Vi1 IPCP: PrimaryDNS 85.37.17.8 (0x810655251108)
02:13:39: Vi1 IPCP: SecondaryDNS 151.99.125.1 (0x830697637D01)
02:13:39: Vi1 IPCP: I CONFACK [ACKsent] id 2 len 22
02:13:39: Vi1 IPCP: Address 82.48.209.243 (0x03065230D1F3)
02:13:39: Vi1 IPCP: PrimaryDNS 85.37.17.8 (0x810655251108)
02:13:39: Vi1 IPCP: SecondaryDNS 151.99.125.1 (0x830697637D01)
02:13:39: Vi1 IPCP: State is Open
02:13:39: Di1 IPCP: Install negotiated IP interface address 82.48.209.243
02:13:39: Di1 IPCP: Install route to 192.168.100.1
02:13:39: Vi1 IPCP: Add link info for cef entry 192.168.100.1
02:13:40: %LINEPROTO-5-UPDOWN: Line protocol on Interface Virtual-Access1, changed state to up
Router(config-if)#
------------------------------------------------------
Here is a a running-config
!
version 12.3
no service pad
service timestamps debug uptime
service timestamps log uptime
service password-encryption
!
hostname Router
!
boot-start-marker
boot-end-marker
!
no logging buffered
enable secret 5 ****************
!
username Router password 7 ****************
ip subnet-zero
ip dhcp excluded-address 10.10.10.1
ip name-server 85.37.17.8
ip name-server 151.99.125.1
!
ip dhcp pool CLIENT
import all
network 10.10.10.0 255.255.255.0
default-router 10.10.10.1
lease infinite
!
!
ip inspect name myfw cuseeme timeout 3600
ip inspect name myfw ftp timeout 3600
ip inspect name myfw rcmd timeout 3600
ip inspect name myfw realaudio timeout 3600
ip inspect name myfw smtp timeout 3600
ip inspect name myfw tftp timeout 30
ip inspect name myfw udp timeout 15
ip inspect name myfw tcp timeout 3600
ip inspect name myfw h323 timeout 3600
no aaa new-model
!
!
partition flash 2 6 2
!
!
!
no crypto isakmp enable
!
!
!
interface Ethernet0
ip address 10.10.10.1 255.255.255.0
ip nat inside
ip tcp adjust-mss 1452
no keepalive
hold-queue 100 out
!
interface ATM0
no ip address
atm vc-per-vp 64
no atm ilmi-keepalive
dsl operating-mode auto
pvc 8/35
pppoe-client dial-pool-number 1 dial-on-demand
!
!
interface Dialer1
ip address negotiated
ip access-group 113 in
ip mtu 1492
ip nat outside
ip inspect myfw out
encapsulation ppp
ip tcp adjust-mss 1452
dialer pool 1
dialer idle-timeout 40 either
dialer-group 1
ppp pap sent-username aliceadsl password 7 ****************
ppp ipcp dns request
no cdp enable
!
ip classless
ip route 0.0.0.0 0.0.0.0 Dialer1
ip http server
no ip http secure-server
ip nat inside source list 102 interface Dialer1 overload
!
!
logging 10.10.10.2
access-list 23 permit 10.10.10.0 0.0.0.255
access-list 102 permit ip 10.10.10.0 0.0.0.255 any
access-list 113 permit udp any any eq domain
access-list 113 permit udp any any eq time
access-list 113 permit tcp any any eq domain
access-list 113 permit tcp any any eq nntp log
access-list 113 permit tcp any any eq ftp log
access-list 113 permit tcp any any eq www
access-list 113 permit tcp any any eq smtp log
access-list 113 permit tcp any any eq pop3 log
access-list 113 permit tcp any any eq 37 log
access-list 113 permit udp any any eq netbios-ns log
access-list 113 permit udp any any eq netbios-dgm log
dialer-list 1 protocol ip list 113
snmp-server community public RW
snmp-server enable traps tty
!
control-plane
!
!
line con 0
exec-timeout 120 0
no modem enable
transport preferred all
transport output all
stopbits 1
line aux 0
transport preferred all
transport output all
line vty 0 4
access-class 23 in
exec-timeout 120 0
login local
length 0
transport preferred all
transport input all
transport output all
!
scheduler max-task-time 5000
!
If I try the connection with the router as bridge and the PC as client PPPoE the connection it is fast, this makes me believe that the cause is the configuration of the router but I has made a lot of tests and I haven't succeeded in resolving.
Can someone help me?
Regards
Giovanni
from Italy
------------------------------------------------------
Here is a debug PPP Negotiation.
Router(config-if)#
02:13:19: %DIALER-6-BIND: Interface Vi1 bound to profile Di1
02:13:19: Vi1 PPP: Phase is DOWN, Setup
02:13:19: Vi1 PPP: Using dialer call direction
02:13:19: Vi1 PPP: Treating connection as a callout
02:13:19: Vi1 PPP: Phase is ESTABLISHING, Active Open
02:13:19: Vi1 PPP: No remote authentication for call-out
02:13:19: Vi1 LCP: O CONFREQ [Closed] id 1 len 10
02:13:19: Vi1 LCP: MagicNumber 0x120C1548 (0x0506120C1548)
02:13:19: %LINK-3-UPDOWN: Interface Virtual-Access1, changed state to up
02:13:19: Vi1 LCP: I CONFACK [REQsent] id 1 len 10
02:13:19: Vi1 LCP: MagicNumber 0x120C1548 (0x0506120C1548)
******************************************* WHY THIS DELAY ? *********************************
02:13:39: Vi1 LCP: I CONFREQ [ACKrcvd] id 2 len 18
02:13:39: Vi1 LCP: MRU 1492 (0x010405D4)
02:13:39: Vi1 LCP: AuthProto PAP (0x0304C023)
02:13:39: Vi1 LCP: MagicNumber 0x423169BF (0x0506423169BF)
02:13:39: Vi1 LCP: O CONFNAK [ACKrcvd] id 2 len 8
02:13:39: Vi1 LCP: MRU 1500 (0x010405DC)
02:13:39: Vi1 LCP: I CONFREQ [ACKrcvd] id 3 len 18
02:13:39: Vi1 LCP: MRU 1500 (0x010405DC)
02:13:39: Vi1 LCP: AuthProto PAP (0x0304C023)
02:13:39: Vi1 LCP: MagicNumber 0x423169BF (0x0506423169BF)
02:13:39: Vi1 LCP: O CONFACK [ACKrcvd] id 3 len 18
02:13:39: Vi1 LCP: MRU 1500 (0x010405DC)
02:13:39: Vi1 LCP: AuthProto PAP (0x0304C023)
02:13:39: Vi1 LCP: MagicNumber 0x423169BF (0x0506423169BF)
02:13:39: Vi1 LCP: State is Open
02:13:39: Vi1 PPP: Phase is AUTHENTICATING, by the peer
02:13:39: Vi1 PAP: Using hostname from interface PAP
02:13:39: Vi1 PAP: Using password from interface PAP
02:13:39: Vi1 PAP: O AUTH-REQ id 1 len 24 from "aliceadsl"
02:13:39: Vi1 PAP: I AUTH-ACK id 1 len 5
02:13:39: Vi1 PPP: Phase is FORWARDING, Attempting Forward
02:13:39: Vi1 PPP: Queue IPCP code[1] id[1]
02:13:39: Vi1 PPP: Phase is ESTABLISHING, Finish LCP
02:13:39: Vi1 PPP: Phase is UP
02:13:39: Vi1 IPCP: O CONFREQ [Closed] id 1 len 22
02:13:39: Vi1 IPCP: Address 0.0.0.0 (0x030600000000)
02:13:39: Vi1 IPCP: PrimaryDNS 0.0.0.0 (0x810600000000)
02:13:39: Vi1 IPCP: SecondaryDNS 0.0.0.0 (0x830600000000)
02:13:39: Vi1 PPP: Process pending ncp packets
02:13:39: Vi1 IPCP: Redirect packet to Vi1
02:13:39: Vi1 IPCP: I CONFREQ [REQsent] id 1 len 10
02:13:39: Vi1 IPCP: Address 192.168.100.1 (0x0306C0A86401)
02:13:39: Vi1 IPCP: O CONFACK [REQsent] id 1 len 10
02:13:39: Vi1 IPCP: Address 192.168.100.1 (0x0306C0A86401)
02:13:39: Vi1 IPCP: I CONFNAK [ACKsent] id 1 len 22
02:13:39: Vi1 IPCP: Address 82.48.209.243 (0x03065230D1F3)
02:13:39: Vi1 IPCP: PrimaryDNS 85.37.17.8 (0x810655251108)
02:13:39: Vi1 IPCP: SecondaryDNS 151.99.125.1 (0x830697637D01)
02:13:39: Vi1 IPCP: O CONFREQ [ACKsent] id 2 len 22
02:13:39: Vi1 IPCP: Address 82.48.209.243 (0x03065230D1F3)
02:13:39: Vi1 IPCP: PrimaryDNS 85.37.17.8 (0x810655251108)
02:13:39: Vi1 IPCP: SecondaryDNS 151.99.125.1 (0x830697637D01)
02:13:39: Vi1 IPCP: I CONFACK [ACKsent] id 2 len 22
02:13:39: Vi1 IPCP: Address 82.48.209.243 (0x03065230D1F3)
02:13:39: Vi1 IPCP: PrimaryDNS 85.37.17.8 (0x810655251108)
02:13:39: Vi1 IPCP: SecondaryDNS 151.99.125.1 (0x830697637D01)
02:13:39: Vi1 IPCP: State is Open
02:13:39: Di1 IPCP: Install negotiated IP interface address 82.48.209.243
02:13:39: Di1 IPCP: Install route to 192.168.100.1
02:13:39: Vi1 IPCP: Add link info for cef entry 192.168.100.1
02:13:40: %LINEPROTO-5-UPDOWN: Line protocol on Interface Virtual-Access1, changed state to up
Router(config-if)#
------------------------------------------------------
Here is a a running-config
!
version 12.3
no service pad
service timestamps debug uptime
service timestamps log uptime
service password-encryption
!
hostname Router
!
boot-start-marker
boot-end-marker
!
no logging buffered
enable secret 5 ****************
!
username Router password 7 ****************
ip subnet-zero
ip dhcp excluded-address 10.10.10.1
ip name-server 85.37.17.8
ip name-server 151.99.125.1
!
ip dhcp pool CLIENT
import all
network 10.10.10.0 255.255.255.0
default-router 10.10.10.1
lease infinite
!
!
ip inspect name myfw cuseeme timeout 3600
ip inspect name myfw ftp timeout 3600
ip inspect name myfw rcmd timeout 3600
ip inspect name myfw realaudio timeout 3600
ip inspect name myfw smtp timeout 3600
ip inspect name myfw tftp timeout 30
ip inspect name myfw udp timeout 15
ip inspect name myfw tcp timeout 3600
ip inspect name myfw h323 timeout 3600
no aaa new-model
!
!
partition flash 2 6 2
!
!
!
no crypto isakmp enable
!
!
!
interface Ethernet0
ip address 10.10.10.1 255.255.255.0
ip nat inside
ip tcp adjust-mss 1452
no keepalive
hold-queue 100 out
!
interface ATM0
no ip address
atm vc-per-vp 64
no atm ilmi-keepalive
dsl operating-mode auto
pvc 8/35
pppoe-client dial-pool-number 1 dial-on-demand
!
!
interface Dialer1
ip address negotiated
ip access-group 113 in
ip mtu 1492
ip nat outside
ip inspect myfw out
encapsulation ppp
ip tcp adjust-mss 1452
dialer pool 1
dialer idle-timeout 40 either
dialer-group 1
ppp pap sent-username aliceadsl password 7 ****************
ppp ipcp dns request
no cdp enable
!
ip classless
ip route 0.0.0.0 0.0.0.0 Dialer1
ip http server
no ip http secure-server
ip nat inside source list 102 interface Dialer1 overload
!
!
logging 10.10.10.2
access-list 23 permit 10.10.10.0 0.0.0.255
access-list 102 permit ip 10.10.10.0 0.0.0.255 any
access-list 113 permit udp any any eq domain
access-list 113 permit udp any any eq time
access-list 113 permit tcp any any eq domain
access-list 113 permit tcp any any eq nntp log
access-list 113 permit tcp any any eq ftp log
access-list 113 permit tcp any any eq www
access-list 113 permit tcp any any eq smtp log
access-list 113 permit tcp any any eq pop3 log
access-list 113 permit tcp any any eq 37 log
access-list 113 permit udp any any eq netbios-ns log
access-list 113 permit udp any any eq netbios-dgm log
dialer-list 1 protocol ip list 113
snmp-server community public RW
snmp-server enable traps tty
!
control-plane
!
!
line con 0
exec-timeout 120 0
no modem enable
transport preferred all
transport output all
stopbits 1
line aux 0
transport preferred all
transport output all
line vty 0 4
access-class 23 in
exec-timeout 120 0
login local
length 0
transport preferred all
transport input all
transport output all
!
scheduler max-task-time 5000
!