[RESOLVED] issues on 26th march snapshot



  • some issues im having on the 26th march nanobsd 1gb snapshot r as follows

    1. pppoe not working, gets the ip from isp etc but interfaces shows connected but not ip etc
    2. below error in console during boot
      Starting syslog…Mar 26 08:49:12  syslogd: /var/log/l2pp.log: No such file or d
      irectory
      done.
    3. DHCP isnt stable similar to the previous snapshot, after sometime, it crashes or so and all lan clients get limited connectivity in windows


  • Non working PPPOE is same here. But it began on snap from 24th: IPCP negotiation error.



  • im stuck on the 22nd march nanobsd coz all the snapshots after that dont seem to work for me for pppoe and the latest one i tried was 26th march but its the same still, any1 idea whats causing it coz 22nd march has that dhcp issues which isnt there in newer snapshots and i want to upgrade but cant coz cant get the pppoe to get up.



  • Be more verbose on the errors you face.
    Provide the logs, ifconfig output, netstat -rn output to at least find where hte problem is.



  • the first 3 images r from a working snapshot from 22nd march nanobsd

    the last 3 images r from a non working snapshot from 26th march nanobsd

    BEFORE


    AFTER




  • pppoe logs please?



  • here r the logs

    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Starting --> Req-Sent
    Mar 27 08:57:51 	mpd: [wan] IPCP: SendConfigReq #1
    Mar 27 08:57:51 	mpd: [wan] IPADDR 0.0.0.0
    Mar 27 08:57:51 	mpd: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Mar 27 08:57:51 	mpd: [wan] IPCP: rec'd Configure Reject #1 (Req-Sent)
    Mar 27 08:57:51 	mpd: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Mar 27 08:57:51 	mpd: [wan] IPCP: SendConfigReq #2
    Mar 27 08:57:51 	mpd: [wan] IPADDR 0.0.0.0
    Mar 27 08:57:51 	mpd: [wan] IPCP: rec'd Configure Nak #2 (Req-Sent)
    Mar 27 08:57:51 	mpd: [wan] IPADDR 94.59.204.104
    Mar 27 08:57:51 	mpd: [wan] 94.59.204.104 is OK
    Mar 27 08:57:51 	mpd: [wan] IPCP: SendConfigReq #3
    Mar 27 08:57:51 	mpd: [wan] IPADDR 94.59.204.104
    Mar 27 08:57:51 	mpd: [wan] IPCP: rec'd Configure Ack #3 (Req-Sent)
    Mar 27 08:57:51 	mpd: [wan] IPADDR 94.59.204.104
    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Req-Sent --> Ack-Rcvd
    Mar 27 08:57:51 	mpd: [wan] IPCP: rec'd Configure Request #28 (Ack-Rcvd)
    Mar 27 08:57:51 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 08:57:51 	mpd: [wan] 195.229.252.33 is OK
    Mar 27 08:57:51 	mpd: [wan] IPCP: SendConfigAck #28
    Mar 27 08:57:51 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Ack-Rcvd --> Opened
    Mar 27 08:57:51 	mpd: [wan] IPCP: LayerUp
    Mar 27 08:57:51 	mpd: [wan] 94.59.204.104 -> 195.229.252.33
    Mar 27 08:57:51 	mpd: [wan] IPCP: parameter negotiation failed
    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Opened --> Stopping
    Mar 27 08:57:51 	mpd: [wan] IPCP: SendTerminateReq #4
    Mar 27 08:57:51 	mpd: [wan] IPCP: LayerDown
    Mar 27 08:57:51 	mpd: [wan] IPCP: rec'd Terminate Ack #4 (Stopping)
    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Stopping --> Stopped
    Mar 27 08:57:51 	mpd: [wan] IPCP: LayerFinish
    Mar 27 08:57:51 	mpd: [wan] Bundle: No NCPs left. Closing links...
    Mar 27 08:57:51 	mpd: [wan] Bundle: closing link "wanL1"...
    Mar 27 08:57:51 	mpd: [wanL1] Link: CLOSE event
    Mar 27 08:57:51 	mpd: [wanL1] LCP: Close event
    Mar 27 08:57:51 	mpd: [wanL1] LCP: state change Opened --> Closing
    Mar 27 08:57:51 	mpd: [wanL1] Link: Leave bundle "wan"
    Mar 27 08:57:51 	mpd: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
    Mar 27 08:57:51 	mpd: [wan] IPCP: Close event
    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Stopped --> Closed
    Mar 27 08:57:51 	mpd: [wan] IPCP: Down event
    Mar 27 08:57:51 	mpd: [wan] IPCP: state change Closed --> Initial
    Mar 27 08:57:51 	mpd: [wanL1] LCP: SendTerminateReq #2
    Mar 27 08:57:51 	mpd: [wanL1] LCP: LayerDown
    Mar 27 08:57:51 	mpd: [wanL1] LCP: rec'd Terminate Ack #2 (Closing)
    Mar 27 08:57:51 	mpd: [wanL1] LCP: state change Closing --> Closed
    Mar 27 08:57:51 	mpd: [wanL1] LCP: LayerFinish
    Mar 27 08:57:51 	mpd: [wanL1] Link: DOWN event
    Mar 27 08:57:51 	mpd: [wanL1] LCP: Down event
    Mar 27 08:57:51 	mpd: [wanL1] LCP: state change Closed --> Initial
    


  • Can you please open /etc/inc/interfaces.inc and change this line
    2216         set ipcp yes vjcomp
    to
    2216         set ipcp no vjcomp

    Try even this change which will be even in new snapshots.
    https://rcs.pfsense.org/projects/pfsense/repos/mainline/commits/8f4f1e308114dd181ad5a7ff5f9db44c69d871e9

    Report back your findings.



  • give me some time coz i tried editing the file from the web gui and it seems to corrupt the file so ill need to find some other way to modify the file and upload it and try it



  • can any1 tell me how do i edit the file and not kill the system

    1. tried from edit file using the webgui but that corrupts the file
    2. tried to uplaod the file using winscp but the system goes crazy

    i guess the file is being used thats y making changes doesnt work, is there any way to stop the system from using it so i can edit it and replace the file and restart its use?



  • finally managed to apply both the patches and still keep the system running.

    after a reboot also things remain the same

    Mar 27 14:39:39 	mpd: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
    Mar 27 14:39:39 	mpd: [wan] IPCP: Open event
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Initial --> Starting
    Mar 27 14:39:39 	mpd: [wan] IPCP: LayerStart
    Mar 27 14:39:39 	mpd: [wan] IPCP: Up event
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Starting --> Req-Sent
    Mar 27 14:39:39 	mpd: [wan] IPCP: SendConfigReq #1
    Mar 27 14:39:39 	mpd: [wan] IPADDR 0.0.0.0
    Mar 27 14:39:39 	mpd: [wan] IPCP: rec'd Configure Nak #1 (Req-Sent)
    Mar 27 14:39:39 	mpd: [wan] IPADDR 92.99.140.250
    Mar 27 14:39:39 	mpd: [wan] 92.99.140.250 is OK
    Mar 27 14:39:39 	mpd: [wan] IPCP: SendConfigReq #2
    Mar 27 14:39:39 	mpd: [wan] IPADDR 92.99.140.250
    Mar 27 14:39:39 	mpd: [wan] IPCP: rec'd Configure Ack #2 (Req-Sent)
    Mar 27 14:39:39 	mpd: [wan] IPADDR 92.99.140.250
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Req-Sent --> Ack-Rcvd
    Mar 27 14:39:39 	mpd: [wan] IPCP: rec'd Configure Request #129 (Ack-Rcvd)
    Mar 27 14:39:39 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 14:39:39 	mpd: [wan] 195.229.252.33 is OK
    Mar 27 14:39:39 	mpd: [wan] IPCP: SendConfigAck #129
    Mar 27 14:39:39 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Ack-Rcvd --> Opened
    Mar 27 14:39:39 	mpd: [wan] IPCP: LayerUp
    Mar 27 14:39:39 	mpd: [wan] 92.99.140.250 -> 195.229.252.33
    Mar 27 14:39:39 	mpd: [wan] IPCP: parameter negotiation failed
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Opened --> Stopping
    Mar 27 14:39:39 	mpd: [wan] IPCP: SendTerminateReq #3
    Mar 27 14:39:39 	mpd: [wan] IPCP: LayerDown
    Mar 27 14:39:39 	mpd: [wan] IPCP: rec'd Terminate Ack #3 (Stopping)
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Stopping --> Stopped
    Mar 27 14:39:39 	mpd: [wan] IPCP: LayerFinish
    Mar 27 14:39:39 	mpd: [wan] Bundle: No NCPs left. Closing links...
    Mar 27 14:39:39 	mpd: [wan] Bundle: closing link "wanL1"...
    Mar 27 14:39:39 	mpd: [wanL1] Link: CLOSE event
    Mar 27 14:39:39 	mpd: [wanL1] LCP: Close event
    Mar 27 14:39:39 	mpd: [wanL1] LCP: state change Opened --> Closing
    Mar 27 14:39:39 	mpd: [wanL1] Link: Leave bundle "wan"
    Mar 27 14:39:39 	mpd: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
    Mar 27 14:39:39 	mpd: [wan] IPCP: Close event
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Stopped --> Closed
    Mar 27 14:39:39 	mpd: [wan] IPCP: Down event
    Mar 27 14:39:39 	mpd: [wan] IPCP: state change Closed --> Initial
    Mar 27 14:39:39 	mpd: [wanL1] LCP: SendTerminateReq #2
    Mar 27 14:39:39 	mpd: [wanL1] LCP: LayerDown
    Mar 27 14:39:39 	mpd: [wanL1] LCP: rec'd Terminate Ack #2 (Closing)
    Mar 27 14:39:39 	mpd: [wanL1] LCP: state change Closing --> Closed
    Mar 27 14:39:39 	mpd: [wanL1] LCP: LayerFinish
    Mar 27 14:39:39 	mpd: [wanL1] Link: DOWN event
    Mar 27 14:39:39 	mpd: [wanL1] LCP: Down event
    Mar 27 14:39:39 	mpd: [wanL1] LCP: state change Closed --> Initial
    


  • Upload this to /usr/local/sbin without the .txt part

    ppp-linkup.txt



  • still the same

    Mar 27 14:59:50 	mpd: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
    Mar 27 14:59:50 	mpd: [wan] IPCP: Open event
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Initial --> Starting
    Mar 27 14:59:50 	mpd: [wan] IPCP: LayerStart
    Mar 27 14:59:50 	mpd: [wan] IPCP: Up event
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Starting --> Req-Sent
    Mar 27 14:59:50 	mpd: [wan] IPCP: SendConfigReq #1
    Mar 27 14:59:50 	mpd: [wan] IPADDR 0.0.0.0
    Mar 27 14:59:50 	mpd: [wan] IPCP: rec'd Configure Nak #1 (Req-Sent)
    Mar 27 14:59:50 	mpd: [wan] IPADDR 94.59.235.223
    Mar 27 14:59:50 	mpd: [wan] 94.59.235.223 is OK
    Mar 27 14:59:50 	mpd: [wan] IPCP: SendConfigReq #2
    Mar 27 14:59:50 	mpd: [wan] IPADDR 94.59.235.223
    Mar 27 14:59:50 	mpd: [wan] IPCP: rec'd Configure Ack #2 (Req-Sent)
    Mar 27 14:59:50 	mpd: [wan] IPADDR 94.59.235.223
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Req-Sent --> Ack-Rcvd
    Mar 27 14:59:50 	mpd: [wan] IPCP: rec'd Configure Request #253 (Ack-Rcvd)
    Mar 27 14:59:50 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 14:59:50 	mpd: [wan] 195.229.252.33 is OK
    Mar 27 14:59:50 	mpd: [wan] IPCP: SendConfigAck #253
    Mar 27 14:59:50 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Ack-Rcvd --> Opened
    Mar 27 14:59:50 	mpd: [wan] IPCP: LayerUp
    Mar 27 14:59:50 	mpd: [wan] 94.59.235.223 -> 195.229.252.33
    Mar 27 14:59:50 	mpd: [wan] IPCP: parameter negotiation failed
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Opened --> Stopping
    Mar 27 14:59:50 	mpd: [wan] IPCP: SendTerminateReq #3
    Mar 27 14:59:50 	mpd: [wan] IPCP: LayerDown
    Mar 27 14:59:50 	mpd: [wan] IPCP: rec'd Terminate Ack #3 (Stopping)
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Stopping --> Stopped
    Mar 27 14:59:50 	mpd: [wan] IPCP: LayerFinish
    Mar 27 14:59:50 	mpd: [wan] Bundle: No NCPs left. Closing links...
    Mar 27 14:59:50 	mpd: [wan] Bundle: closing link "wanL1"...
    Mar 27 14:59:50 	mpd: [wanL1] Link: CLOSE event
    Mar 27 14:59:50 	mpd: [wanL1] LCP: Close event
    Mar 27 14:59:50 	mpd: [wanL1] LCP: state change Opened --> Closing
    Mar 27 14:59:50 	mpd: [wanL1] Link: Leave bundle "wan"
    Mar 27 14:59:50 	mpd: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
    Mar 27 14:59:50 	mpd: [wan] IPCP: Close event
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Stopped --> Closed
    Mar 27 14:59:50 	mpd: [wan] IPCP: Down event
    Mar 27 14:59:50 	mpd: [wan] IPCP: state change Closed --> Initial
    Mar 27 14:59:50 	mpd: [wanL1] LCP: SendTerminateReq #2
    Mar 27 14:59:50 	mpd: [wanL1] LCP: LayerDown
    Mar 27 14:59:50 	mpd: [wanL1] LCP: rec'd Terminate Ack #2 (Closing)
    Mar 27 14:59:50 	mpd: [wanL1] LCP: state change Closing --> Closed
    Mar 27 14:59:50 	mpd: [wanL1] LCP: LayerFinish
    Mar 27 14:59:50 	mpd: [wanL1] Link: DOWN event
    Mar 27 14:59:50 	mpd: [wanL1] LCP: Down event
    Mar 27 14:59:50 	mpd: [wanL1] LCP: state change Closed --> Initial
    


  • Can you please add as you did with the no compression to the mpd.conf
    just under the line youchange previously and give me the logs again

    set log +iface
    set log +fsm
    set log +ccp



  • slow down, can u tell me what to add in what file then atleast i wont be lost doing stuff?



  • ok figured it out, the log is the same.

    one thing the annoys me in the console everytime

    Mar 27 16:08:28  syslogd: /var/log/l2tp.log: No such file or directory
    Mar 27 16:08:42  syslogd: /var/log/l2tp.log: No such file or directory
    Mar 27 16:08:28  syslogd: /var/log/l2tp.log: No such file or directory
    Mar 27 16:08:42  syslogd: /var/log/l2tp.log: No such file or directory
    

    mpd log

    Mar 27 16:09:21 	mpd: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
    Mar 27 16:09:21 	mpd: [wan] IPCP: Open event
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Initial --> Starting
    Mar 27 16:09:21 	mpd: [wan] IPCP: LayerStart
    Mar 27 16:09:21 	mpd: [wan] IPCP: Up event
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Starting --> Req-Sent
    Mar 27 16:09:21 	mpd: [wan] IPCP: SendConfigReq #1
    Mar 27 16:09:21 	mpd: [wan] IPADDR 0.0.0.0
    Mar 27 16:09:21 	mpd: [wan] IPCP: rec'd Configure Nak #1 (Req-Sent)
    Mar 27 16:09:21 	mpd: [wan] IPADDR 86.97.126.189
    Mar 27 16:09:21 	mpd: [wan] 86.97.126.189 is OK
    Mar 27 16:09:21 	mpd: [wan] IPCP: SendConfigReq #2
    Mar 27 16:09:21 	mpd: [wan] IPADDR 86.97.126.189
    Mar 27 16:09:21 	mpd: [wan] IPCP: rec'd Configure Ack #2 (Req-Sent)
    Mar 27 16:09:21 	mpd: [wan] IPADDR 86.97.126.189
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Req-Sent --> Ack-Rcvd
    Mar 27 16:09:21 	mpd: [wan] IPCP: rec'd Configure Request #15 (Ack-Rcvd)
    Mar 27 16:09:21 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 16:09:21 	mpd: [wan] 195.229.252.33 is OK
    Mar 27 16:09:21 	mpd: [wan] IPCP: SendConfigAck #15
    Mar 27 16:09:21 	mpd: [wan] IPADDR 195.229.252.33
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Ack-Rcvd --> Opened
    Mar 27 16:09:21 	mpd: [wan] IPCP: LayerUp
    Mar 27 16:09:21 	mpd: [wan] 86.97.126.189 -> 195.229.252.33
    Mar 27 16:09:21 	mpd: [wan] IPCP: parameter negotiation failed
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Opened --> Stopping
    Mar 27 16:09:21 	mpd: [wan] IPCP: SendTerminateReq #3
    Mar 27 16:09:21 	mpd: [wan] IPCP: LayerDown
    Mar 27 16:09:21 	mpd: [wan] IPCP: rec'd Terminate Ack #3 (Stopping)
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Stopping --> Stopped
    Mar 27 16:09:21 	mpd: [wan] IPCP: LayerFinish
    Mar 27 16:09:21 	mpd: [wan] Bundle: No NCPs left. Closing links...
    Mar 27 16:09:21 	mpd: [wan] Bundle: closing link "wanL1"...
    Mar 27 16:09:21 	mpd: [wanL1] Link: CLOSE event
    Mar 27 16:09:21 	mpd: [wanL1] LCP: Close event
    Mar 27 16:09:21 	mpd: [wanL1] LCP: state change Opened --> Closing
    Mar 27 16:09:21 	mpd: [wanL1] Link: Leave bundle "wan"
    Mar 27 16:09:21 	mpd: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
    Mar 27 16:09:21 	mpd: [wan] IPCP: Close event
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Stopped --> Closed
    Mar 27 16:09:21 	mpd: [wan] IPCP: Down event
    Mar 27 16:09:21 	mpd: [wan] IPCP: state change Closed --> Initial
    Mar 27 16:09:21 	mpd: [wanL1] LCP: SendTerminateReq #2
    Mar 27 16:09:21 	mpd: [wanL1] LCP: LayerDown
    Mar 27 16:09:21 	mpd: [wanL1] LCP: rec'd Terminate Ack #2 (Closing)
    Mar 27 16:09:21 	mpd: [wanL1] LCP: state change Closing --> Closed
    Mar 27 16:09:21 	mpd: [wanL1] LCP: LayerFinish
    Mar 27 16:09:21 	mpd: [wanL1] Link: DOWN event
    Mar 27 16:09:21 	mpd: [wanL1] LCP: Down event
    Mar 27 16:09:21 	mpd: [wanL1] LCP: state change Closed --> Initial
    


  • In /etc/inc/interfaces.inc just below the line for vjcomp add those lines.



  • Please add all the log settings you can find here http://mpd.sourceforge.net/doc5/mpd18.html#18
    and if possible get a packet trace. Otherwise this is very difficult to diagnose.



  • im not that great at freebsd, mayb igor can help in a bit to produce the logs coz what i see is, pppoe connects and from log u can see the IP is received from the ISP but there is something else also negotiated which causes the IPCP error which brings down the whole thing.

    currently im on the 22nd march 1GB nanobsd and its working fine in that with the compression etc on, all snapshots after that 22nd stopped so mayb trying to trace what all related to mpd has changed can solve the issue and i udnerstand a lof of things have changed since then.



  • by the way i usually get the log from the system log in the GUI which shows only 50 entries, can u just tell me how to get the complete log so i can attempt those other logging commands



  • got sthing for you :)

    i repost the first login attemp after a modem reset later… there seems to be some differencies.. but i'll check back later on that

    
    Mar 27 21:11:22 	wan: Multi-link PPP daemon for FreeBSD
    Mar 27 21:11:22 	wan:
    Mar 27 21:11:22 	wan: process 32841 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-snaps.pfsense.org 17:21 23-Mar-2010)
    Mar 27 21:11:22 	wan: web: web is not running
    Mar 27 21:11:22 	wan: [wan] Bundle: Interface ng0 created
    Mar 27 21:11:22 	wan: [wanL1] Link: OPEN event
    Mar 27 21:11:22 	wan: [wanL1] LCP: Open event
    Mar 27 21:11:22 	wan: [wanL1] LCP: state change Initial --> Starting
    Mar 27 21:11:22 	wan: [wanL1] LCP: LayerStart
    Mar 27 21:11:22 	wan: [wanL1] PPPoE: Connecting to ''
    Mar 27 21:11:22 	wan: PPPoE: rec'd ACNAME "MUNR78-se800-B221E050705132"
    Mar 27 21:11:23 	wan: [wanL1] PPPoE: connection successful
    Mar 27 21:11:23 	wan: [wanL1] Link: UP event
    Mar 27 21:11:23 	wan: [wanL1] LCP: Up event
    Mar 27 21:11:23 	wan: [wanL1] LCP: state change Starting --> Req-Sent
    Mar 27 21:11:23 	wan: [wanL1] LCP: SendConfigReq #1
    Mar 27 21:11:23 	wan: [wanL1] MRU 1492
    Mar 27 21:11:23 	wan: [wanL1] MAGICNUM a209be22
    Mar 27 21:11:23 	wan: [wanL1] xmit frame to link proto=0xc021
    Mar 27 21:11:23 	wan: ff 03 c0 21 01 01 00 0e 01 04 05 d4 05 06 a2 09 ...!............
    Mar 27 21:11:23 	wan: be 22 ."
    Mar 27 21:11:23 	wan: [wanL1] rec'd 20 bytes frame from link proto=0xc021
    Mar 27 21:11:23 	wan: c0 21 01 e5 00 12 01 04 05 d4 03 04 c0 23 05 06 .!...........#..
    Mar 27 21:11:23 	wan: 11 58 64 46 .XdF
    Mar 27 21:11:23 	wan: [wanL1] LCP: rec'd Configure Request #229 (Req-Sent)
    Mar 27 21:11:23 	wan: [wanL1] MRU 1492
    Mar 27 21:11:23 	wan: [wanL1] AUTHPROTO PAP
    Mar 27 21:11:23 	wan: [wanL1] MAGICNUM 11586446
    Mar 27 21:11:23 	wan: [wanL1] LCP: SendConfigAck #229
    Mar 27 21:11:23 	wan: [wanL1] MRU 1492
    Mar 27 21:11:23 	wan: [wanL1] AUTHPROTO PAP
    Mar 27 21:11:23 	wan: [wanL1] MAGICNUM 11586446
    Mar 27 21:11:23 	wan: [wanL1] xmit frame to link proto=0xc021
    Mar 27 21:11:23 	wan: ff 03 c0 21 02 e5 00 12 01 04 05 d4 03 04 c0 23 ...!...........#
    Mar 27 21:11:23 	wan: 05 06 11 58 64 46 ...XdF
    Mar 27 21:11:23 	wan: [wanL1] LCP: state change Req-Sent --> Ack-Sent
    Mar 27 21:11:23 	wan: [wanL1] rec'd 16 bytes frame from link proto=0xc021
    Mar 27 21:11:23 	wan: c0 21 02 01 00 0e 01 04 05 d4 05 06 a2 09 be 22 .!............."
    Mar 27 21:11:23 	wan: [wanL1] LCP: rec'd Configure Ack #1 (Ack-Sent)
    Mar 27 21:11:23 	wan: [wanL1] MRU 1492
    Mar 27 21:11:23 	wan: [wanL1] MAGICNUM a209be22
    Mar 27 21:11:23 	wan: [wanL1] LCP: state change Ack-Sent --> Opened
    Mar 27 21:11:23 	wan: [wanL1] LCP: auth: peer wants PAP, I want nothing
    Mar 27 21:11:23 	wan: [wanL1] PAP: using authname "XXX"
    Mar 27 21:11:23 	wan: [wanL1] PAP: sending REQUEST #1 len: 55
    Mar 27 21:11:23 	wan: [wanL1] xmit frame to link proto=0xc023
    Mar 27 21:11:23 	wan: ff 03 c0 23 01 01 00 37 29 30 30 31 36 34 34 31 ...#...7)
    	[killed some lines with my login data]
    Mar 27 21:11:23 	wan: [wanL1] LCP: LayerUp
    Mar 27 21:11:23 	wan: [wanL1] rec'd 7 bytes frame from link proto=0xc023
    Mar 27 21:11:23 	wan: c0 23 02 01 00 05 00 .#.....
    Mar 27 21:11:23 	wan: [wanL1] PAP: rec'd ACK #1 len: 5
    Mar 27 21:11:23 	wan: [wanL1] LCP: authorization successful
    Mar 27 21:11:23 	wan: [wanL1] Link: Matched action 'bundle "wan" ""'
    Mar 27 21:11:23 	wan: [wanL1] Link: Join bundle "wan"
    Mar 27 21:11:23 	wan: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
    Mar 27 21:11:23 	wan: [wan] IPCP: Open event
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Initial --> Starting
    Mar 27 21:11:23 	wan: [wan] IPCP: LayerStart
    Mar 27 21:11:23 	wan: [wan] IPCP: Up event
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Starting --> Req-Sent
    Mar 27 21:11:23 	wan: [wan] IPCP: SendConfigReq #1
    Mar 27 21:11:23 	wan: [wan] IPADDR 0.0.0.0
    Mar 27 21:11:23 	wan: [wan] PRIDNS 0.0.0.0
    Mar 27 21:11:23 	wan: [wan] SECDNS 0.0.0.0
    Mar 27 21:11:23 	wan: [wan] xmit bypass frame link=-1 proto=0x8021
    Mar 27 21:11:23 	wan: ff ff 80 21 01 01 00 16 03 06 00 00 00 00 81 06 ...!............
    Mar 27 21:11:23 	wan: 00 00 00 00 83 06 00 00 00 00 ..........
    Mar 27 21:11:23 	wan: [wanL1] rec'd 12 bytes frame from link proto=0x8021
    Mar 27 21:11:23 	wan: 80 21 01 91 00 0a 03 06 57 ba e0 79 .!......W..y
    Mar 27 21:11:23 	wan: [wan] IPCP: rec'd Configure Request #145 (Req-Sent)
    Mar 27 21:11:23 	wan: [wan] IPADDR 87.186.224.121
    Mar 27 21:11:23 	wan: [wan] 87.186.224.121 is OK
    Mar 27 21:11:23 	wan: [wan] IPCP: SendConfigAck #145
    Mar 27 21:11:23 	wan: [wan] IPADDR 87.186.224.121
    Mar 27 21:11:23 	wan: [wan] xmit bypass frame link=-1 proto=0x8021
    Mar 27 21:11:23 	wan: ff ff 80 21 02 91 00 0a 03 06 57 ba e0 79 ...!......W..y
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Req-Sent --> Ack-Sent
    Mar 27 21:11:23 	wan: [wan] rec'd 22 bytes bypass frame link=0 proto=0x8021
    Mar 27 21:11:23 	wan: 03 01 00 16 03 06 5d cd 7e be 81 06 d9 00 2b a1 ......].~.....+.
    Mar 27 21:11:23 	wan: 83 06 d9 00 2b b1 ....+.
    Mar 27 21:11:23 	wan: [wan] IPCP: rec'd Configure Nak #1 (Ack-Sent)
    Mar 27 21:11:23 	wan: [wan] IPADDR 93.205.126.190
    Mar 27 21:11:23 	wan: [wan] 93.205.126.190 is OK
    Mar 27 21:11:23 	wan: [wan] PRIDNS 217.0.43.161
    Mar 27 21:11:23 	wan: [wan] SECDNS 217.0.43.177
    Mar 27 21:11:23 	wan: [wan] IPCP: SendConfigReq #2
    Mar 27 21:11:23 	wan: [wan] IPADDR 93.205.126.190
    Mar 27 21:11:23 	wan: [wan] PRIDNS 217.0.43.161
    Mar 27 21:11:23 	wan: [wan] SECDNS 217.0.43.177
    Mar 27 21:11:23 	wan: [wan] xmit bypass frame link=-1 proto=0x8021
    Mar 27 21:11:23 	wan: ff ff 80 21 01 02 00 16 03 06 5d cd 7e be 81 06 ...!......].~...
    Mar 27 21:11:23 	wan: d9 00 2b a1 83 06 d9 00 2b b1 ..+.....+.
    Mar 27 21:11:23 	wan: [wan] rec'd 22 bytes bypass frame link=0 proto=0x8021
    Mar 27 21:11:23 	wan: 02 02 00 16 03 06 5d cd 7e be 81 06 d9 00 2b a1 ......].~.....+.
    Mar 27 21:11:23 	wan: 83 06 d9 00 2b b1 ....+.
    Mar 27 21:11:23 	wan: [wan] IPCP: rec'd Configure Ack #2 (Ack-Sent)
    Mar 27 21:11:23 	wan: [wan] IPADDR 93.205.126.190
    Mar 27 21:11:23 	wan: [wan] PRIDNS 217.0.43.161
    Mar 27 21:11:23 	wan: [wan] SECDNS 217.0.43.177
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Ack-Sent --> Opened
    Mar 27 21:11:23 	wan: [wan] IPCP: LayerUp
    Mar 27 21:11:23 	wan: [wan] 93.205.126.190 -> 87.186.224.121
    Mar 27 21:11:23 	wan: [wan] IPCP: parameter negotiation failed
    	[negotiation failed?!]
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Opened --> Stopping
    Mar 27 21:11:23 	wan: [wan] IPCP: SendTerminateReq #3
    Mar 27 21:11:23 	wan: [wan] xmit bypass frame link=-1 proto=0x8021
    Mar 27 21:11:23 	wan: ff ff 80 21 05 03 00 04 ...!....
    Mar 27 21:11:23 	wan: [wan] IPCP: LayerDown
    Mar 27 21:11:23 	wan: [wan] rec'd 4 bytes bypass frame link=0 proto=0x8021
    Mar 27 21:11:23 	wan: 06 03 00 04 ....
    Mar 27 21:11:23 	wan: [wan] IPCP: rec'd Terminate Ack #3 (Stopping)
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Stopping --> Stopped
    Mar 27 21:11:23 	wan: [wan] IPCP: LayerFinish
    Mar 27 21:11:23 	wan: [wan] Bundle: No NCPs left. Closing links...
    Mar 27 21:11:23 	wan: [wan] Bundle: closing link "wanL1"...
    Mar 27 21:11:23 	wan: [wan] rec'd 4 bytes bypass frame link=0 proto=0xc021
    Mar 27 21:11:23 	wan: 05 e6 00 04 ....
    Mar 27 21:11:23 	wan: [wanL1] LCP: rec'd Terminate Request #230 (Opened)
    Mar 27 21:11:23 	wan: [wanL1] LCP: state change Opened --> Stopping
    Mar 27 21:11:23 	wan: [wanL1] Link: Leave bundle "wan"
    Mar 27 21:11:23 	wan: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps
    Mar 27 21:11:23 	wan: [wan] IPCP: Close event
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Stopped --> Closed
    Mar 27 21:11:23 	wan: [wan] IPCP: Down event
    Mar 27 21:11:23 	wan: [wan] IPCP: state change Closed --> Initial
    Mar 27 21:11:23 	wan: [wanL1] LCP: SendTerminateAck #2
    Mar 27 21:11:23 	wan: [wanL1] xmit frame to link proto=0xc021
    Mar 27 21:11:23 	wan: ff 03 c0 21 06 02 00 04 ...!....
    Mar 27 21:11:23 	wan: [wanL1] LCP: LayerDown
    Mar 27 21:11:23 	wan: [wanL1] Link: CLOSE event
    Mar 27 21:11:23 	wan: [wanL1] LCP: Close event
    Mar 27 21:11:23 	wan: [wanL1] LCP: state change Stopping --> Closing
    Mar 27 21:11:24 	wan: [wanL1] PPPoE: connection closed
    Mar 27 21:11:24 	wan: [wanL1] Link: DOWN event
    Mar 27 21:11:24 	wan: [wanL1] LCP: Down event
    Mar 27 21:11:24 	wan: [wanL1] LCP: LayerFinish
    Mar 27 21:11:24 	wan: [wanL1] LCP: state change Closing --> Initial
    Mar 27 21:11:53 	wan: caught fatal signal term
    Mar 27 21:11:53 	wan: [wan] IFACE: Close event
    Mar 27 21:11:53 	wan: [wan] IPCP: Close event
    Mar 27 21:11:55 	wan: [wan] Bundle: Shutdown
    Mar 27 21:11:55 	wan: [wanL1] Link: Shutdown
    Mar 27 21:11:55 	wan: process 32841 terminated
    Mar 27 21:11:55 	wan: Multi-link PPP daemon for FreeBSD
    	[and so on...]
    
    


  • im going back from 22nd to the 4th march nanobsd coz that DHCP issue is giving me a lot of pain, keeps crashing in under 24hrs leaving all clients without net access.



  • Can you please try this fix
    https://rcs.pfsense.org/projects/pfsense/repos/mainline/commits/5ca41f8b4f70dbe45d14c74349657a60f0b6bbde

    Please test that before i delve into something else.



  • fix works :)

    thx

    Mar 28 23:09:35 	wan: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
    Mar 28 23:09:35 	wan: [wan] IPADDR 93.205.112.166
    Mar 28 23:09:35 	wan: [wan] PRIDNS 217.0.43.161
    Mar 28 23:09:35 	wan: [wan] SECDNS 217.0.43.177
    Mar 28 23:09:35 	wan: [wan] IPCP: state change Ack-Sent --> Opened
    Mar 28 23:09:35 	wan: [wan] IPCP: LayerUp
    Mar 28 23:09:35 	wan: [wan] 93.205.112.166 -> 87.186.224.121
    Mar 28 23:09:35 	wan: [wan] IFACE: Up event
    


  • confirmed, pppoe works

    some other issues

    Starting syslog…Mar 29 10:08:34  syslogd: /var/log/l2tp.log: No such file or directory
    done.
    (i checked in /var/log and there exists a file name of  lt2p.log so that might be the cause)

    Mar 29 06:08:42 	php: : The command '/bin/ln /etc/hosts /var/etc/hosts' returned exit code '1', the output was 'ln: /var/etc/hosts: File exists'
    Mar 29 06:08:42 	php: : The command '/usr/local/sbin/dhcpleases /var/dhcpd/var/db/dhcpd.leases pfsense /var/run/dnsmasq.pid /var/etc/hosts' returned exit code '3', the output was 'The leases file passed as argument does not exist.: No such file or directory'
    
    Mar 29 10:09:04 	php: : The command 'route add -host 195.229.252.33' returned exit code '1', the output was 'route: writing to routing socket: Invalid argument add host 195.229.252.33: Invalid argument'
    Mar 29 10:09:04 	php: : The command 'route add -host 195.229.252.33' returned exit code '1', the output was 'route: writing to routing socket: Invalid argument add host 195.229.252.33: Invalid argument'
    


  • Thanks should be ok on latest snaps.



  • Hi all

    THANKS!! The latest Snapshot 20100331 work again with pppoE

    GREAT JOB!

    Peter


Log in to reply