Networking Support in VirtualBox

Christian Helmuth christian.helmuth at ...1...
Thu Jul 27 17:37:12 CEST 2017 

Chris,

some annotations of your log below that may help.

On Wed, Jul 26, 2017 at 09:58:11AM -0400, Chris Rothrock wrote:
> NOVA Microhypervisor v7-2006635 (x86_64): Jul 25 2017 11:23:13 [gcc 6.3.0]
> [MBI]
> 
> [ 0] TSC:3400000 kHz BUS:0 kHz DL
> [ 0] CORE:0:0:0 6:9e:9:1 [48] Intel(R) Core(TM) i5-7500 CPU @ 3.40GHz
> [ 3] CORE:0:3:0 6:9e:9:1 [48] Intel(R) Core(TM) i5-7500 CPU @ 3.40GHz
> [ 2] CORE:0:2:0 6:9e:9:1 [48] Intel(R) Core(TM) i5-7500 CPU @ 3.40GHz
> [ 1] CORE:0:1:0 6:9e:9:1 [48] Intel(R) Core(TM) i5-7500 CPU @ 3.40GHz
> [ 0] disabling super pages for DMAR
> Hypervisor features VMX
> Hypervisor reports 4x1 CPUs
> CPU ID (genode->kernel:package:core:thread) remapping
>  remap (0->0:0:0:0) boot cpu
>  remap (1->1:0:1:0)
>  remap (2->2:0:2:0)
>  remap (3->3:0:3:0)
> Hypervisor info page contains 26 memory descriptors:
> core     image  [0000000000100000,0000000002682000)
> binaries region [0000000000226000,0000000002682000) free for reuse
> detected physical memory: 0x0000000000000000 - size: 0x000000000008ec00
> use      physical memory: 0x0000000000000000 - size: 0x000000000008e000
> detected physical memory: 0x0000000000100000 - size: 0x00000000b2bfb000
> use      physical memory: 0x0000000000100000 - size: 0x00000000b2bfb000
> detected physical memory: 0x00000000b3aff000 - size: 0x0000000000001000
> use      physical memory: 0x00000000b3aff000 - size: 0x0000000000001000
> detected physical memory: 0x0000000100000000 - size: 0x000000013f800000
> use      physical memory: 0x0000000100000000 - size: 0x000000013f800000
> :virt_alloc: Allocator 0x1e76f0 dump:
>  Block: [0000000000002000,0000000000003000) size=4K avail=0 max_avail=0
>  Block: [0000000000003000,0000000000004000) size=4K avail=0 max_avail=0
>  Block: [0000000000004000,0000000000005000) size=4K avail=0 max_avail=0
>  Block: [0000000000005000,0000000000006000) size=4K avail=0 max_avail=0
>  Block: [0000000000006000,0000000000007000) size=4K avail=0 max_avail=0
>  Block: [0000000000007000,0000000000008000) size=4K avail=0 max_avail=0
>  Block: [0000000000008000,0000000000009000) size=4K avail=0 max_avail=0
>  Block: [0000000000009000,000000000000a000) size=4K avail=0 max_avail=0
>  Block: [000000000000a000,000000000000b000) size=4K avail=0 max_avail=0
>  Block: [000000000000b000,000000000000c000) size=4K avail=0 max_avail=0
>  Block: [000000000000c000,000000000000d000) size=4K avail=0 max_avail=0
>  Block: [000000000000d000,000000000000e000) size=4K avail=0 max_avail=0
>  Block: [000000000000e000,000000000000f000) size=4K avail=0 max_avail=0
>  Block: [000000000000f000,0000000000010000) size=4K avail=0 max_avail=0
>  Block: [0000000000010000,0000000000011000) size=4K avail=0 max_avail=0
>  Block: [0000000000011000,0000000000012000) size=4K avail=0 max_avail=0
>  Block: [0000000000012000,0000000000013000) size=4K avail=0 max_avail=0
>  Block: [0000000000013000,0000000000014000) size=4K avail=0
> max_avail=137434760164K
>  Block: [0000000000014000,0000000000015000) size=4K avail=0 max_avail=0
>  Block: [0000000000015000,0000000000016000) size=4K avail=0 max_avail=0
>  Block: [0000000000016000,0000000000017000) size=4K avail=0 max_avail=0
>  Block: [0000000000017000,0000000000018000) size=4K avail=0 max_avail=0
>  Block: [0000000000018000,0000000000019000) size=4K avail=0 max_avail=0
>  Block: [0000000000019000,000000000001a000) size=4K avail=0 max_avail=908K
>  Block: [000000000001a000,000000000001b000) size=4K avail=0 max_avail=0
>  Block: [000000000001b000,000000000001c000) size=4K avail=0 max_avail=908K
>  Block: [000000000001c000,000000000001d000) size=4K avail=0 max_avail=0
>  Block: [000000000001d000,0000000000100000) size=908K avail=908K
> max_avail=908K
>  Block: [0000000000226000,0000000000227000) size=4K avail=0 max_avail=0
>  Block: [0000000000227000,0000000000228000) size=4K avail=0
> max_avail=137434760164K
>  Block: [0000000000228000,0000000000229000) size=4K avail=0 max_avail=0
>  Block: [0000000000229000,00000000a0000000) size=2619228K avail=2619228K
> max_avail=2619228K
>  Block: [00000000b0000000,00000000bfeff000) size=261116K avail=261116K
> max_avail=137434760164K
>  Block: [00000000bff04000,00007fffbfffd000) size=137434760164K
> avail=137434760164K max_avail=137434760164K
>  => mem_size=140736144932864 (134216446 MB) / mem_avail=140736144809984
> (134216446 MB)
> 
> :phys_alloc: Allocator 0x1e6620 dump:
>  Block: [0000000000001000,0000000000002000) size=4K avail=0 max_avail=0
>  Block: [0000000000002000,0000000000003000) size=4K avail=0 max_avail=0
>  Block: [0000000000003000,0000000000004000) size=4K avail=0 max_avail=0
>  Block: [0000000000004000,0000000000005000) size=4K avail=0 max_avail=0
>  Block: [0000000000005000,0000000000006000) size=4K avail=0 max_avail=0
>  Block: [0000000000006000,0000000000007000) size=4K avail=0 max_avail=0
>  Block: [0000000000007000,0000000000008000) size=4K avail=0 max_avail=0
>  Block: [0000000000008000,0000000000009000) size=4K avail=0 max_avail=0
>  Block: [0000000000009000,000000000000a000) size=4K avail=0 max_avail=0
>  Block: [000000000000a000,000000000000b000) size=4K avail=0 max_avail=0
>  Block: [000000000000b000,000000000000c000) size=4K avail=0 max_avail=0
>  Block: [000000000000c000,000000000000d000) size=4K avail=0 max_avail=0
>  Block: [000000000000d000,000000000000e000) size=4K avail=0 max_avail=0
>  Block: [000000000000e000,000000000000f000) size=4K avail=0 max_avail=0
>  Block: [000000000000f000,0000000000010000) size=4K avail=0 max_avail=0
>  Block: [0000000000010000,0000000000011000) size=4K avail=0 max_avail=0
>  Block: [0000000000011000,0000000000012000) size=4K avail=0 max_avail=0
>  Block: [0000000000012000,0000000000013000) size=4K avail=0 max_avail=5112M
>  Block: [0000000000013000,0000000000014000) size=4K avail=0 max_avail=0
>  Block: [0000000000014000,0000000000015000) size=4K avail=0 max_avail=0
>  Block: [0000000000015000,0000000000016000) size=4K avail=0 max_avail=0
>  Block: [0000000000016000,0000000000017000) size=4K avail=0 max_avail=0
>  Block: [0000000000017000,0000000000018000) size=4K avail=0 max_avail=0
>  Block: [0000000000018000,0000000000019000) size=4K avail=0 max_avail=0
>  Block: [0000000000019000,000000000001a000) size=4K avail=0 max_avail=0
>  Block: [000000000001a000,000000000001b000) size=4K avail=0 max_avail=0
>  Block: [000000000001b000,000000000001c000) size=4K avail=0 max_avail=5112M
>  Block: [000000000001c000,000000000001d000) size=4K avail=0 max_avail=0
>  Block: [000000000001d000,000000000008e000) size=452K avail=452K
> max_avail=452K
>  Block: [0000000000100000,0000000000101000) size=4K avail=0 max_avail=15356K
>  Block: [0000000000101000,0000000001000000) size=15356K avail=15356K
> max_avail=15356K
>  Block: [0000000003400000,0000000003401000) size=4K avail=0 max_avail=5112M
>  Block: [0000000003401000,0000000003402000) size=4K avail=0 max_avail=0
>  Block: [0000000003402000,000000007da7d000) size=2005484K avail=2005484K
> max_avail=2005484K
>  Block: [0000000080001000,0000000080002000) size=4K avail=0 max_avail=5112M
>  Block: [0000000080002000,00000000b2cfb000) size=832484K avail=832484K
> max_avail=832484K
>  Block: [00000000b3aff000,00000000b3b00000) size=4K avail=4K max_avail=5112M
>  Block: [0000000100000000,000000023f800000) size=5112M avail=5112M
> max_avail=5112M
>  => mem_size=8282722304 (7899 MB) / mem_avail=8282591232 (7898 MB)
> 
> :io_mem_alloc: Allocator 0x1e87d8 dump:
>  Block: [0000000000000000,0000000000001000) size=4K avail=4K max_avail=4K
>  Block: [000000000008e000,0000000000100000) size=456K avail=456K
> max_avail=456K
>  Block: [00000000b2cfb000,00000000b3aff000) size=14352K avail=14352K
> max_avail=18014398500052988K
>  Block: [00000000b3b00000,0000000100000000) size=1221M avail=1221M
> max_avail=18014398500052988K
>  Block: [000000023f800000,fffffffffffff000) size=18014398500052988K
> avail=18014398500052988K max_avail=18014398500052988K
>  => mem_size=18446744065349738496 (17592186036443 MB) /
> mem_avail=18446744065349738496 (17592186036443 MB)
> 
> :rom_fs: ROM modules:
>  ROM: [000000007fd31000,000000007fd47448) acpi_drv
>  ROM: [000000007dd44000,000000007dd45dae) config
>  ROM: [000000007fad3000,000000007fb4fba8) device_pd
>  ROM: [000000007fecb000,000000007ff0cdd0) fb_drv
>  ROM: [000000000001b000,000000000001c000) hypervisor_info_page
>  ROM: [000000007ea68000,000000007eaa46d0) init
>  ROM: [000000007dd46000,000000007ddf1b28) ld.lib.so
>  ROM: [000000007dba4000,000000007dcd5068) libc.lib.so
>  ROM: [000000007dd14000,000000007dd1c130) libc_pipe.lib.so
>  ROM: [000000007fc19000,000000007fc27d70) libc_terminal.lib.so
>  ROM: [000000007fc28000,000000007fd0cd40) libiconv.lib.so
>  ROM: [000000007fbb1000,000000007fbd84a0) libm.lib.so
>  ROM: [000000007dd35000,000000007dd43388) log_terminal
>  ROM: [000000007fbd9000,000000007fc18938) nic_drv
>  ROM: [000000007dd1d000,000000007dd349c8) nit_fb
>  ROM: [000000007dcd6000,000000007dd132e0) nitpicker
>  ROM: [000000007fb76000,000000007fbb06d0) platform_drv
>  ROM: [0000000000019000,000000000001a000) platform_info
>  ROM: [000000007faa5000,000000007fabdcf8) ps2_drv
>  ROM: [000000007fd27000,000000007fd306f0) pthread.lib.so
>  ROM: [000000007fb50000,000000007fb75e18) qemu-usb.lib.so
>  ROM: [000000007ea50000,000000007ea67770) report_rom
>  ROM: [000000007fd48000,000000007fd58a08) rtc_drv
>  ROM: [000000007fd5b000,000000007fecaae0) stdcxx.lib.so
>  ROM: [000000007eaa5000,000000007faa5000) test.iso
>  ROM: [000000007fd59000,000000007fd5ab35) test.vbox
>  ROM: [000000007fabe000,000000007fad26a8) timer
>  ROM: [000000007ff0d000,000000007ffff830) usb_drv
>  ROM: [000000007fd0d000,000000007fd260a0) vbox_pointer
>  ROM: [000000007ddf2000,000000007ea4f678) virtualbox5-nova
> 
> Genode 17.05-86-g0d1be4a <local changes>
> 7898 MiB RAM and 63254 caps assigned to init
> [init] child "timer" announces service "Timer"
> [init] child "report_rom" announces service "Report"
> [init] child "report_rom" announces service "ROM"
> [init] child "log_terminal" announces service "Terminal"
> [init -> nic_drv] --- iPXE NIC driver started ---
> [init -> nic_drv] -- init iPXE NIC
> [init] child "acpi_report_rom" announces service "Report"
> [init] child "acpi_report_rom" announces service "ROM"
> [init -> acpi_drv] Found MADT
> [init -> acpi_drv] MADT IRQ 0 -> GSI 2 flags: 0
> [init -> acpi_drv] MADT IRQ 9 -> GSI 9 flags: 13
> [init -> acpi_drv] Found MCFG
> [init -> acpi_drv] MCFG BASE 0xe0000000 seg 0x0 bus 0x0-0xff
> [init -> acpi_drv] Found DMAR
> [init -> acpi_drv] 39 bit DMA physical addressable , IRQ remapping supported
> [init -> acpi_drv] DMA remapping structure type=0
> [init -> acpi_drv] DMA remapping structure type=0
> [init -> acpi_drv] DMA remapping structure type=1
> [init -> acpi_drv] DMA remapping structure type=1
> [init] child "platform_drv" announces service "Platform"
> [init -> ps2_drv] Using keyboard with scan code set 1 (xlate)
> [init -> ps2_drv] Warning: could not reset mouse (missing ack)
> [init -> nic_drv] Found: 00:1f.6 8086:15b7 (rev 31) IRQ 0b
> Warning: PD (init -> usb_drv) RAM limit (used=4844K, limit=4965381)
> exceeded during transfer_quota(8K)
> [init] Warning: usb_drv: RAM upgrade of Platform failed
> [init -> nic_drv] no driver found
> [init -> fb_drv] Found PCI VGA at 00:02.0
> [init -> fb_drv] fb mapped to 0x1000
> [init -> usb_drv] resource_request: ram_quota=8K, cap_quota=0
> [init] child "usb_drv" requests resources: ram_quota=8K, cap_quota=0

