Big Issue with PPPOE Dialing (can't connect to my ISP)

[Oreste]

Hello everybody

I have a big issue since I m running oleg's firmware. PPPOE is very instable and I cant connect to my ISP anymore. Here the probleme :

I have a Speedtouch 510v4 and I before that with my wl500gp and the original asus firmware I had no issue everything worked fine except sometimes I lost the connection but nothing major.

I decided to install Oleg firmware (last version) and when I tried to connect to my ISP it didnt work so i thought it was the speedtouch modem. I did a firmware update and switch the modem to bridge mode with dhcp activated.

I reconnect my WL500gp (with oleg firmware) and it connected to the ISP. GREAT it was working !!!

But yesterday i just changed one parameter (it was the server for the time synchornization) and I rebooted the asus and since that time i cant connect anymore same problem occured (no dialing).

I tried to reboot many times modem and router. and the "connect" and "disconnect" buttons the in webif have no effects

Here my system log (just the end otherwise thread is too long for posting)

Dec 31 13:00:03 kernel: PCI: Enabling device 01:02.0 (0004 -> 0006)
Dec 31 13:00:03 kernel: 2.11 Wireless Controller 4.150.10.16
Dec 31 13:00:03 kernel: device eth0 entered promiscuous mode
Dec 31 13:00:03 kernel: device vlan0 entered promiscuous mode
Dec 31 13:00:03 kernel: device eth1 entered promiscuous mode
Dec 31 13:00:03 kernel: br0: port 2(eth1) entering listening state
Dec 31 13:00:03 kernel: br0: port 1(vlan0) entering listening state
Dec 31 13:00:03 kernel: br0: port 2(eth1) entering learning state
Dec 31 13:00:03 kernel: br0: port 2(eth1) entering forwarding state
Dec 31 13:00:03 kernel: br0: topology change detected, propagating
Dec 31 13:00:03 kernel: br0: port 1(vlan0) entering learning state
Dec 31 13:00:03 kernel: br0: port 1(vlan0) entering forwarding state
Dec 31 13:00:03 kernel: br0: topology change detected, propagating
Dec 31 13:00:03 dnsmasq[74]: started, version 2.22 cachesize 150
Dec 31 13:00:03 dnsmasq[74]: DHCP, IP range 192.168.1.2 -- 192.168.1.254, lease time 24h
Dec 31 13:00:03 dnsmasq[74]: DHCP, /tmp/dnsmasq.log will be written every 8h
Dec 31 13:00:03 dnsmasq[74]: read /etc/hosts - 5 addresses
Dec 31 13:00:03 dnsmasq[74]: reading /tmp/resolv.conf
Dec 31 13:00:04 kernel: usb.c: registered new driver usbdevfs
Dec 31 13:00:04 kernel: usb.c: registered new driver hub
Dec 31 13:00:04 kernel: usb-uhci.c: $Revision: 1.275 $ time 20:50:46 Mar 17 2008
Dec 31 13:00:04 kernel: usb-uhci.c: High bandwidth mode enabled
Dec 31 13:00:04 kernel: PCI: Enabling device 01:03.0 (0000 -> 0001)
Dec 31 13:00:04 kernel: ECHI PCI device 30381106 found.
Dec 31 13:00:04 kernel: UCHI reg 0x41 = 10
Dec 31 13:00:04 kernel: UCHI reg 0x41 changed to = 0
Dec 31 13:00:04 kernel: usb-uhci.c: USB UHCI at I/O 0x100, IRQ 12
Dec 31 13:00:04 kernel: usb-uhci.c: Detected 2 ports
Dec 31 13:00:04 kernel: usb.c: new USB bus registered, assigned bus number 1
Dec 31 13:00:04 kernel: hub.c: USB hub found
Dec 31 13:00:04 kernel: hub.c: 2 ports detected
Dec 31 13:00:04 kernel: PCI: Enabling device 01:03.1 (0000 -> 0001)
Dec 31 13:00:04 kernel: ECHI PCI device 30381106 found.
Dec 31 13:00:04 kernel: UCHI reg 0x41 = 10
Dec 31 13:00:04 kernel: UCHI reg 0x41 changed to = 0
Dec 31 13:00:04 kernel: usb-uhci.c: USB UHCI at I/O 0x120, IRQ 12
Dec 31 13:00:04 kernel: usb-uhci.c: Detected 2 ports
Dec 31 13:00:04 kernel: usb.c: new USB bus registered, assigned bus number 2
Dec 31 13:00:04 kernel: hub.c: USB hub found
Dec 31 13:00:04 kernel: hub.c: 2 ports detected
Dec 31 13:00:04 kernel: usb-uhci.c: v1.275:USB Universal Host Controller Interface driver
Dec 31 13:00:04 kernel: PCI: Enabling device 01:03.2 (0000 -> 0002)
Dec 31 13:00:04 kernel: ehci_hcd 01:03.2: PCI device 1106:3104
Dec 31 13:00:04 kernel: ehci_hcd 01:03.2: irq 12, pci mem c011c000
Dec 31 13:00:04 kernel: usb.c: new USB bus registered, assigned bus number 3
Dec 31 13:00:04 kernel: ECHI PCI device 31041106 found.
Dec 31 13:00:04 kernel: ECHI reg 0x49 = 80010f20
Dec 31 13:00:04 kernel: ECHI reg 0x49 changed to = 80010f00
Dec 31 13:00:04 kernel: ECHI reg 0x4b = 80010f09
Dec 31 13:00:04 kernel: ECHI reg 0x4b changed to = 80010f29
Dec 31 13:00:04 kernel: PCI: 01:03.2 PCI cache line size set incorrectly (0 bytes) by BIOS/FW, correcting to 32
Dec 31 13:00:04 kernel: ehci_hcd 01:03.2: USB 2.0 enabled, EHCI 1.00, driver 2003-Dec-29/2.4
Dec 31 13:00:04 kernel: hub.c: USB hub found
Dec 31 13:00:04 kernel: hub.c: 4 ports detected
Dec 31 13:00:04 kernel: usb.c: registered new driver usblp
Dec 31 13:00:04 kernel: printer.c: v0.13: USB Printer Device Class driver
Dec 31 13:00:05 kernel: hub.c: connect-debounce failed, port 2 disabled
Dec 31 13:00:05 kernel: hub.c: new USB device 01:03.2-2, assigned address 2
Dec 31 13:00:05 kernel: usb.c: USB device 2 (vend/prod 0xea0/0x2168) is not claimed by any active driver.
Dec 31 13:00:06 kernel: usb.c: registered new driver audio
Dec 31 13:00:06 kernel: audio.c: v1.0.0:USB Audio Class driver
Dec 31 13:00:06 kernel: SCSI subsystem driver Revision: 1.00
Dec 31 13:00:06 kernel: Initializing USB Mass Storage driver...
Dec 31 13:00:06 kernel: usb.c: registered new driver usb-storage
Dec 31 13:00:06 kernel: scsi0 : SCSI emulation for USB Mass Storage devices
Dec 31 13:00:06 kernel:   Vendor: Generic   Model: USB Flash Disk    Rev: 2.00
Dec 31 13:00:06 kernel:   Type:   Direct-Access                      ANSI SCSI revision: 02
Dec 31 13:00:06 kernel: Attached scsi removable disk sda at scsi0, channel 0, id 0, lun 0
Dec 31 13:00:06 kernel: sda : READ CAPACITY failed.
Dec 31 13:00:06 kernel: sda : status = 1, message = 00, host = 0, driver = 08 
Dec 31 13:00:06 kernel: Current sd00:00: sns = 70  6
Dec 31 13:00:06 kernel: ASC=28 ASCQ= 0
Dec 31 13:00:06 kernel: Raw sense data:0x70 0x00 0x06 0x00 0x00 0x00 0x00 0x0a 0x00 0x00 0x00 0x00 0x28 0x00 0x00 0x00 0x00 0x00 
Dec 31 13:00:06 kernel: sda : block size assumed to be 512 bytes, disk size 1GB.  
Dec 31 13:00:06 kernel: Partition check:
Dec 31 13:00:07 kernel:  I/O error: dev 08:00, sector 0
Dec 31 13:00:07 kernel:  I/O error: dev 08:00, sector 0
Dec 31 13:00:07 kernel:  unable to read partition table
Dec 31 13:00:07 kernel: USB Mass Storage support registered.
Dec 31 13:00:07 kernel: vlan1: Setting MAC address to  00 1b fc e2 9b 83.
Dec 31 13:00:07 kernel: VLAN (vlan1):  Underlying device (eth0) has same MAC, not checking promiscious mode.
Dec 31 13:00:07 udhcpc[99]: udhcpc (v0.9.9-pre) started
Dec 31 13:00:07 dhcp client: deconfig: lease is lost
Dec 31 13:00:12 dnsmasq[74]: DHCPREQUEST(br0) 192.168.1.252 00:1a:4d:4b:8b:48
Dec 31 13:00:12 dnsmasq[74]: DHCPNAK(br0) 192.168.1.252 00:1a:4d:4b:8b:48 lease not found
Dec 31 13:00:15 dnsmasq[74]: DHCPDISCOVER(br0) 00:1a:4d:4b:8b:48
Dec 31 13:00:15 dnsmasq[74]: DHCPOFFER(br0) 192.168.1.252 00:1a:4d:4b:8b:48
Dec 31 13:00:15 dnsmasq[74]: DHCPREQUEST(br0) 192.168.1.252 00:1a:4d:4b:8b:48
Dec 31 13:00:15 dnsmasq[74]: DHCPACK(br0) 192.168.1.252 00:1a:4d:4b:8b:48 cyril-desktop
Dec 31 13:00:22 udhcpc[99]: No lease, forking to background.
Dec 31 13:00:22 pppd[103]: Plugin rp-pppoe.so loaded.
Dec 31 13:00:22 pppd[103]: RP-PPPoE plugin version 3.3 compiled against pppd 2.4.2
Dec 31 13:00:22 pppd[105]: pppd 2.4.2 started by admin, uid 0
Dec 31 13:00:22 pppd[105]: Using interface ppp0
Dec 31 13:00:22 pppd[105]: local  IP address 10.64.64.64
Dec 31 13:00:22 pppd[105]: remote IP address 10.112.112.112
Dec 31 13:00:34 kernel: SCSI device sda: 1023488 512-byte hdwr sectors (524 MB)
Dec 31 13:00:34 kernel: sda: Write Protect is off
Dec 31 13:00:34 kernel:  p1 p2
Dec 31 13:00:34 kernel: kjournald starting.  Commit interval 5 seconds
Dec 31 13:00:34 kernel: EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
Dec 31 13:00:34 kernel: EXT3 FS 2.4-0.9.19, 19 August 2002 on sd(8,1), internal journal
Dec 31 13:00:34 kernel: EXT3-fs: recovery complete.
Dec 31 13:00:34 kernel: EXT3-fs: mounted filesystem with ordered data mode.
Dec 31 13:00:34 USB storage: ext3 fs at /dev/discs/disc0/part1 mounted to /tmp/mnt/disc0_1
Dec 31 13:00:51 udhcpc[104]: Lease of 192.168.1.64 obtained, lease time 86400
Dec 31 13:00:51 dnsmasq[74]: read /etc/hosts - 5 addresses
Dec 31 13:00:51 dnsmasq[74]: reading /tmp/resolv.conf
Dec 31 13:00:51 dnsmasq[74]: using nameserver 192.168.1.254#53
Dec 31 13:00:51 dhcp client: bound IP : 192.168.1.64 from 10.0.0.138

The probleme seems to be here. Nothing never happens after here and when it worked i had some information about dialing...

Dec 31 13:07:00 pppd[229]: pppd 2.4.2 started by admin, uid 0
Dec 31 13:07:00 pppd[229]: Using interface ppp0
Dec 31 13:07:00 pppd[229]: local IP address 10.64.64.64
Dec 31 13:07:00 pppd[229]: remote IP address 10.112.112.112

It would be great if someone could help with this problem

Thanks a lot

PS : sorry for my english, i m french

[wrc4]

So I'm sticking with the ASUS firmware for now.

[al37919]

According to http://wl500g.info/showthread.php?t=14007 try to set PPPoE Idle Disconnect Time to 0

[Oreste]

Thx a lot al37919 ! It works now !