12-Apr-2014 to 13-Apr-2014 Can't find kernel

Raul Ramos · Apr 13, 2014, 5:18 PM

Hi

12-Apr-2014 - fail on boot with message can't find kernel and the build is a few Megs short (70581761).

Update 13-Apr-2014: oh c'mon this is short to. missing kernel ? i will try tomorrow and give feedback.

well…keep coming :)

Thanks

phil.davis · Apr 14, 2014, 1:49 AM

I guess you used the full install?
The 2.2-DEVELOPMENT upgrade images are actually bigger than normal. Anyone tried those? Or will I be the bunny to see if they are any good or not?
Wish we could see the boot log and the pfSense-tools repo to know what might be going wrong.

phil.davis · Apr 14, 2014, 5:31 AM

2.2-ALPHA (i386)
built on Sun Apr 13 15:35:58 CDT 2014
FreeBSD 10.0-STABLE

I upgraded an Alix 2D13 with the 2GB image pfSense-2.2-DEVELOPMENT-2g-i386-nanobsd-upgrade-20140413-1535.img.gz and it has worked. I even got my ath0 WiFi Access Point device for the first time in 2.2, and am posting across said WiFi.
There are a bunch of messages on the console during boot about log files that cannot be found. I will have a quick look at that now. But internet works.
Console boot output:

1  pfSense
2  pfSense

F6 PXE
Boot:  2
/boot/config: -h
Consoles: serial port
BIOS drive C: is disk0
BIOS 640kB/261120kB available memory

FreeBSD/x86 bootstrap loader, Revision 1.1
(root@builder-10-0-b3-i386, Sun Apr 13 16:13:40 CDT 2014)
Loading /boot/defaults/loader.conf
/boot/kernel/kernel text=0x10ea59d data=0x71cad0+0x1f9be8 syms=[0x4+0xea770+0x4+0x15f89e]

Hit [Enter] to boot immediately, or any other key for command prompt.
Booting [/boot/kernel/kernel]...
KDB: debugger backends: ddb
KDB: current backend: ddb
Copyright (c) 1992-2014 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
        The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 10.0-STABLE #0 fde2f5e(HEAD)-dirty: Sun Apr 13 16:31:11 CDT 2014
    root@builder-10-0-b3-i386:/usr/obj.pfSense/usr/pfSensesrc/src/sys/pfSense_wrap.10.i386 i386
FreeBSD clang version 3.3 (tags/RELEASE_33/final 183502) 20130610
CPU: Geode(TM) Integrated Processor by AMD PCS (498.06-MHz 586-class CPU)
  Origin = "AuthenticAMD"  Id = 0x5a2  Family = 0x5  Model = 0xa  Stepping = 2
  Features=0x88a93d <fpu,de,pse,tsc,msr,cx8,sep,pge,cmov,clflush,mmx>AMD Features=0xc0400000 <mmx+,3dnow!+,3dnow!>real memory  = 268435456 (256 MB)
