|
||||||||
I have a problem with mono 1.0 running on a generic PC. *Establishing the pppoe connection takes hours and hours.* After tons and tons of retries - mono gets online and start to route packets correctly to the Internet. However, using the same modem/same ADSL line with a win XP machine works like a charm. One thing is worth to be noted. As a modem, I'm using a router ZyXEL 642R in bridge mode (RFC1483). Following is the mpd/pppoe log related to a typical unsuccesfull attempt to establish a connection: ***start*** Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] opening link "pppoe"... Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] link: OPEN event Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: Open event Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: state change Initial --> Starting Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: LayerStart Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] device: OPEN event in state DOWN Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] device is now in state OPENING Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] rec'd ACNAME "r-ve056" Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] rec'd command 11 from "[4b]:" Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] rec'd proto LCP while dead Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] connection successful Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] device: UP event in state OPENING Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] device is now in state UP Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] link: UP event Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] link: origination is local Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: Up event Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: state change Starting --> Req-Sent Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: phase shift DEAD --> ESTABLISH Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: SendConfigReq #34 Jun 19 00:04:02 scaffandro.entropy.org mpd: MRU 1492 Jun 19 00:04:02 scaffandro.entropy.org mpd: MAGICNUM 59b03ecc Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: rec'd Configure Ack #34 link 0 (Req-Sent) Jun 19 00:04:02 scaffandro.entropy.org mpd: MRU 1492 Jun 19 00:04:02 scaffandro.entropy.org mpd: MAGICNUM 59b03ecc Jun 19 00:04:02 scaffandro.entropy.org mpd: [pppoe] LCP: state change Req-Sent --> Ack-Rcvd Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: rec'd Configure Request #2 link 0 (Ack-Rcvd) Jun 19 00:04:22 scaffandro.entropy.org mpd: MRU 1492 Jun 19 00:04:22 scaffandro.entropy.org mpd: AUTHPROTO PAP Jun 19 00:04:22 scaffandro.entropy.org mpd: MAGICNUM 5561bdf6 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: SendConfigAck #2 Jun 19 00:04:22 scaffandro.entropy.org mpd: MRU 1492 Jun 19 00:04:22 scaffandro.entropy.org mpd: AUTHPROTO PAP Jun 19 00:04:22 scaffandro.entropy.org mpd: MAGICNUM 5561bdf6 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: state change Ack-Rcvd --> Opened Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: phase shift ESTABLISH --> AUTHENTICATE Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: auth: peer wants PAP, I want nothing Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] PAP: using authname mylogin at myisp dot it Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] PAP: sending REQUEST Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: LayerUp Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] PAP: rec'd ACK #1 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: authorization successful Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] LCP: phase shift AUTHENTICATE --> NETWORK Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] setting interface ng0 MTU to 1492 bytes Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] up: 1 link, total bandwidth 64000 bps Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: Up event Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: state change Starting --> Req-Sent Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: SendConfigReq #100 Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 0.0.0.0 Jun 19 00:04:22 scaffandro.entropy.org mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: rec'd Configure Request #1 link 0 (Req-Sent) Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 192.168.100.1 Jun 19 00:04:22 scaffandro.entropy.org mpd: 192.168.100.1 is OK Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: SendConfigAck #1 Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 192.168.100.1 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: state change Req-Sent --> Ack-Sent Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: rec'd Configure Reject #100 link 0 (Ack-Sent) Jun 19 00:04:22 scaffandro.entropy.org mpd: COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: SendConfigReq #101 Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 0.0.0.0 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: rec'd Configure Nak #101 link 0 (Ack-Sent) Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 82.50.178.13 Jun 19 00:04:22 scaffandro.entropy.org mpd: 82.50.178.13 is OK Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: SendConfigReq #102 Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 82.50.178.13 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: rec'd Configure Ack #102 link 0 (Ack-Sent) Jun 19 00:04:22 scaffandro.entropy.org mpd: IPADDR 82.50.178.13 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: state change Ack-Sent --> Opened Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IPCP: LayerUp Jun 19 00:04:22 scaffandro.entropy.org mpd: 82.50.178.13 -> 192.168.100.1 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] IFACE: Up event Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] setting interface ng0 MTU to 1492 bytes Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] exec: /sbin/ifconfig ng0 82.50.178.13 192.168.100.1 netmask 0xffffffff -link0 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] exec: /sbin/route add 82.50.178.13 -iface lo0 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] exec: /sbin/route add 0.0.0.0 192.168.100.1 Jun 19 00:04:22 scaffandro.entropy.org mpd: [pppoe] exec: /usr/local/sbin/ppp-linkup ng0 inet 82.50.178.13 192.168.100.1 Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] IFACE: Up event Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] connection closed Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] rec'd unexpected protocol IP on link 0 Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] device: DOWN event in state UP Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] device is now in state DOWN Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] error writing len 16 frame to bypass: Network is down Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] link: DOWN event Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] LCP: Down event Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] LCP: state change Opened --> Starting Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] LCP: phase shift NETWORK --> DEAD Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] setting interface ng0 MTU to 1500 bytes Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] up: 0 links, total bandwidth 9600 bps Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] IPCP: Down event Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] IPCP: state change Opened --> Starting Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] IPCP: LayerDown Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] IFACE: Down event Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] exec: /sbin/route delete 0.0.0.0 192.168.100.1 Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] exec: /sbin/route delete 82.50.178.13 -iface lo0 Jun 19 00:15:06 scaffandro.entropy.org mpd: [pppoe] exec: /sbin/ifconfig ng0 down delete -link0 Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] LCP: LayerDown Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto IP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] device: OPEN event in state DOWN Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] pausing 5 seconds before open Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] device is now in state DOWN Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto IP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto LCP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto IP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto LCP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto IP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto LCP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto IP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto LCP while dead Jun 19 00:15:07 scaffandro.entropy.org mpd: [pppoe] rec'd proto IP while dead Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] closing link "pppoe"... Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] link: CLOSE event Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] LCP: Close event Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] LCP: state change Starting --> Initial Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] LCP: LayerFinish Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] device: CLOSE event in state DOWN Jun 19 00:15:09 scaffandro.entropy.org mpd: [pppoe] device is now in state DOWN ***end*** Any help, observation or comment on the logs is MUCH appreciated! Gianluca Bosco |