2.0RC1 : PPPoE not working yet
-
Looks to me that the posted config.xml has two ppp interfaces saying they use /dev/cuaU0.0 but only one (ppp2) seems to be mapped to a pfSense interface (opt3).
Could this be a rarely encountered configuration that causes pfSense to create a ppp configuration file that confuses the ppp daemon?
I've previously reported pfSense 2.0 seems to have a bit of trouble deleting interfaces. Might this be another example? Can you account for the two ppp interfaces referencing /dev/cuaU0.0?
the second ppp interface isn't mapped. I have two sim cards with different network providers and have switched between the two depending upon the sim fitted to the hsdpa modem.
-
@ermal:
I need the system logs.
which ones? ppp and system?
and is there a simple way to extract them or do I just download the log file? -
tried this snapshot yesterday, pfSense-2.0-RC1-1g-i386-20110315-1934-nanobsd-upgrade.img.gz
better than it has been but it still hasn't consistantly resolved the underlying issue.
removing the hsdpa usb modem and then reconnecting the usb is detected by the system but the ppp code doesn't detect it. which is the same symptom as we had originally.
i'll leave this for a while until some of the other rc1 issues have been worked through and/or I get some more time to document the operation. -
You mean that you want to triger a connection reload when the modem is put in?
-
@ermal:
I need the system logs.
which ones? ppp and system?
and is there a simple way to extract them or do I just download the log file?In case you haven't figured t out already, truncated forms of the system logs are available in the web GUI from Status -> System Logs, click on the appropriate tab.
If you want the full system log(s) they can be displayed by shell command # clog /var/log/ (replace <file>by the name of the appropriate file, e.g. system.log, ppp.log etc)
The logs are "circular buffer" files which are a fixed size. Once the file is full old entries drop out to make room for new entries.</file> -
@ermal:
You mean that you want to triger a connection reload when the modem is put in?
anything that causes the link to drop should cause a connection reload. In this instance I've used a USB disconnect but the same issue occurs with power cycling the ASDL modem, disconnecting the ethernet connection to the ADSL, disconnecting the phone line into the ADSL. Unfortunately my options for testing a failover with a USB HSDPA modem are limited to 'pulling the plug'.
What I've seen is that there appears to be some change of link state conditions that aren't detected by the pfsense code and subsequantly there are issues in (re)establishing a WAN link.
It may be that it is being highlighted due to the low speed of my machine ( 800MHz ). -
Can you give the related system log on this?
The section when the usb is detached and reattached and any other output in the 'vicinity' of these. -
hi all!!
I have the same problem since around beta2 (probably before) and i got it to work just clicking around the advanced options (/interfaces_ppps_edit.php). Only selecting the link interface and saving.
Although they are working, i can't access the webgui through any pppoe interface. I have created the corresponding rules to allow https but nothing…
I have 3 wan (2 pppoe, 1 DHCP) 1 LAN and i can only access the webgui through the DHCP o the LAN interface.
Any ideas?2.0-RC1 (i386)
built on Mon Mar 14 20:46:06 EDT 2011Bruno
-
in this first log the usb/hsdpa modem reconnects ok
Mar 19 08:35:44 pfsense ppp: [opt3_link0] Link: reconnection attempt 16 Mar 19 08:35:44 pfsense ppp: [opt3_link0] can't open /dev/cuaU0.0: No such file or directory Mar 19 08:35:44 pfsense ppp: [opt3_link0] Link: DOWN event Mar 19 08:35:44 pfsense ppp: [opt3_link0] LCP: Down event Mar 19 08:35:44 pfsense ppp: [opt3_link0] Link: reconnection attempt 17 in 4 seconds Mar 19 08:35:45 pfsense kernel: ugen0.2: <huawei technologies="">at usbus0 Mar 19 08:35:45 pfsense kernel: ugen0.2: <huawei technologies="">at usbus0 (disconnected) Mar 19 08:35:46 pfsense kernel: stray irq7 Mar 19 08:35:47 pfsense kernel: ugen0.2: <huawei technologies="">at usbus0 Mar 19 08:35:47 pfsense kernel: u3g0: <data interface="">on usbus0 Mar 19 08:35:47 pfsense kernel: u3g0: Found 2 ports. Mar 19 08:35:47 pfsense kernel: umass0: <huawei 0="" 2="" technologies="" huawei="" mobile,="" class="" 0,="" rev="" 1.10="" 0.00,="" addr="">on usbus0 Mar 19 08:35:48 pfsense ppp: [opt3_link0] Link: reconnection attempt 17 Mar 19 08:35:48 pfsense ppp: [opt3_link0] chat: Detected Hayes compatible modem. Mar 19 08:35:49 pfsense kernel: (probe0:umass-sim0:0:0:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 Mar 19 08:35:49 pfsense kernel: (probe0:umass-sim0:0:0:0): CAM status: SCSI Status Error Mar 19 08:35:49 pfsense kernel: (probe0:umass-sim0:0:0:0): SCSI status: Check Condition Mar 19 08:35:49 pfsense kernel: (probe0:umass-sim0:0:0:0): SCSI sense: NOT READY asc:3a,0 (Medium not present) Mar 19 08:35:49 pfsense kernel: cd0 at umass-sim0 bus 0 scbus0 target 0 lun 0 Mar 19 08:35:49 pfsense kernel: cd0: <huawei mass="" storage="" 2.31="">Removable CD-ROM SCSI-2 device Mar 19 08:35:49 pfsense kernel: cd0: 1.000MB/s transfers Mar 19 08:35:49 pfsense kernel: cd0: Attempt to query device size failed: NOT READY, Medium not present Mar 19 08:35:49 pfsense ppp: [opt3_link0] chat: Dialing server at *99#... Mar 19 08:35:49 pfsense ppp: [opt3_link0] chat: Connected at an unknown speed. Mar 19 08:35:49 pfsense ppp: [opt3_link0] MODEM: chat script succeeded Mar 19 08:35:49 pfsense ppp: [opt3_link0] Link: UP event Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: Up event Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: state change Starting --> Req-Sent Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: SendConfigReq #2 Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACCMAP 0x000a0000 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MRU 1500 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MAGICNUM f9e01515 Mar 19 08:35:49 pfsense apinger: ALARM: GW_WAN(203.56.14.17) *** GW_WANdown *** Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: rec'd Configure Request #0 (Req-Sent) Mar 19 08:35:49 pfsense ppp: [opt3_link0] MRU 1440 Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACCMAP 0x00000000 Mar 19 08:35:49 pfsense ppp: [opt3_link0] AUTHPROTO CHAP MD5 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MAGICNUM 00c85e42 Mar 19 08:35:49 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: SendConfigAck #0 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MRU 1440 Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACCMAP 0x00000000 Mar 19 08:35:49 pfsense ppp: [opt3_link0] AUTHPROTO CHAP MD5 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MAGICNUM 00c85e42 Mar 19 08:35:49 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: state change Req-Sent --> Ack-Sent Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: rec'd Configure Ack #2 (Ack-Sent) Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:35:49 pfsense ppp: [opt3_link0] ACCMAP 0x000a0000 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MRU 1500 Mar 19 08:35:49 pfsense ppp: [opt3_link0] MAGICNUM f9e01515 Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: state change Ack-Sent --> Opened Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: auth: peer wants CHAP, I want nothing Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: LayerUp Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: rec'd Discard Request #1 (Opened) Mar 19 08:35:49 pfsense ppp: [opt3_link0] CHAP: rec'd CHALLENGE #1 len: 35 Mar 19 08:35:49 pfsense ppp: [opt3_link0] Name: "UMTS_CHAP_SRVR" Mar 19 08:35:49 pfsense ppp: [opt3_link0] CHAP: Using authname "blank" Mar 19 08:35:49 pfsense ppp: [opt3_link0] CHAP: sending RESPONSE #1 len: 26 Mar 19 08:35:49 pfsense ppp: [opt3_link0] CHAP: rec'd SUCCESS #1 len: 4 Mar 19 08:35:49 pfsense ppp: [opt3_link0] LCP: authorization successful Mar 19 08:35:49 pfsense ppp: [opt3_link0] Link: Matched action 'bundle "opt3" ""' Mar 19 08:35:49 pfsense ppp: [opt3_link0] Link: Join bundle "opt3" Mar 19 08:35:49 pfsense ppp: [opt3] Bundle: Status update: up 1 link, total bandwidth 28800 bps Mar 19 08:35:49 pfsense ppp: [opt3] IPCP: Open event Mar 19 08:35:49 pfsense ppp: [opt3] IPCP: state change Initial --> Starting Mar 19 08:35:49 pfsense ppp: [opt3] IPCP: LayerStart Mar 19 08:35:49 pfsense ppp: [opt3] IPCP: Up event Mar 19 08:35:49 pfsense ppp: [opt3] IPCP: state change Starting --> Req-Sent Mar 19 08:35:49 pfsense ppp: [opt3] IPCP: SendConfigReq #7 Mar 19 08:35:49 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:35:49 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:35:49 pfsense ppp: [opt3] PRIDNS 0.0.0.0 Mar 19 08:35:49 pfsense ppp: [opt3] SECDNS 0.0.0.0 Mar 19 08:35:49 pfsense apinger: alarm canceled: GW_WAN(203.56.14.17) *** GW_WANdown *** Mar 19 08:35:50 pfsense ppp: [opt3] IPCP: rec'd Configure Nak #7 (Req-Sent) Mar 19 08:35:50 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:35:50 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:35:50 pfsense ppp: [opt3] PRINBNS 10.11.12.13 Mar 19 08:35:50 pfsense ppp: [opt3] SECNBNS 10.11.12.14 Mar 19 08:35:50 pfsense ppp: [opt3] IPCP: SendConfigReq #8 Mar 19 08:35:50 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:35:50 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:35:50 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:35:50 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:35:51 pfsense ppp: [opt3] IPCP: rec'd Configure Nak #8 (Req-Sent) Mar 19 08:35:51 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:35:51 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:35:51 pfsense ppp: [opt3] PRINBNS 10.11.12.13 Mar 19 08:35:51 pfsense ppp: [opt3] SECNBNS 10.11.12.14 Mar 19 08:35:51 pfsense ppp: [opt3] IPCP: SendConfigReq #9 Mar 19 08:35:51 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:35:51 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:35:51 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:35:51 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: rec'd Configure Request #0 (Req-Sent) Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: SendConfigAck #0 Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: state change Req-Sent --> Ack-Sent Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: rec'd Configure Reject #9 (Ack-Sent) Mar 19 08:35:52 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: SendConfigReq #10 Mar 19 08:35:52 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:35:52 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:35:52 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: rec'd Configure Nak #10 (Ack-Sent) Mar 19 08:35:52 pfsense ppp: [opt3] IPADDR 121.91.213.142 Mar 19 08:35:52 pfsense ppp: [opt3] 121.91.213.142 is OK Mar 19 08:35:52 pfsense ppp: [opt3] PRIDNS 123.200.191.17 Mar 19 08:35:52 pfsense ppp: [opt3] SECDNS 123.200.191.18 Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: SendConfigReq #11 Mar 19 08:35:52 pfsense ppp: [opt3] IPADDR 121.91.213.142 Mar 19 08:35:52 pfsense ppp: [opt3] PRIDNS 123.200.191.17 Mar 19 08:35:52 pfsense ppp: [opt3] SECDNS 123.200.191.18 Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: rec'd Configure Ack #11 (Ack-Sent) Mar 19 08:35:52 pfsense ppp: [opt3] IPADDR 121.91.213.142 Mar 19 08:35:52 pfsense ppp: [opt3] PRIDNS 123.200.191.17 Mar 19 08:35:52 pfsense ppp: [opt3] SECDNS 123.200.191.18 Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: state change Ack-Sent --> Opened Mar 19 08:35:52 pfsense ppp: [opt3] IPCP: LayerUp Mar 19 08:35:52 pfsense ppp: [opt3] 121.91.213.142 -> 10.64.64.0 Mar 19 08:35:52 pfsense check_reload_status: Rewriting resolv.conf Mar 19 08:35:53 pfsense check_reload_status: rc.newwanip starting ppp1 Mar 19 08:35:53 pfsense ppp: [opt3] IFACE: Up event Mar 19 08:35:54 pfsense php: : rc.newwanip: Informational is starting ppp1. Mar 19 08:35:54 pfsense php: : rc.newwanip: on (IP address: 121.91.213.142) (interface: opt3) (real interface: ppp1). Mar 19 08:35:56 pfsense php: : ROUTING: change default route to 10.64.64.0 Mar 19 08:35:56 pfsense php: : Removing static route for monitor 123.200.191.17 and adding a new route through 10.64.64.0 Mar 19 08:35:56 pfsense php: : Removing static route for monitor 203.56.14.17 and adding a new route through 203.56.14.7 Mar 19 08:35:56 pfsense check_reload_status: reloading filter Mar 19 08:35:56 pfsense check_reload_status: reloading filter Mar 19 08:35:56 pfsense apinger: Exiting on signal 15. Mar 19 08:35:57 pfsense check_reload_status: reloading filter Mar 19 08:35:58 pfsense apinger: Starting Alarm Pinger, apinger(63604) Mar 19 08:35:58 pfsense php: : DynDns: Running updatedns() Mar 19 08:35:58 pfsense php: : DynDns: updatedns() starting Mar 19 08:35:58 pfsense php: : DynDns: _detectChange() starting. Mar 19 08:35:58 pfsense php: : DynDns: _checkIP() starting. Mar 19 08:35:58 pfsense php: : DynDns debug information: 121.91.213.142 extracted from local system. Mar 19 08:35:58 pfsense php: : DynDns: Current WAN IP: 121.91.213.142 Mar 19 08:35:58 pfsense php: : DynDns: Cached IP: 121.91.181.126 Mar 19 08:35:58 pfsense php: : DynDns debug information: DynDns: cacheIP != wan_ip. Updating. Cached IP: 121.91.181.126 WAN IP: 121.91.213.142 Mar 19 08:35:59 pfsense php: : DynDns: DynDns _update() starting. Mar 19 08:36:01 pfsense php: : Gateways status could not be determined, considering all as up/active. Mar 19 08:36:01 pfsense php: : DynDns: DynDns _checkStatus() starting. Mar 19 08:36:01 pfsense php: : DynDns: Current Service: freedns Mar 19 08:36:01 pfsense php: : DynDns: _checkIP() starting. Mar 19 08:36:01 pfsense php: : DynDns debug information: 121.91.213.142 extracted from local system. Mar 19 08:36:01 pfsense php: : phpDynDNS: updating cache file /conf/dyndns_opt3freedns'sages.jumpingcrab.com'.cache: 121.91.213.142 Mar 19 08:36:01 pfsense php: : phpDynDNS: (Success) IP Address Changed Successfully! Mar 19 08:36:07 pfsense php: : Resyncing OpenVPN instances for interface NEXTG. Mar 19 08:36:08 pfsense apinger: ALARM: NEXTG(123.200.191.17) *** NEXTGdelay *** Mar 19 08:36:13 pfsense hostapd: ath0_wlan0: STA 5c:ac:4c:58:ef:87 WPA: group key handshake completed (RSN) Mar 19 08:36:14 pfsense apinger: alarm canceled: NEXTG(123.200.191.17) *** NEXTGdelay *** Mar 19 08:36:18 pfsense check_reload_status: reloading filter</huawei></huawei></data></huawei></huawei></huawei>
in this section it fails to reconnect after the USb is reinserted.
Mar 19 08:38:44 pfsense kernel: ugen0.2: <huawei technologies="">at usbus0 Mar 19 08:38:45 pfsense ppp: [wan_link0] PPPoE connection timeout after 9 seconds Mar 19 08:38:45 pfsense ppp: [wan_link0] Link: DOWN event Mar 19 08:38:45 pfsense ppp: [wan_link0] LCP: Down event Mar 19 08:38:45 pfsense ppp: [wan_link0] Link: reconnection attempt 5 in 3 seconds Mar 19 08:38:45 pfsense ppp: [opt3_link0] Link: reconnection attempt 11 Mar 19 08:38:45 pfsense kernel: ugen0.2: <huawei technologies="">at usbus0 (disconnected) Mar 19 08:38:46 pfsense ppp: [opt3_link0] can't open /dev/cuaU0.0: No such file or directory Mar 19 08:38:46 pfsense ppp: [opt3_link0] Link: DOWN event Mar 19 08:38:46 pfsense ppp: [opt3_link0] LCP: Down event Mar 19 08:38:46 pfsense ppp: [opt3_link0] Link: reconnection attempt 12 in 2 seconds Mar 19 08:38:46 pfsense kernel: ugen0.2: <huawei technologies="">at usbus0 Mar 19 08:38:47 pfsense kernel: u3g0: <data interface="">on usbus0 Mar 19 08:38:47 pfsense kernel: u3g0: Found 2 ports. Mar 19 08:38:47 pfsense kernel: umass0: <huawei 0="" 2="" technologies="" huawei="" mobile,="" class="" 0,="" rev="" 1.10="" 0.00,="" addr="">on usbus0 Mar 19 08:38:48 pfsense kernel: (probe0:umass-sim0:0:0:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 Mar 19 08:38:48 pfsense kernel: (probe0:umass-sim0:0:0:0): CAM status: SCSI Status Error Mar 19 08:38:48 pfsense kernel: (probe0:umass-sim0:0:0:0): SCSI status: Check Condition Mar 19 08:38:48 pfsense kernel: (probe0:umass-sim0:0:0:0): SCSI sense: NOT READY asc:3a,0 (Medium not present) Mar 19 08:38:48 pfsense ppp: [wan_link0] Link: reconnection attempt 5 Mar 19 08:38:48 pfsense ppp: [opt3_link0] Link: reconnection attempt 12 Mar 19 08:38:48 pfsense ppp: [wan_link0] PPPoE: Connecting to '*' Mar 19 08:38:49 pfsense kernel: cd0 at umass-sim0 bus 0 scbus0 target 0 lun 0 Mar 19 08:38:49 pfsense kernel: cd0: <huawei mass="" storage="" 2.31="">Removable CD-ROM SCSI-2 device Mar 19 08:38:49 pfsense kernel: cd0: 1.000MB/s transfers Mar 19 08:38:49 pfsense kernel: cd0: Attempt to query device size failed: NOT READY, Medium not present Mar 19 08:38:49 pfsense ppp: [opt3_link0] chat: Detected Hayes compatible modem. Mar 19 08:38:50 pfsense ppp: [opt3_link0] chat: Dialing server at *99#... Mar 19 08:38:50 pfsense ppp: [opt3_link0] chat: Connected at an unknown speed. Mar 19 08:38:50 pfsense ppp: [opt3_link0] MODEM: chat script succeeded Mar 19 08:38:50 pfsense ppp: [opt3_link0] Link: UP event Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: Up event Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: state change Starting --> Req-Sent Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: SendConfigReq #3 Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACCMAP 0x000a0000 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MRU 1500 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MAGICNUM 305465d9 Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: rec'd Configure Request #0 (Req-Sent) Mar 19 08:38:50 pfsense ppp: [opt3_link0] MRU 1440 Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACCMAP 0x00000000 Mar 19 08:38:50 pfsense ppp: [opt3_link0] AUTHPROTO CHAP MD5 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MAGICNUM 00c862a9 Mar 19 08:38:50 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: SendConfigAck #0 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MRU 1440 Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACCMAP 0x00000000 Mar 19 08:38:50 pfsense ppp: [opt3_link0] AUTHPROTO CHAP MD5 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MAGICNUM 00c862a9 Mar 19 08:38:50 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: state change Req-Sent --> Ack-Sent Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: rec'd Configure Ack #3 (Ack-Sent) Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACFCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] PROTOCOMP Mar 19 08:38:50 pfsense ppp: [opt3_link0] ACCMAP 0x000a0000 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MRU 1500 Mar 19 08:38:50 pfsense ppp: [opt3_link0] MAGICNUM 305465d9 Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: state change Ack-Sent --> Opened Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: auth: peer wants CHAP, I want nothing Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: LayerUp Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: rec'd Discard Request #1 (Opened) Mar 19 08:38:50 pfsense ppp: [opt3_link0] CHAP: rec'd CHALLENGE #1 len: 35 Mar 19 08:38:50 pfsense ppp: [opt3_link0] Name: "UMTS_CHAP_SRVR" Mar 19 08:38:50 pfsense ppp: [opt3_link0] CHAP: Using authname "blank" Mar 19 08:38:50 pfsense ppp: [opt3_link0] CHAP: sending RESPONSE #1 len: 26 Mar 19 08:38:50 pfsense ppp: [opt3_link0] CHAP: rec'd SUCCESS #1 len: 4 Mar 19 08:38:50 pfsense ppp: [opt3_link0] LCP: authorization successful Mar 19 08:38:50 pfsense ppp: [opt3_link0] Link: Matched action 'bundle "opt3" ""' Mar 19 08:38:50 pfsense ppp: [opt3_link0] Link: Join bundle "opt3" Mar 19 08:38:50 pfsense ppp: [opt3] Bundle: Status update: up 1 link, total bandwidth 28800 bps Mar 19 08:38:50 pfsense ppp: [opt3] IPCP: Open event Mar 19 08:38:50 pfsense ppp: [opt3] IPCP: state change Initial --> Starting Mar 19 08:38:50 pfsense ppp: [opt3] IPCP: LayerStart Mar 19 08:38:50 pfsense ppp: [opt3] IPCP: Up event Mar 19 08:38:50 pfsense ppp: [opt3] IPCP: state change Starting --> Req-Sent Mar 19 08:38:50 pfsense ppp: [opt3] IPCP: SendConfigReq #13 Mar 19 08:38:50 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:38:50 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:38:50 pfsense ppp: [opt3] PRIDNS 0.0.0.0 Mar 19 08:38:50 pfsense ppp: [opt3] SECDNS 0.0.0.0 Mar 19 08:38:51 pfsense ppp: [opt3] IPCP: rec'd Configure Nak #13 (Req-Sent) Mar 19 08:38:51 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:38:51 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:38:51 pfsense ppp: [opt3] PRINBNS 10.11.12.13 Mar 19 08:38:51 pfsense ppp: [opt3] SECNBNS 10.11.12.14 Mar 19 08:38:51 pfsense ppp: [opt3] IPCP: SendConfigReq #14 Mar 19 08:38:51 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:38:51 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:38:51 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:38:51 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:38:53 pfsense ppp: [opt3] IPCP: SendConfigReq #15 Mar 19 08:38:53 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:38:53 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:38:53 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:38:53 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:38:55 pfsense ppp: [opt3] IPCP: SendConfigReq #16 Mar 19 08:38:55 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:38:55 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:38:55 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:38:55 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:38:57 pfsense ppp: [opt3] IPCP: SendConfigReq #17 Mar 19 08:38:57 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:38:57 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:38:57 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:38:57 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:38:57 pfsense ppp: [wan_link0] PPPoE connection timeout after 9 seconds Mar 19 08:38:57 pfsense ppp: [wan_link0] Link: DOWN event Mar 19 08:38:57 pfsense ppp: [wan_link0] LCP: Down event Mar 19 08:38:57 pfsense ppp: [wan_link0] Link: reconnection attempt 6 in 4 seconds Mar 19 08:38:59 pfsense ppp: [opt3] IPCP: SendConfigReq #18 Mar 19 08:38:59 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:38:59 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:38:59 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:38:59 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:39:01 pfsense ppp: [opt3] IPCP: SendConfigReq #19 Mar 19 08:39:01 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:39:01 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:39:01 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:39:01 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:39:01 pfsense ppp: [wan_link0] Link: reconnection attempt 6 Mar 19 08:39:01 pfsense ppp: [wan_link0] PPPoE: Connecting to '*' Mar 19 08:39:03 pfsense ppp: [opt3] IPCP: SendConfigReq #20 Mar 19 08:39:03 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:39:03 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:39:03 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:39:03 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:39:05 pfsense ppp: [opt3] IPCP: SendConfigReq #21 Mar 19 08:39:05 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:39:05 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:39:05 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:39:05 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:39:07 pfsense ppp: [opt3] IPCP: SendConfigReq #22 Mar 19 08:39:07 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:39:07 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:39:07 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:39:07 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:39:09 pfsense ppp: [opt3] IPCP: SendConfigReq #23 Mar 19 08:39:09 pfsense ppp: [opt3] IPADDR 0.0.0.0 Mar 19 08:39:09 pfsense ppp: [opt3] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Mar 19 08:39:09 pfsense ppp: [opt3] PRIDNS 10.11.12.13 Mar 19 08:39:09 pfsense ppp: [opt3] SECDNS 10.11.12.14 Mar 19 08:39:10 pfsense ppp: [wan_link0] PPPoE connection timeout after 9 seconds Mar 19 08:39:10 pfsense ppp: [wan_link0] Link: DOWN event Mar 19 08:39:10 pfsense ppp: [wan_link0] LCP: Down event Mar 19 08:39:10 pfsense ppp: [wan_link0] Link: reconnection attempt 7 in 2 seconds Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: parameter negotiation failed Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: state change Req-Sent --> Stopped Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: LayerFinish Mar 19 08:39:11 pfsense ppp: [opt3] Bundle: No NCPs left. Closing links... Mar 19 08:39:11 pfsense ppp: [opt3] Bundle: closing link "opt3_link0"... Mar 19 08:39:11 pfsense ppp: [opt3_link0] Link: CLOSE event Mar 19 08:39:11 pfsense ppp: [opt3_link0] LCP: Close event Mar 19 08:39:11 pfsense ppp: [opt3_link0] LCP: state change Opened --> Closing Mar 19 08:39:11 pfsense ppp: [opt3_link0] Link: Leave bundle "opt3" Mar 19 08:39:11 pfsense ppp: [opt3] Bundle: Status update: up 0 links, total bandwidth 9600 bps Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: Close event Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: state change Stopped --> Closed Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: Down event Mar 19 08:39:11 pfsense ppp: [opt3] IPCP: state change Closed --> Initial Mar 19 08:39:11 pfsense ppp: [opt3_link0] LCP: SendTerminateReq #4 Mar 19 08:39:11 pfsense ppp: [opt3_link0] LCP: LayerDown Mar 19 08:39:12 pfsense ppp: [wan_link0] Link: reconnection attempt 7 Mar 19 08:39:12 pfsense ppp: [wan_link0] PPPoE: Connecting to '*' Mar 19 08:39:13 pfsense hostapd: ath0_wlan0: STA 5c:ac:4c:58:ef:87 WPA: group key handshake completed (RSN) Mar 19 08:39:13 pfsense ppp: [opt3_link0] LCP: SendTerminateReq #5 Mar 19 08:39:15 pfsense ppp: [opt3_link0] LCP: state change Closing --> Closed Mar 19 08:39:15 pfsense ppp: [opt3_link0] LCP: LayerFinish Mar 19 08:39:15 pfsense ppp: [opt3_link0] Link: DOWN event Mar 19 08:39:15 pfsense ppp: [opt3_link0] LCP: Down event Mar 19 08:39:15 pfsense ppp: [opt3_link0] LCP: state change Closed --> Initial Mar 19 08:39:21 pfsense ppp: [wan_link0] PPPoE connection timeout after 9 seconds Mar 19 08:39:21 pfsense ppp: [wan_link0] Link: DOWN</huawei></huawei></data></huawei></huawei></huawei>
-
have updated to latest snapshot.
issue is still there.
ppp connection via hsdpa appears to be random if link comes active.
once it fails, if it doesn't recover within a short period of time, the ppp log no longer has any entries for the link retrying.
this is without removing/installing the USB connection.is anyone else using a USB hsdpa modem on RC2 successfully? either single or backup?
-
after some scientific google ;) i found the following http://lists.freebsd.org/pipermail/freebsd-questions/2007-September/158811.html
specifically the entry into mpd.conf for "set bundle no noretry"I had rebuilt a bog standard system with only a single WAN configured for a hsdpa usb modem. ie no failover.
i was still having problems with the modem not connecting.
I then edited the /var/etc/mpd_wan.conf file and added the line above.
The modem came up pretty much straight away.
[edit] unfortunately it hasn't done anything to resolve the problem of recovering from a failed link :'( -
to confirm if i had a hardware issue or not, i loaded up a CF with a copy of vyatta.
3g/hsdpa usb modem connects/reconnects/unplug/plug usb and it establishes a connection each time. ie doesn't have any issues with connectivity or failing to connect.I'd like some feedback from anyone who has is using a usb hsdpa/3g modem to see if they have any issues on v2 rc1.
Vyatta is working but it's a pain to maintain with no graphic interface on the free version. -
I use a 3G modem for connectivity at two different sites. I'll try unplugging it and see what happens.
GB
-
;) Being Very familiar with this product i was a bit miffed to have thsi same issue, PPPOe not connecting.
Was running 1.2.3 latest upgraded to 2.0 RC1. Migrations seems to go through with no issues except for WAN.when WAN is changed to PPPOE, no connection. The Wan now says WAN/PPPOE, so i assume it sees that setup?
When it does not work it then creates a PPPOE:1 connection which i tried then it created a PPPOE:2 then PPPOE:3After trying multiple changes i went back to 1.2.3 and all works 100%. Can you point me to some resource that explains
the change in WAN setup. -
For me I never managed to work pppoe. Each time i try to connect it goes down in few seconds.
-
Just tested yesterdays svn build of 2.0RC1 to see if PPPoE is finally working and it is still not…. :S
1. Interfaces -> assign -> PPP's -> edit interface which is from 1.2.3
NO INTERFACES ARE SELECTABLE - until I re-select PPPoE AGAIN in the drop down list.
Why does WAN and LAN appear there? thats not a physical interface. :SBut even then, PPPoE is not working:
System log reports this when trying to connect: May 5 22:02:20 - php: : Could not find gateway for interface(wan).