usb_drv is out of RAM here - increasing the RAM quota may help.

> [init] child "rtc_drv" announces service "Rtc"
> [init -> ps2_drv] Error: failed to read from port
> [init -> ps2_drv] Warning: could not reset mouse (unexpected response)
> [init -> nic_drv] Error: could not find usable NIC device

nic_drv did not find a supported NIC. What NIC is part of this PC (PCI
vendor and device ID)?

> [init] child "fb_drv" announces service "Framebuffer"
> [init] child "nic_drv" announces service "Nic"
> [init -> ps2_drv] Error: failed to read from port
> [init -> ps2_drv] Warning: could not enable stream
> [init -> platform_drv] PS2 uses IRQ, vector 0x1
> [init -> platform_drv] PS2 uses IRQ, vector 0xc
> [init] child "ps2_drv" announces service "Input"
> [init -> fb_drv] Found: VESA BIOS version 3.0
> [init -> fb_drv] OEM: Intel(R) SKL/KBL Mobile/Desktop Graphics Chipset
> Accelerated VGA BIOS
> [init -> fb_drv] Found: physical frame buffer at 0xc0000000 size: 134152192
> [init -> fb_drv] fb mapped to 0xc000000
> [init -> fb_drv] using video mode: 1920x1080 at ...64...
> [init] child "nitpicker" announces service "Nitpicker"
> [init] child "nit_fb1" announces service "Framebuffer"
> [init] child "nit_fb1" announces service "Input"
> [init] child "nit_fb2" announces service "Framebuffer"
> [init -> nit_fb1] using xywh=(10,10,800,600)
> [init] child "nit_fb2" announces service "Input"
> [init -> nit_fb2] using xywh=(410,410,800,600)
> [init -> vbox1] using the pipe libc plugin
> [init -> vbox2] using the pipe libc plugin
> [init -> vbox2] Warning: issetugid called, not yet implemented, returning 1
> [init -> vbox2] Warning: issetugid called, not yet implemented, returning 1
> [init -> vbox1] Warning: issetugid called, not yet implemented, returning 1
> [init -> vbox1] Warning: issetugid called, not yet implemented, returning 1
> [init -> vbox2] Error: fcntl(): command 2 not supported
> [init -> vbox2] Log created: 2017-07-25T18:13:00.000000000Z
> [init -> vbox2] main     Executable: /virtualbox
> [init -> vbox2] Error: SystemPropertiesWrap : Cannot determine default
> Guest Additions ISO location. Most likely they are not availae
> [init -> vbox1] Error: fcntl(): command 2 not supported
> [init -> vbox1] Log created: 2017-07-25T18:13:00.000000000Z
> [init -> vbox1] main     Executable: /virtualbox
> [init -> vbox1] Error: SystemPropertiesWrap : Cannot determine default
> Guest Additions ISO location. Most likely they are not availae
> [init -> vbox2] i_saveSettings skipped
> [init -> vbox1] i_saveSettings skipped
> [init -> vbox2] Using VMX virtualization extension.
> [init -> vbox2] Warning: _fpathconf: _fpathconf not implemented
> [init -> vbox1] Using VMX virtualization extension.
> [init -> vbox2] Warning: statfs provides bogus values for '//test.iso'
> (probably a shared folder)
> [init -> vbox1] Warning: _fpathconf: _fpathconf not implemented
> [init -> vbox1] Warning: statfs provides bogus values for '//test.iso'
> (probably a shared folder)
> [init -> vbox2] EMT
> [init -> vbox2] EMT      !!Assertion Failed!!
> [init -> vbox2] EMT      Expression: <NULL>
> [init -> vbox2] EMT      Location  : /home/chris/genode/contrib/virtualbox5
> [init -> vbox2]
> -63197fb01f1442acf40937798b78d036450296bd/src/app/virtualbox/src/VBox/VMM/VMMR3/PDMDriver.cpp(814)
> int pdmR3DrvInsta,
> [init -> vbox2]  PCFGMNODE, PPDMIBASE, PPDMDRVINS, PPDMLUN, PDMIBASE**)
> [init -> vbox2]
> [init -> vbox2] !!Assertion Failed!!
> [init -> vbox2] Expression: <none>
> [init -> vbox2] Location  :
> /home/chris/genode/contrib/virtualbox5-63197fb01f1442acf40937798b78d036450296bd/src/app/virtualbox/src/VI
> [init -> vbox2] BASE, PPDMDRVINS, PPDMLUN, PDMIBASE**)
> [init -> vbox2] EMT      Driver 'NAT' wasn't found!
> [init -> vbox2] Driver 'NAT' wasn't found!

