Bug 3008

Summary: All machines fail to boot through UNFS (nightly build 20120822-1)
Product: [Runtime] General Runtime Reporter: liang li <liang.li2>
Component: General RuntimeAssignee: Saul Wold <sgw>
Status: VERIFIED FIXED QA Contact:
Severity: normal    
Priority: High CC: corneliux.stoicescu, jiajun.xu, laurentiu.serban, poky.bs.watcher, poky.watcher, Qi.Chen, sgw, yi.zhao
Version: 1.3   
Target Milestone: 1.3 M4   
Hardware: x86   
OS: Multiple   
Whiteboard: (Patch Review)
OS type for building Yocto: --- Type of Regression: ---
Verified: Documentation change: ---
Attachments:
Description Flags
routerstationpro boot log none

Description liang li 2012-08-24 08:58:46 UTC
nightly build 20120822-1 images from :
http://autobuilder.pokylinux.org/nightly/20120822-1/machines/qemu/

when use "runqemu nfs kernel rootfs nographic" to boot up the qemu images, following error met (for example  "runqemu nfs vmlinux-3.4.7+git6+28bcd46af1d592dab39bd8a0891c872454fde8bc_1+492560e2f9a6864c5b4bbb24a35631c182fa35a5-r4.0-qemuppc-20120822141902.bin /opt/poky/temp/ nographic"):

.......
Running qemu-system-ppc...
/opt/poky/1.2+snapshot/sysroots/x86_64-pokysdk-linux/usr/bin/qemu-system-ppc -kernel /home/liangli/kernel_8_22/vmlinux-3.4.7+git6+28bcd46af1d592dab39bd8a0891c872454fde8bc_1+492560e2f9a6864c5b4bbb24a35631c182fa35a5-r4.0-qemuppc-20120822141902.bin -net nic,model=pcnet -net tap,vlan=0,ifname=tap0,script=no,downscript=no -cpu G4 -M mac99 -no-reboot -show-cursor -usb -usbdevice wacom-tablet -no-reboot -nographic -m 128 --append "root=/dev/nfs console=ttyS0 console=tty nfsroot=192.168.7.1:/opt/poky/temp/,nfsvers=2,mountprog=21111,nfsprog=11111,udp,port=3049,mountport=3048 rw ip=192.168.7.2::192.168.7.1:255.255.255.0 mem=128M console=ttyS0"
>> Cannot manage 'OHCI USB controller' PCI device type 'usb':
>>  106b 3f (c 3 10)

>> =============================================================
>> OpenBIOS 1.0 [Jun 16 2011 08:02]
>> Configuration device id QEMU version 1 machine id 1
>> CPUs: 1
>> Memory: 128M
>> UUID: 00000000-0000-0000-0000-000000000000
>> CPU type PowerPC,G4
Welcome to OpenBIOS v1.0 built on Jun 16 2011 08:02
>> [ppc] Kernel already loaded (0x01000000 + 0x0088c23c) (initrd 0x00000000 + 0x00000000)
>> [ppc] Kernel command line: root=/dev/nfs console=ttyS0 console=tty nfsroot=192.168.7.1:/opt/poky/temp/,nfsvers=2,mountprog=21111,nfsprog=11111,udp,port=3049,mountport=3048 rw ip=192.168.7.2::192.168.7.1:255.255.255.0 mem=128M  console=ttyS0
OF stdout device is: /pci@f2000000/mac-io@e/escc@13000/ch-b@13000
Preparing to boot Linux version 3.4.7-yocto-standard (pokybuild@autobuilder05) (gcc version 4.7.2 20120706 (prerelease) (GCC) ) #1 PREEMPT Wed Aug 22 07:51:39 PDT 2012
Detected machine type: 00000400
command line: 
memory layout at init:
  memory_limit : 00000000 (16 MB aligned)
  alloc_bottom : 01891000
  alloc_top    : 08000000
  alloc_top_hi : 08000000
  rmo_top      : 08000000
  ram_top      : 08000000
