Boot android_x86 in VirtualBox through NFS

[Ye Roger]

I setup the boot environment to boot android_x86 in VirtualBox through NFS. All the setup looks good and I can load kernel and ramdisk without problem. I setup DEBUG=2 so that I can enter command line console during the boot. NFS filesystem can be mounted correctly, but the boot crashed somewhere. I try to debug where is the problem, do you have any idea how should I continue for the debugging ? What is script or program will be invoked after I exist from the command line ? Below is the log:

......

[    1.701138] Sending DHCP requests ., OK

[    1.711138] IP-Config: Got DHCP answer from 192.168.56.2, my address is 192.168.56.100

[    1.749793] IP-Config: Complete:

[    1.751722]      device=eth0, hwaddr=08:00:27:ce:b5:bf, ipaddr=192.168.56.100, mask=255.255.255.0, gw=255.255.255.255

[    1.752711]      host=192.168.56.100, domain=, nis-domain=(none)

[    1.753344]      bootserver=0.0.0.0, rootserver=0.0.0.0, rootpath=

[    1.753759]      nameserver0=192.168.56.2

[    1.754575] Freeing unused kernel memory: 540K (c186a000 - c18f1000)

+ exec

[    1.773483] random: env urandom read with 3 bits of entropy available

+ exec

Detecting Android-x86... found at 192.168.56.200:/media/Android-x86/

[    1.941184] usb 2-1: new full-speed USB device number 2 using ohci-pci

[    2.032316] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2

Type 'exit' to continue booting...

Running busybox ash...

/android # [    2.186637] usb 2-1: New USB device found, idVendor=80ee, idProduct=0021

[    2.203222] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0

[    2.223199] usb 2-1: Product: USB Tablet

[    2.223545] usb 2-1: Manufacturer: VirtualBox

[    2.243270] input: VirtualBox USB Tablet as /devices/pci0000:00/0000:00:06.0/usb2/2-1/2-1:1.0/0003:80EE:0021.0001/input/input4

[    2.252386] hid-generic 0003:80EE:0021.0001: input,hidraw0: USB HID v1.10 Mouse [VirtualBox USB Tablet] on usb-0000:00:06.0-1/input0

[    2.287120] Switched to clocksource tsc

[    3.885596] nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead.

/android # exit

[   50.947645] parport_pc 00:02: reported by Plug and Play ACPI

[   51.164115] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 11

[   51.476196] snd_intel8x0 0000:00:05.0: intel8x0_measure_ac97_clock: measured 51800 usecs (6240 samples)

[   51.477427] snd_intel8x0 0000:00:05.0: measured clock 120463 rejected

[   51.831137] snd_intel8x0 0000:00:05.0: intel8x0_measure_ac97_clock: measured 50956 usecs (7200 samples)

[   51.834199] snd_intel8x0 0000:00:05.0: measured clock 141298 rejected

[   52.186191] snd_intel8x0 0000:00:05.0: intel8x0_measure_ac97_clock: measured 50940 usecs (7200 samples)

[   52.195253] snd_intel8x0 0000:00:05.0: measured clock 141342 rejected

[   52.195941] snd_intel8x0 0000:00:05.0: clocking to 48000

[   52.237663] piix4_smbus 0000:00:07.0: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr

[   52.314921] input: PC Speaker as /devices/platform/pcspkr/input/input5

[   52.510236] uvesafb: Oracle CorporationOracle VM VirtualBox VBE AdapterOracle VM VirtualBox Version 4.3.20, Oracle VM VirtualBox VBE AdapterOracle VM VirtualBox Version 4.3.20, Oracle VM VirtualBox Version 4.3.20, OEM: VirtualBox VESA BIOSOracle CorporationOracle VM VirtualBox VBE AdapterOracle VM VirtualBox Version 4.3.20, VBE v2.0

[   52.557991] uvesafb: protected mode interface info at c000:4600

[   52.560007] uvesafb: pmi: set display start = c00c464f, set palette = c00c4710

[   52.565824] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input6

[   52.566646] uvesafb: pmi: ports = 1ce 1cf 1cf 1d0 3b6 3b7 

[   52.567405] uvesafb: no monitor limits have been set, default refresh rate will be used

[   52.569013] uvesafb: scrolling: redraw

[   52.575579] Console: switching to colour frame buffer device 100x37

[   52.581263] uvesafb: framebuffer at 0xe0000000, mapped to 0xf8380000, using 12288k, total 12288k

[   52.581900] fb0: VESA VGA frame buffer device

Use Alt-F1/F2/F3 to switch between virtual consoles

Type 'exit' to enter Android...

Running busybox ash...

/android # exit

[   66.012987] init: could not import file '/init.android_x86.rc' from '/init.rc'

[   66.148116] init: /dev/hw_random not found

             A N D R O I D [   66.925206] input: Android Power Button as /devices/virtual/input/input7

[   67.036784] init: /dev/hw_random not found

[   67.044029] init: Unable to read property file '/system/default.prop'

[   67.046644] init: Unable to read property file '/data/local.prop'

[   67.047916] init: Unable to open persistent property directory /data/property errno: 13

[   67.049890] healthd: BatteryHealthPath not found

[   67.051592] healthd: BatteryTemperaturePath not found

[   67.053655] binder: 1071:1071 transaction failed 29189, size 0-0

[   67.069308] init: Unable to write persistent property to temp file /data/property/.temp.rp2Krp errno: 13

[   67.079430] init: Unable to write persistent property to temp file /data/property/.temp.lEw7U2 errno: 13

[   67.084899] init: property 'sys.powerctl' doesn't exist while expanding '${sys.powerctl}'

[   67.101551] init: property 'sys.sysctl.extra_free_kbytes' doesn't exist while expanding '${sys.sysctl.extra_free_kbytes}'

[   67.115534] init: property 'sys.sysctl.tcp_def_init_rwnd' doesn't exist while expanding '${sys.sysctl.tcp_def_init_rwnd}'

[   67.361586] fs_mgr: Cannot open file /fstab.android_x86

[   67.440589] capability: warning: `rild' uses 32-bit capabilities (legacy support in use)

[   67.467857] random: nonblocking pool is initialized

root@x86:/ # [   67.566458] netpoll: netconsole: couldn't parse config at ''!

[   67.567192] netconsole: cleaning up

What happen after this ?

[  114.913116] nfs: server 192.168.56.200 not responding, still trying

[  114.914810] nfs: server 192.168.56.200 not responding, still trying

It seems the system hang at here and the network is disconnected. I cannot ping the ip 192.168.56.100.

Anybody know how the root file system is switched to "/android" ?

[Ye Roger]

I spent some time to try to figure out what happen. It seems the network is reset after switch_root. It is still look good after switch_root. Debugging init.rc and see where this happen.

[Ye Roger]

The problem is resolved now. I found it is a known issue reported at:

https://code.google.com/p/android/issues/detail?id=24335

I can boot from NFS without problem now.