avail memory = 226328576 (215 MB)
pnpbios: Bad PnP BIOS data checksum
random device not loaded; using insecure entropy
ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
module_register_init: MOD_LOAD (ipw_bss_fw, 0xc07cb680, 0) error 1
ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
module_register_init: MOD_LOAD (ipw_ibss_fw, 0xc07cb730, 0) error 1
ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
module_register_init: MOD_LOAD (ipw_monitor_fw, 0xc07cb7e0, 0) error 1
iwi_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
iwi_bss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
module_register_init: MOD_LOAD (iwi_bss_fw, 0xc07f1ca0, 0) error 1
iwi_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
iwi_ibss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
module_register_init: MOD_LOAD (iwi_ibss_fw, 0xc07f1d50, 0) error 1
iwi_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
iwi_monitor: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
module_register_init: MOD_LOAD (iwi_monitor_fw, 0xc07f1e00, 0) error 1
wlan: mac acl policy registered
K6-family MTRR support enabled (2 registers)
random: <software, yarrow="">initialized
ACPI BIOS Error (bug): A valid RSDP was not found (20130823/tbxfroot-223)
ACPI: Table initialisation failed: AE_NOT_FOUND
ACPI: Try disabling either ACPI or apic support.
cryptosoft0: <software crypto="">on motherboard
padlock0: No ACE support.
pcib0 pcibus 0 on motherboard
pci0: <pci bus="">on pcib0
Geode LX: PC Engines ALIX.2 v0.99h tinyBIOS V1.4a (C)1997-2007
pci0: <encrypt decrypt,="" entertainment="" crypto="">at device 1.2 (no driver attached)
vr0: <via 10="" vt6105m="" rhine="" iii="" 100basetx="">port 0x1000-0x10ff mem 0xe0000000-0xe00000ff irq 10 at device 9.0 on pci0
vr0: Quirks: 0x2
vr0: Revision: 0x96
miibus0: <mii bus="">on vr0
ukphy0: <generic ieee="" 802.3u="" media="" interface="">PHY 1 on miibus0
ukphy0:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
vr1: <via 10="" vt6105m="" rhine="" iii="" 100basetx="">port 0x1400-0x14ff mem 0xe0040000-0xe00400ff irq 11 at device 10.0 on pci0
vr1: Quirks: 0x2
vr1: Revision: 0x96
miibus1: <mii bus="">on vr1
ukphy1: <generic ieee="" 802.3u="" media="" interface="">PHY 1 on miibus1
ukphy1:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
vr2: <via 10="" vt6105m="" rhine="" iii="" 100basetx="">port 0x1800-0x18ff mem 0xe0080000-0xe00800ff irq 15 at device 11.0 on pci0
vr2: Quirks: 0x2
vr2: Revision: 0x96
miibus2: <mii bus="">on vr2
ukphy2: <generic ieee="" 802.3u="" media="" interface="">PHY 1 on miibus2
ukphy2:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow
ath0: <atheros 5212="">mem 0xe00c0000-0xe00cffff irq 9 at device 12.0 on pci0
ath0: AR5212 mac 5.9 RF5112 phy 4.3
ath0: 2GHz radio: 0x0000; 5GHz radio: 0x0036
isab0: <pci-isa bridge="">port 0x6000-0x6007,0x6100-0x61ff,0x6200-0x623f,0x9d00-0x9d7f,0x9c00-0x9c3f at device 15.0 on pci0
isa0: <isa bus="">on isab0
atapci0: <amd cs5536="" udma100="" controller="">port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xff00-0xff0f at device 15.2 on pci0
ata0: <ata channel="">at channel 0 on atapci0
ata1: <ata channel="">at channel 1 on atapci0
ohci0: <ohci (generic)="" usb="" controller="">mem 0xefffe000-0xefffefff irq 12 at device 15.4 on pci0
usbus0 on ohci0
ehci0: <amd cs5536="" (geode)="" usb="" 2.0="" controller="">mem 0xefffd000-0xefffdfff irq 12 at device 15.5 on pci0
usbus1: EHCI version 1.0
usbus1 on ehci0
cpu0 on motherboard
pmtimer0 on isa0
orm0: <isa option="" rom="">at iomem 0xe0000-0xea7ff pnpid ORM0000 on isa0
atrtc0: <at realtime="" clock="">at port 0x70 irq 8 on isa0
Event timer "RTC" frequency 32768 Hz quality 0
attimer0: <at timer="">at port 0x40 on isa0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
ppc0: parallel port not found.
uart0: <16550 or compatible> at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
uart0: console (9600,n,8,1)
uart1: <16550 or compatible> at port 0x2f8-0x2ff irq 3 on isa0
Timecounters tick every 1.000 msec
IPsec: Initialized Security Association Processing.
usbus0: 12Mbps Full Speed USB v1.0
usbus1: 480Mbps High Speed USB v2.0
ugen0.1: <amd>at usbus0
uhub0: <amd 1="" 9="" ohci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr="">on usbus0
ugen1.1: <amd>at usbus1
uhub1: <amd 1="" 9="" ehci="" root="" hub,="" class="" 0,="" rev="" 2.00="" 1.00,="" addr="">on usbus1
ada0 at ata0 bus 0 scbus0 target 0 lun 0
ada0: <sandisk sdcfh-002g="" hdx="" 6.02="">CFA-4 device
ada0: Serial Number DHZ080911003327
ada0: 16.700MB/s transfers (PIO4, PIO 512bytes)
ada0: 1907MB (3906560 512 byte sectors: 16H 63S/T 3875C)
ada0: Previously was known as ad0
random: unblocking device.
Timecounter "TSC" frequency 498061163 Hz quality 800
uhub0: 4 ports with 4 removable, self powered
Root mount waiting for: usbus1
Root mount waiting for: usbus1
uhub1: 4 ports with 4 removable, self powered
Trying to mount root from ufs:/dev/ufs/pfsense1 [ro,sync,noatime]...
Configuring crash dumps...
Mounting filesystems...
Setting up memory disks... done.
Disabling APM on /dev/ad0
(pass0:ata0:0:0:0): SETFEATURES. ACB: ef 85 00 00 00 40 00 00 00 00 00 00
(pass0:ata0:0:0:0): CAM status: ATA Status Error
(pass0:ata0:0:0:0): ATA status: 51 (DRDY SERV ERR), error: 04 (ABRT )
(pass0:ata0:0:0:0): RES: 51 04 00 00 00 00 00 00 00 00 00
Failed to configure APM: No such file or directory

     ___
 ___/ f \