The .vbox config uses the NAT backend, which is not supported. Please
change test.vbox according to (for example) vm_win10.vbox:

  <Network>
    <Adapter slot="0" enabled="false" MACAddress="0800271D7901" cable="true" speed="0" type="82540EM">
      <HostInterface/>
      <DisabledModes/>
    </Adapter>
  </Network>

> Warning: unresolvable exception 3, pd 'init -> vbox2', thread 'EMT', cpu 0,
> ip=0x168a3d3 no signal handler

This is the result of the assertion which calls "int3".

> [ 0] Killed EC:0xffffffff831b1dc0 SC:0xffffffff830faac0 V:0xfe CR0:0x0
> CR3:0x0 CR4:0x0 (IPC Abort)
> [init -> vbox1] EMT
> [init -> vbox1] EMT      !!Assertion Failed!!
> [init -> vbox1] EMT      Expression: <NULL>
> [init -> vbox1] EMT      Location  : /home/chris/genode/contrib/virtualbox5
> [init -> vbox1]
> -63197fb01f1442acf40937798b78d036450296bd/src/app/virtualbox/src/VBox/VMM/VMMR3/PDMDriver.cpp(814)
> int pdmR3DrvInsta,
> [init -> vbox1]  PCFGMNODE, PPDMIBASE, PPDMDRVINS, PPDMLUN, PDMIBASE**)
> [init -> vbox1]
> [init -> vbox1] !!Assertion Failed!!
> [init -> vbox1] Expression: <none>
> [init -> vbox1] Location  :
> /home/chris/genode/contrib/virtualbox5-63197fb01f1442acf40937798b78d036450296bd/src/app/virtualbox/src/VI
> [init -> vbox1] BASE, PPDMDRVINS, PPDMLUN, PDMIBASE**)
> [init -> vbox1] EMT      Driver 'NAT' wasn't found!
> [init -> vbox1] Driver 'NAT' wasn't found!
> Warning: unresolvable exception 3, pd 'init -> vbox1', thread 'EMT', cpu 0,
> ip=0x168a3d3 no signal handler
> [ 0] Killed EC:0xffffffff831f6700 SC:0xffffffff830fad60 V:0xfe CR0:0x0
> CR3:0x0 CR4:0x0 (IPC Abort)


Regards
-- 
Christian Helmuth
Genode Labs

https://www.genode-labs.com/ · https://genode.org/
https://twitter.com/GenodeLabs · /ˈdʒiː.nəʊd/

Genode Labs GmbH · Amtsgericht Dresden · HRB 28424 · Sitz Dresden
Geschäftsführer: Dr.-Ing. Norman Feske, Christian Helmuth

More information about the users mailing list