[RESOLVED] issues on 26th march snapshot
-
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/5ca41f8b4f70dbe45d14c74349657a60f0b6bbdePlease 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