/ p \___/ Sense
\___/   \
    \___/

Welcome to pfSense 2.2-ALPHA  ...

Creating symlinks....usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
usage: /usr/sbin/clog [-i -s log_size] [ -f ] log_file
chmod: /var/log/*.log: No such file or directory
..done.
>>> Under 512 megabytes of ram detected.  Not enabling APC.
Apr 14 10:40:11 system[280]: [NOTICE] fpm is running, pid 280
Apr 14 10:40:12 system[280]: [NOTICE] ready to handle connections
External config loader 1.0 is now starting...
Launching the init system... done.
Initializing............................. done.
Starting device manager (devd)...done.
Loading configuration......done.
Updating configuration...done.
Cleaning backup cache........done.
Setting up extended sysctls...done.
Setting timezone...done.
Configuring loopback interface...done.
Starting syslog...done.
Starting Secure Shell Services...done.
Setting up polling defaults...Apr 14 10:40:21  syslogd: /var/log/routing.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/ntpd.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/ppp.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/pptps.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/poes.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/l2tps.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/ipsec.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/openvpn.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/gateways.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/resolver.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/dhcpd.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/relayd.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/wireless.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/filter.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/vpn.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/portalauth.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/dhcpd.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:40:21  syslogd: /var/log/system.log: No such file or directory
done.
Setting up interfaces microcode...done.
Configuring loopback interface...done.
Creating wireless clone interfaces...done.
Configuring LAGG interfaces...done.
Configuring VLAN interfaces...done.
Configuring QinQ interfaces...done.
Configuring WAN interface...done.
Configuring LAN interface...done.
Configuring OPT1 interface...done.
Syncing OpenVPN settings...route: writing to routing socket: No such process
route: writing to routing socket: No such process
route: writing to routing socket: No such process
route: writing to routing socket: No such process
done.
Configuring firewall.route: writing to routing socket: No such process
.DUMMYNET 0 with IPv6 initialized (100409)
load_dn_sched dn_sched FIFO loaded
load_dn_sched dn_sched QFQ loaded
load_dn_sched dn_sched RR loaded
load_dn_sched dn_sched WF2Q+ loaded
load_dn_sched dn_sched PRIO loaded
....done.
Starting PFLOG...done.
Setting up gateway monitors...done.
Synchronizing user settings...done.
Starting webConfigurator...done.
Configuring CRON...done.
Starting DNS forwarder...done.
Starting NTP time client...done.
Starting DHCP service...done.
Configuring firewall.route: writing to routing socket: No such process
.....done.
Generating RRD graphs...done.
Starting syslog...done.
Apr 14 10:41:32  syslogd: /var/log/routing.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/ntpd.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/ppp.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/pptps.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/poes.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/l2tps.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/ipsec.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/openvpn.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/gateways.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/resolver.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/dhcpd.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/relayd.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/wireless.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/filter.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/vpn.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/portalauth.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/dhcpd.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/system.log: No such file or directory
Apr 14 10:41:32  syslogd: /var/log/system.log: No such file or directory
Starting CRON... done.
Bootup complete

FreeBSD/i386 (testoffice-rt-01.np.net.inf.org) (console)

*** Welcome to pfSense 2.2-ALPHA-nanobsd (i386) on testoffice-rt-01 ***

 WAN (wan)       -> vr0        -> v4/DHCP4: 10.49.223.200/24
 LAN (lan)       -> vr1        -> v4: 10.49.208.250/22
 OPT1 (opt1)     -> vr2        ->

 0) Logout (SSH only)                  8) Shell
 1) Assign Interfaces                  9) pfTop
 2) Set interface(s) IP address       10) Filter Logs
 3) Reset webConfigurator password    11) Restart webConfigurator
 4) Reset to factory defaults         12) pfSense Developer Shell
 5) Reboot system                     13) Upgrade from console
 6) Halt system                       14) Enable Secure Shell (sshd)
 7) Ping host                         15) Restore recent configuration

Enter an option:</sandisk></amd></amd></amd></amd></at></at></isa></amd></ohci></ata></ata></amd></isa></pci-isa></atheros></generic></mii></via></generic></mii></via></generic></mii></via></encrypt></pci></software></software,></mmx+,3dnow!+,3dnow!></fpu,de,pse,tsc,msr,cx8,sep,pge,cmov,clflush,mmx>

And sshd is not starting. I tried disabling it then enabling it again in System->Advanced, hoping it might regenerate keys, or whatever its problem is. There is actually an "sshd" binary. At the moment there are no log files in /var/log so I can't see what sshd is complaining about. Just a heads up for those trying this snapshot version, you might not be able to ssh in when it comes up, so make sure you have real console access before trying an upgrade.

Raul Ramos · Apr 14, 2014, 8:12 AM

the latest-nanobsd-vga-1g.img.gz (13-Apr-2014 22:01) doesn't work

"can't find 'kernel
Error while including /boot/menu.rc, in the line:
menu-display"

can't load kernel"

phil.davis · Apr 14, 2014, 9:08 AM

Crash report begins.  Anonymous machine information:

i386
10.0-STABLE
FreeBSD 10.0-STABLE #0 fde2f5e(HEAD)-dirty: Sun Apr 13 16:31:11 CDT 2014     root@builder-10-0-b3-i386:/usr/obj.pfSense/usr/pfSensesrc/src/sys/pfSense_wrap.10.i386

Crash report details:

PHP Errors:
[14-Apr-2014 14:25:36 Asia/Kathmandu] PHP Fatal error:  Call to undefined function susbstr() in /etc/rc.newwanip on line 98

And the rc.newwanip on this box indeed has the line 98:

if (($curwanip == "0.0.0.0" || !is_ipaddr($curwanip)) && susbstr($interface_real, 0, 4) != "ovpn") {

which has a typo "susbstr" should be "substr".

The Master pfSense repo does not have this change at all. It just has:

if($curwanip == "0.0.0.0" || !is_ipaddr($curwanip)) {

But I have a sense of deja-vu that I have seen the extra test in the new version somewhere, ah yes, it is in the 2.1 branch, recently committed:

if (($curwanip == "0.0.0.0" || !is_ipaddr($curwanip)) && susbstr($interface_real, 0, 4) != "ovpn") {

And that has the typo, I better point that out.

So, how does the 2.2-DEVELOPMENT snapshot have this bit of code from 2.1-branch?

What exactly is this snapshot that I am trying/testing?

phil.davis · Apr 14, 2014, 9:16 AM

And that has the typo, I better point that out.

Pull request submitted for that: https://github.com/pfsense/pfsense/pull/1084
After making that fix, my OPT1 2nd WAN seems happier to be physically unplugged, replugged, get a DHCP address and come up. ;)
This code was obviously committed without testing?
How does that happen?
Everyone, including those with commit access, should be testing code at least once on something before committing it. This one was broken and would never have passed any test.

eri-- · Apr 14, 2014, 10:41 AM

Yep fat finger.

I am the faulty one :)
Mostly because tested on VM and retyped on the code.
php does not help that it does not validate function names from std lib.

Regarding the commits that you donot see sometime its because the repos are completely internally hosted now and sync to github.
Hence even the read only on the repos allover.

phil.davis · Apr 14, 2014, 12:28 PM

There are a bunch of messages on the console during boot about log files that cannot be found. I will have a quick look at that now.

My config.xml has:

	 <syslog><nentries>100</nentries>
		<logfilesize>0</logfilesize>
		 <sourceip><ipproto>ipv4</ipproto></sourceip></syslog>

And /etc/rc feeds the log file size of zero to "clog", and it does not like it.
My /etc/rc and the one on GitHub pfSense Master are the same, so it seems it is not recent edit in this area. Perhaps when I changed the <nentries>value and saved, it also put "0" in the <logfilesize>, I will have a play with that now.</logfilesize></nentries>

Raul Ramos · Apr 14, 2014, 2:51 PM

nanobsd (1g) vga amd64

Apr 14 05:53:42 CDT 2014 -> can't find kernel

Update:
2.2-ALPHA (i386) built on Sun Apr 13 15:35:04 CDT 2014 - boots with stopped sshd and ipsec.

phil.davis · Apr 15, 2014, 3:26 AM

Sorry for hijacking this thread with the issue about boot messages. That actually turned out to be a "feature" in the way the new Log File Size option was implemented in Status: System logs: Settings
I have fixed that up with https://github.com/pfsense/pfsense/pull/1088
So I will stop my thread hijack now ;)

Edit: Confirmed working fine now on 2.2-ALPHA (i386) built on Mon Apr 14 15:07:07 CDT 2014

12-Apr-2014 to 13-Apr-2014 Can't find kernel

"can't find 'kernel Error while including /boot/menu.rc, in the line: menu-display"

"can't find 'kernel
Error while including /boot/menu.rc, in the line:
menu-display"