found display   : /pci@f2000000/QEMU,VGA@c, opening... done
copying OF device tree...
Building dt strings...
Building dt structure...
Device tree strings 0x01892000 -> 0x018924aa
Device tree struct  0x01893000 -> 0x01895000
Calling quiesce...
returning from prom_init
console [ttyS0] enabled, bootconsole disabled
pid_max: default: 32768 minimum: 301
Security Framework initialized
Mount-cache hash table entries: 512
Initializing cgroup subsys debug
Initializing cgroup subsys cpuacct
Initializing cgroup subsys memory
Initializing cgroup subsys devices
Initializing cgroup subsys freezer
Initializing cgroup subsys net_cls
Initializing cgroup subsys blkio
ftrace: allocating 18295 entries in 54 pages
devtmpfs: initialized
NET: Registered protocol family 16
PCI: Probing PCI hardware
PCI host bridge to bus 0000:00
pci_bus 0000:00: root bus resource [io  0x0000-0x7fffff]
pci_bus 0000:00: root bus resource [mem 0x80000000-0x8fffffff]
bio: create slab <bio-0> at 0
vgaarb: device added: PCI:0000:00:0c.0,decodes=io+mem,owns=io+mem,locks=none
vgaarb: loaded
vgaarb: bridge control possible 0000:00:0c.0
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
Switching to clocksource timebase
NET: Registered protocol family 2
IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
TCP established hash table entries: 4096 (order: 3, 32768 bytes)
TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
TCP: Hash tables configured (established 4096 bind 4096)
TCP: reno registered
UDP hash table entries: 256 (order: 0, 4096 bytes)
UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
NET: Registered protocol family 1
RPC: Registered named UNIX socket transport module.
RPC: Registered udp transport module.
RPC: Registered tcp transport module.
RPC: Registered tcp NFSv4.1 backchannel transport module.
VFS: Disk quotas dquot_6.5.2
Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Registering unionfs 2.5.10 (for 3.1.0-rc4)
NFS: Registering the id_resolver key type
Btrfs loaded
msgmni has been set to 235
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
io scheduler noop registered
io scheduler deadline registered
io scheduler cfq registered (default)
Using unsupported 800x600 QEMU,VGA at 80000000, depth=15, pitch=1600
Console: switching to colour frame buffer device 100x37
fb0: Open Firmware frame buffer device on /pci@f2000000/QEMU,VGA@c
pmac_zilog: 0.6 (Benjamin Herrenschmidt <benh@kernel.crashing.org>)
brd: module loaded
MacIO PCI driver attached to Keylargo chipset
0.00013020:ch-a: ttyS0 at MMIO 0x80893020 (irq = 37) is a Z85c30 ESCC - Serial port
0.00013000:ch-b: ttyS1 at MMIO 0x80893000 (irq = 36) is a Z85c30 ESCC - Serial port
Macintosh CUDA driver v0.5 for Unified ADB.
Uniform Multi-Platform E-IDE driver
adb: starting probe task...
ADB keyboard at 2, handler set to 3
Detected ADB keyboard, type ANSI.
input: ADB keyboard as /devices/virtual/input/input0
ADB mouse at 3, handler set to 2
input: ADB mouse as /devices/virtual/input/input1
adb: finished probe task...
ide-pmac: Found Apple Heathrow ATA controller (macio), bus ID 0, irq 17
ide0 at 0xc9018000-0xc9018070,0xc9018160 on irq 17
ide-pmac: Found Apple Heathrow ATA controller (macio), bus ID 0, irq 19
hdc: QEMU DVD-ROM, ATAPI CD/DVD-ROM drive
hdc: MWDMA2 mode selected
ide1 at 0xc901a000-0xc901a070,0xc901a160 on irq 19
ide-pmac: Found Apple Heathrow ATA controller (macio), bus ID 0, irq 21
ide2 at 0xc9024000-0xc9024070,0xc9024160 on irq 21
ide-gd driver 1.18
pcnet32: pcnet32.c:v1.35 21.Apr.2008 tsbogend@alpha.franken.de
pcnet32: PCnet/PCI II 79C970A at 0x400, 52:54:00:12:34:56 assigned IRQ 27
pcnet32: eth0: registered as PCnet/PCI II 79C970A
pcnet32: 1 cards_found
ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
ohci_hcd 0000:00:0f.0: OHCI Host Controller
ohci_hcd 0000:00:0f.0: new USB bus registered, assigned bus number 1
ohci_hcd 0000:00:0f.0: irq 27, io mem 0x80900000
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 3 ports detected
mousedev: PS/2 mouse device common for all mice
usbcore: registered new interface driver wacom
md: linear personality registered for level -1
md: raid0 personality registered for level 0
md: raid1 personality registered for level 1
md: raid10 personality registered for level 10
md: multipath personality registered for level -4
md: faulty personality registered for level -5
device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@redhat.com
usbcore: registered new interface driver usbhid
usbhid: USB HID core driver
oprofile: using timer interrupt.
TCP: cubic registered
NET: Registered protocol family 10
IPv6 over IPv4 tunneling driver
NET: Registered protocol family 17
Registering the dns_resolver key type
console [netcon0] enabled
netconsole: network logging started
usb 1-1: new full-speed USB device number 2 using ohci_hcd
pcnet32 0000:00:0d.0: eth0: link up
IP-Config: Complete:
     device=eth0, addr=192.168.7.2, mask=255.255.255.0, gw=192.168.7.1
     host=192.168.7.2, domain=, nis-domain=(none)
     bootserver=255.255.255.255, rootserver=192.168.7.1, rootpath=
md: Waiting for all devices to be available before autodetect
md: If you don't use raid, use raid=noautodetect
md: Autodetecting RAID arrays.
md: Scanned 0 and added 0 devices.
md: autorun ...
md: ... autorun DONE.
input: Wacom Penpartner as /devices/pci0000:00/0000:00:0f.0/usb1/1-1/1-1:1.0/input/input2
VFS: Mounted root (nfs filesystem) on device 0:13.
devtmpfs: mounted
Freeing unused kernel memory: 288k freed
INIT: version 2.88 booting
Starting udev
udev[50]: starting version 164
Starting Bootlog daemon: bootlogd.
ALSA: Restoring mixer settings...
/usr/sbin/alsactl: load_state:1686: No soundcards found...
Configuring network interfaces... done.
Starting portmap daemon...
Unknown HZ value! (94) Assume 100.
net.ipv4.conf.default.rp_filter = 1
net.ipv4.conf.all.rp_filter = 1
hwclock: can't open '/dev/misc/rtc': No such file or directory
INIT: Entering runlevel: 5
Starting system message bus: dbus.
Starting Connection Manager
Starting OpenBSD Secure Shell server: sshd
  generating ssh RSA key...
Bad SWSTYLE=0x04
nfs: server 192.168.7.1 not responding, still trying

the qemu hung here and can not bootup.
----------------------
the error "nfs: server 192.168.7.1 not responding, still trying" met on both qemux86,qemux86_64,qemuppc and qemumips and all qemu target can not bootup.
----------------------
if "nographic" not used ,the qemu hung and desktop of qemu can not be found.
Comment 1 Yi Zhao 2012-08-28 02:08:39 UTC
Created attachment 739 [details]
routerstationpro boot log
Comment 2 Yi Zhao 2012-08-28 02:09:55 UTC
This issue also happens on routerstationpro and mpc8315e-rdb when booting through NFS.
Comment 3 Yi Zhao 2012-08-28 06:05:23 UTC
Looks like the connman causes this failure. The current version of connman is 1.4. When I using an old version 1.3 from 1.3_M3 instead, the system can boot.
Comment 4 Saul Wold 2012-08-29 18:06:25 UTC
*** Bug 3038 has been marked as a duplicate of this bug. ***
Comment 5 Saul Wold 2012-08-29 21:47:55 UTC
Please check your firewall settings, I was having a problem also and it was pointed out that I should check them, once I disabled the firewall it all magically started to work again.
Comment 6 Yi Zhao 2012-08-30 07:19:08 UTC
(In reply to comment #5)
> Please check your firewall settings, I was having a problem also and it was
> pointed out that I should check them, once I disabled the firewall it all
> magically started to work again.

On our hosts (Ubuntu 12.04 x86_64, Fedora 17 x86_64, openSuse 12.1 x86_64), there is no firewall running. The sato and sato-sdk rootfs can not boot up via NFS, but the minimal rootfs can boot because it doesn't use connman as the network manager.
Comment 7 Saul Wold 2012-08-30 19:51:26 UTC
I can reproduce this locally, it's connman related and seems to do with the -P option.
Comment 8 Saul Wold 2012-08-30 23:49:33 UTC
The problem was the routes where getting cleaned up when the connmand started causing the network to go away and NFS gets dropped.

Adding -I for nfs start up solved this, patch is sent
Comment 10 liang li 2012-09-10 05:47:29 UTC
no such error when using qemuppc sato and sato-sdk images built locally with newest master branch:
git info:5343cdb20ee56a8b507733c637dcc2466ae13288
test env: ubuntu 12.04 x86_64
Comment 11 liang li 2012-09-11 05:38:15 UTC
(In reply to comment #10)
> no such error when using qemuppc sato and sato-sdk images built locally with
> newest master branch:
> git info:5343cdb20ee56a8b507733c637dcc2466ae13288
> test env: ubuntu 12.04 x86_64

if "nographic" not used ,the qemu still hung and desktop of qemu can not be found.
Comment 12 Yi Zhao 2012-09-11 10:25:25 UTC
(In reply to comment #11)
> (In reply to comment #10)
> > no such error when using qemuppc sato and sato-sdk images built locally with
> > newest master branch:
> > git info:5343cdb20ee56a8b507733c637dcc2466ae13288
> > test env: ubuntu 12.04 x86_64
> 
> if "nographic" not used ,the qemu still hung and desktop of qemu can not be
> found.

This is because the xserver-xorg package doesn't install. We have opened a new bug 3089 to report it.
Comment 13 Laurentiu Serban 2012-09-24 23:24:03 UTC
verified in 1.3 M4 RC3
Comment 14 Laurentiu Serban 2012-09-24 23:24:54 UTC
commit id e5c3513ca8abb21eb5e9b8c19d1b9199b14ae07c