NUL Test Report

Sun, 26 Apr 2015 01:00:05 +0000 testbox/ivybridge-1-g5bc2785 (Michal Sojka: Move files related to nightly testing to another repo)

19. Direct PCI device assignment in Vancouver (/home/nul/nul/michal/boot/vancouver-dpci.wv)

novaboot: Read /home/nul/nul/.novaboot
novaboot: Connecting to IP relay... done
<iprelayd: connected>
novaboot: Entering directory `/home/nul/nul/build'
novaboot: Created vancuver.nulconfig
novaboot: Created /home/nul/nul/build/config-novaboot
novaboot: Running: rsync -RLp --chmod=Dg+s,ug+w,o-w,+rX --rsync-path="umask 002 && rsync" bin/apps/hypervisor bin/apps/sigma0.nul bin/apps/vancouver.nul bin/boot/munich imgs/bzImage-3.1-32 imgs/slackware-32.bz2 vancuver.nulconfig config-novaboot rtime.felk.cvut.cz:/srv/tftp/novaboot
novaboot: Reseting the test box... done
novaboot: Serial line interaction (press Ctrl-C to interrupt)...
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 19.
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 19.
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 19.
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 19.
***** WHICH IDE Returns: Pri/Sec:0, Mas/Slave: 0
SetSataPortString, Port# 0
***** Found a match!!! Drive= 0
GetDriveInfo()
GDI - Found HDD.
NOVA Microhypervisor v6-7ebd956 (x86_32): Apr 26 2015 01:00:34 [gcc 4.7.2]
[ 0] CORE:0:0:0 6:3a:9:1 [12] Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
[ 3] CORE:0:3:0 6:3a:9:1 [12] Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
[ 2] CORE:0:2:0 6:3a:9:1 [12] Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
[ 1] CORE:0:1:0 6:3a:9:1 [12] Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
=> hostkeyb:0,0x60,1,12 <=
=> service_config <=
=> service_disk <=
Constructing service /disk...
Service /disk registered.
=> script_start:1 <=
=> script_wait:16000 <=
=> script_start:1 <=
sc: start 0-1 count 1
sc: wait 16000ms
tb: client data 3f000 guid 5 parent 925
sc: waiting...
(5) Ignored parameter: 'rom://bin/apps/vancouver.nul'
(5) => PC_PS2 <=
(5) => mem:0,0xa0000 <=
(5) physmem: 0 [0, a0000]
(5) => mem:0x100000 <=
(5) physmem: 0 [100000, 3c00000]
(5) => ioio <=
(5) => nullio:0x80 <=
(5) => pic:0x20,,0x4d0 <=
(5) => pic:0xa0,2,0x4d1 <=
(5) => pit:0x40,0 <=
(5) => scp:0x92,0x61 <=
(5) => kbc:0x60,1,12 <=
(5) => keyb:0,0x10000 <=
(5) => mouse:1,0x10001 <=
(5) => rtc:0x70,8 <=
(5) => serial:0x3f8,0x4,0x4711 <=
s0: => INIT done <=
(5) => hostsink:0x4712,80 <=
(5) => vga:0x03c0 <=
(5) Allocating from guest 03be0000+20000
(5) VGA console 3be0000+20000 0x83fe0000
(5) => vbios_disk <=
(5) => vbios_keyboard <=
(5) => hostkeyb:0x10,0x60,1,,1 <=
(5) => vbios_mem <=
(5) => vbios_time <=
(5) => vbios_reset <=
(5) => vbios_multiboot <=
(5) => msi <=
(5) => ioapic <=
(5) => pcihostbridge:0,0x10,0xcf8,0xe0000000 <=
(5) => pmtimer:0x8000 <=
(5) => vcpus <=
(5) => vcpu <=
(5) create VCPU
(5) => halifax <=
(5) => vbios <=
(5) => lapic <=
(5) LAPIC freq 102903687
(5) startup
(5) => dpci:2,0,0 <=
(5) search_device(2,0,0) bdf c8
(5) DPCI device assigned
s0: [ 5] iomem f6500000+20000 granted from 0xb1800000
s0: [ 5] iomem f6539000+1000 granted from 0xb1400000
(5) alloc ioio region f08005 done
s0: [ 5] msi granted to cpu 2
(5) do_gsi_boot eip 800006ad esp 80238fec
(5) do_gsi(990, 7b, 992) 0xbfff6000
(5) MSI 7b enabled for bdf c8 MSI fee00018/7b
(5) => 82576vf <=
(5) Attached 82576VF model at f7ce0000+0x4000, f7cc0000+0x1000
(5) void DBus<M>::debug_dump() [with M = MessageHwIOIn]: Bus used 0 times.
(5) 0: StaticReceiver<Y>::StaticReceiver() [with Y = IOAccess]
(5)
(5) do_gsi_boot eip 80004bd8 esp 80213fec
(5) do_gsi_boot eip 800059b8 esp 80212fec
(5) do_gsi_boot eip 800057d3 esp 80210fec
(5) RESET device state
(5) disabled DMA by PCI device c8 cmd 100007 -> 100003
(5) INIT done
(5) reset CPU from 9 mtr_in e0010
(5) > bool VirtualBiosMultiboot::receive(MessageBios&) rip ffff ilen 3 cr0 10 efl 10002
(5) module 0 start 0x81c00000+918 cmdline rom://bin/boot/munich
(5) module 1 start 0x81c02000+1df330 cmdline rom://imgs/bzImage-3.1-32 clocksource=ts
(5) module 2 start 0x81de3000+611e9c cmdline rom://imgs/slackware-32.bz2
(5) # MUNICH: v.0.4.6 starts Linux
(5) # MUNICH: 3.1.0 (us15@erwin) #1 SMP PREEMPT Thu Nov 17 14:02:47 CET 2011
(5) # MUNICH: clocksource=tsc console=ttyS0 root=/dev/ram0
(5) # MUNICH: initrd 19E3000
(5) # MUNICH: copy image
(5) # MUNICH: start kernel
(5) handle_int15 eax e801 ebx 0 ecx 0 edx 0 eip ffff efl 10002
(5) handle_int15 eax c000 ebx 0 ecx 0 edx 0 eip ffff efl 10002
(5) handle_int15 eax e980 ebx 0 ecx 0 edx 47534943 eip ffff efl 10002
(5) VESA 4f00 tag 0 base 40000+33d0 esi 0
(5) # Linux version 3.1.0 (us15@erwin) (gcc version 4.4.5 (Debian 4.4.5-8) ) #1 SMP P
(5) # | REEMPT Thu Nov 17 14:02:47 CET 2011
(5) # CPU: vendor_id 'NOVA microHV' unknown, using generic init.
(5) # CPU: Your system may be unstable.
(5) # BIOS-provided physical RAM map:
(5) # BIOS-e820: 0000000000000000 - 000000000009ac00 (usable)
(5) # BIOS-e820: 000000000009ac00 - 00000000000a0000 (reserved)
(5) # BIOS-e820: 0000000000100000 - 0000000003be0000 (usable)
(5) # Notice: NX (Execute Disable) protection missing in CPU!
(5) # DMI not present or invalid.
(5) # last_pfn = 0x3be0 max_arch_pfn = 0x100000
(5) # init_memory_mapping: 0000000000000000-0000000003be0000
(5) # RAMDISK: 019e3000 - 01ff5000
(5) # ACPI: RSDP 0009ce00 00014 (v00 NOVA )
(5) # ACPI: RSDT 0009e000 00030 (v01 NOVA bk@vmmon 00000001 00000000)
(5) # ACPI: APIC 0009f000 00064 (v01 NOVA bk@vmmon 00000001 00000000)
(5) # ACPI: MCFG 0009bc00 0003C (v01 NOVA bk@vmmon 00000001 00000000)
(5) # ACPI: FACP 0009ac00 000DC (v01 NOVA bk@vmmon 00000001 00000000)
(5) # ACPI Error: Required field Pm1aEventBlock has zero address and/or length: 0x000
(5) # | 0000000000000/0x0 (20110623/tbfadt-544)
(5) # ACPI Error: Required field Pm1aControlBlock has zero address and/or length: 0x0
(5) # | 000000000000000/0x0 (20110623/tbfadt-544)
(5) # ACPI Error: Null physical address for ACPI table [DSDT] (20110623/tbutils-459)
(5) # ACPI Error: Null physical address for ACPI table [FACS] (20110623/tbutils-459)
(5) # 59MB LOWMEM available.
(5) # mapped low ram: 0 - 03be0000
(5) # low ram: 0 - 03be0000
(5) # Zone PFN ranges:
(5) # DMA 0x00000010 -> 0x00001000
(5) # Normal 0x00001000 -> 0x00003be0
(5) # Movable zone start PFN for each node
(5) # early_node_map[2] active PFN ranges
(5) # 0: 0x00000010 -> 0x0000009a
(5) # 0: 0x00000100 -> 0x00003be0
(5) # Using APIC driver default
(5) # ACPI: PM-Timer IO Port: 0x8000
(5) # ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
(5) # ACPI: X2APIC_NMI (uid[0xffffffff] dfl dfl lint[0x1])
(5) # ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
(5) # ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
(5) # IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23
(5) # ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
(5) # ACPI: NMI_SRC (dfl dfl global_irq 23)
(5) # Using ACPI (MADT) for SMP configuration information
(5) # SMP: Allowing 1 CPUs, 0 hotplug CPUs
(5) # Allocating PCI resources starting at 3be0000 (gap: 3be0000:fc420000)
(5) # setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
(5) # PERCPU: Embedded 9 pages/cpu @c3400000 s22976 r0 d13888 u4194304
(5) # Built 1 zonelists in Zone order, mobility grouping on. Total pages: 15090
(5) # Kernel command line: clocksource=tsc console=ttyS0 root=/dev/ram0
(5) # PID hash table entries: 256 (order: -2, 1024 bytes)
(5) # Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
(5) # Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
(5) # Initializing CPU#0
(5) # Memory: 49960k/61312k available (2436k kernel code, 10880k reserved, 992k data,
(5) # | 312k init, 0k highmem)
(5) # virtual kernel memory layout:
(5) # fixmap : 0xfff17000 - 0xfffff000 ( 928 kB)
(5) # vmalloc : 0xc43e0000 - 0xfff15000 ( 955 MB)
(5) # lowmem : 0xc0000000 - 0xc3be0000 ( 59 MB)
(5) # .init : 0xc135a000 - 0xc13a8000 ( 312 kB)
(5) # .data : 0xc12613d0 - 0xc13595c0 ( 992 kB)
(5) # .text : 0xc1000000 - 0xc12613d0 (2436 kB)
(5) # Checking if this processor honours the WP bit even in supervisor mode...Ok.
(5) # Preemptible hierarchical RCU implementation.
(5) # Verbose stalled-CPUs detection is disabled.
(5) # NR_IRQS:512
(5) # Console: colour VGA+ 80x25
(5) # console [ttyS0] enabled
(5) # Fast TSC calibration using PIT
(5) # Detected 3292.849 MHz processor.
(5) # Calibrating delay loop (skipped), value calculated using timer frequency.. 6585
(5) # | .69 BogoMIPS (lpj=13171396)
(5) # pid_max: default: 32768 minimum: 301
(5) # Mount-cache hash table entries: 512
(5) # SMP alternatives: switching to UP code
(5) # Freeing SMP alternatives: 16k freed
(5) # ACPI: Core revision 20110623
(5) # ACPI Exception: AE_NO_ACPI_TABLES, While loading namespace from ACPI tables (20
(5) # | 110623/tbxface-640)
(5) # ACPI: Unable to load the System Description Tables
(5) # Enabling APIC mode: Flat. Using 1 I/O APICs
(5) # ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
(5) # CPU0: NOVA microHV Vancouver VMM proudly presents this VirtualCPU. stepping 03
(5) # | Performance Events:
(5) # Brought up 1 CPUs
(5) # Total of 1 processors activated (6585.69 BogoMIPS).
(5) # NET: Registered protocol family 16
(5) # PCI: Using configuration type 1 for base access
(5) # bio: create slab <bio-0> at 0
(5) # ACPI: Interpreter disabled.
(5) # vgaarb: loaded
(5) # SCSI subsystem initialized
(5) # usbcore: registered new interface driver usbfs
(5) # usbcore: registered new interface driver hub
(5) # usbcore: registered new device driver usb
(5) # PCI: Probing PCI hardware
(5) # pnp: PnP ACPI: disabled
(5) # Switching to clocksource acpi_pm
(5) # NET: Registered protocol family 2
(5) # Switched to NOHz mode on CPU #0
(5) # IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
(5) # TCP established hash table entries: 2048 (order: 2, 16384 bytes)
(5) # TCP bind hash table entries: 2048 (order: 2, 16384 bytes)
(5) # TCP: Hash tables configured (established 2048 bind 2048)
(5) # TCP reno registered
(5) # UDP hash table entries: 128 (order: 0, 4096 bytes)
(5) # UDP-Lite hash table entries: 128 (order: 0, 4096 bytes)
(5) # NET: Registered protocol family 1
(5) # Trying to unpack rootfs image as initramfs...
(5) # rootfs image is not initramfs (no cpio magic); looks like an initrd
(5) # Freeing initrd memory: 6216k freed
(5) # platform rtc_cmos: registered platform RTC device (no PNP device found)
(5) # microcode: no support for this CPU vendor
(5) # HugeTLB registered 4 MB page size, pre-allocated 0 pages
(5) # NTFS driver 2.1.30 [Flags: R/O].
(5) # msgmni has been set to 109
(5) # io scheduler noop registered
(5) # io scheduler deadline registered (default)
(5) # io scheduler cfq registered
(5) # Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
(5) # serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16450
(5) # Non-volatile memory driver v1.3
(5) # brd: module loaded
(5) # e1000e: Intel(R) PRO/1000 Network Driver - 1.4.4-k
(5) # e1000e: Copyright(c) 1999 - 2011 Intel Corporation.
(5) # e1000e 0000:00:01.0: can't find IRQ for PCI INT A; probably buggy MP table
(5) MAP 0 f6500000+20000 from 0x84000000 size 20000 page f6500 f6500000
(5) MAP 1 f6539000+1000 from 0x84020000 size 1000 page f6539 f6539000
(5) # e1000e 0000:00:01.0: eth0: (PCI Express:2.5GT/s:Width x1) 5c:f9:dd:76:dc:17
(5) # e1000e 0000:00:01.0: eth0: Intel(R) PRO/1000 Network Connection
(5) # e1000e 0000:00:01.0: eth0: MAC: 10, PHY: 11, PBA No: 1011FF-0FF
(5) # Intel(R) Gigabit Ethernet Network Driver - version 3.0.6-k
(5) # Copyright (c) 2007-2011 Intel Corporation.
(5) # Intel(R) Virtual Function Network Driver - version 2.0.0-k
(5) # Copyright (c) 2009 - 2010 Intel Corporation.
(5) # igbvf 0000:00:02.0: enabling device (0000 -> 0002)
(5) VF_RESET 42:68:38:b4:a3:05
(5) VF_RESET 42:68:38:b4:a3:05
(5) VF_SET_MAC 42:68:38:b4:a3:05
(5) # igbvf 0000:00:02.0: Intel(R) 82576 Virtual Function
(5) # igbvf 0000:00:02.0: Address: 42:68:38:b4:a3:05
(5) # igbvf 0000:00:02.0: MAC: 1
(5) # tun: Universal TUN/TAP device driver, 1.6
(5) # tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
(5) # ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
(5) # Initializing USB Mass Storage driver...
(5) # usbcore: registered new interface driver usb-storage
(5) # USB Mass Storage support registered.
(5) # i8042: PNP: No PS/2 controller found. Probing ports directly.
(5) # serio: i8042 KBD port at 0x60,0x64 irq 1
(5) # serio: i8042 AUX port at 0x60,0x64 irq 12
(5) # mousedev: PS/2 mouse device common for all mice
(5) # input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/inp
(5) # | ut0
(5) # input: PC Speaker as /devices/platform/pcspkr/input/input1
(5) # rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
(5) # rtc0: alarms up to one day, 114 bytes nvram
(5) # cpuidle: using governor ladder
(5) # cpuidle: using governor menu
(5) # usbcore: registered new interface driver usbhid
(5) # usbhid: USB HID core driver
(5) # TCP cubic registered
(5) # NET: Registered protocol family 17
(5) # Using IPI No-Shortcut mode
(5) # rtc_cmos rtc_cmos: setting system clock to 2015-04-25 23:15:25 UTC (1430003725)
(5) # | Refined TSC clocksource calibration: 3292.917 MHz.
(5) # Override clocksource tsc is not HRT compatible. Cannot switch while in HRT/NOHZ
(5) # | mode
(5) # Switching to clocksource tsc
(5) # input: PS/2 Generic Mouse as /devices/platform/i8042/serio1/input/input2
(5) # RAMDISK: bzip2 image found at block 0
(5) # VFS: Mounted root (ext2 filesystem) readonly on device 1:0.
(5) # Freeing unused kernel memory: 312k freed
(5) # Write protecting the kernel text: 2440k
(5) # Write protecting the kernel read-only data: 736k
(5) # INIT: version 2.86 booting
(5) # proc on /proc type proc (rw)
(5) # sysfs on /sys type sysfs (rw)
(5) # Triggering udev events: /sbin/udevadm trigger --action=add
(5) # udev[400]: renamed network interface eth1 to int0
(5) # udev[397]: renamed network interface eth0 to ext0
(5) # Setting system time from the hardware clock (localtime).
(5) # Testing root filesystem status: read-only filesystem
(5) # Checking root filesystem:
(5) # fsck 1.41.13 (13-Dec-2010)
(5) # ramdisk: clean, 502/4096 files, 15944/16384 blocks
(5) # Remounting root device with read-write enabled.
(5) # /dev/ram0 on / type ext2 (rw)
(5) # Checking non-root filesystems:
(5) # fsck 1.41.13 (13-Dec-2010)
(5) # Mounting non-root local filesystems:
(5) # tmpfs on /dev/shm type tmpfs (rw)
(5) # Using /etc/random-seed to initialize /dev/urandom.
(5) # INIT: Entering runlevel: 3
(5) # Going multiuser...
(5) # cannot (un)set powersave mode
(5) # [9;15][14;60]Starting sysklogd daemons: /usr/sbin/syslogd /usr/sbin/klogd -c
(5) # | 3 -x
(5) # Triggering udev events: /sbin/udevadm trigger --type=failed
(5) # Bridging between ext0 and int0
(5) VF_SET_MULTICAST 00000003 (0) c3348b00
(5) TX queue 0: DISABLED
(5) TX queue 0: ENABLED
(5) 82576VF MAP f7ce2+1 from 0x80216000
(5) VF message unknown 00000005
(5) VF_SET_MULTICAST 00000003 (0) 00000000
(5) VF_SET_MULTICAST 00000003 (0) c13a2000
(5) VF_SET_MULTICAST 00010003 (1) c1230010
(5) # Polling for DHCP server on interface br0:
(5) # dhcpcd[694]: version 5.2.7 starting
(5) # dhcpcd[694]: br0: waiting for carrier
(5) # dhcpcd[694]: br0: carrier acquired
(5) # dhcpcd[694]: br0: broadcasting for a lease
(5) # dhcpcd[694]: br0: offered 147.32.86.155 from 147.32.86.2
(5) # dhcpcd[694]: br0: acknowledged 147.32.86.155 from 147.32.86.2
(5) # dhcpcd[694]: br0: leased 147.32.86.155 for 3600 seconds
(5) # dhcpcd[694]: forked to background, child pid 721
(5) # Starting Internet super-server daemon: /usr/sbin/inetd
sc: start 0-1 count 1
sc: done.
tb: client data 3f002 guid 6 parent 928
(6) Ignored parameter: 'rom://bin/apps/vancouver.nul'
(6) => PC_PS2 <=
(6) => mem:0,0xa0000 <=
(6) physmem: 0 [0, a0000]
(6) => mem:0x100000 <=
(6) physmem: 0 [100000, 3c00000]
(6) => ioio <=
(6) => nullio:0x80 <=
(6) => pic:0x20,,0x4d0 <=
(6) => pic:0xa0,2,0x4d1 <=
(6) => pit:0x40,0 <=
(6) => scp:0x92,0x61 <=
(6) => kbc:0x60,1,12 <=
(6) => keyb:0,0x10000 <=
(6) => mouse:1,0x10001 <=
(6) => rtc:0x70,8 <=
(6) => serial:0x3f8,0x4,0x4711 <=
(6) => hostsink:0x4712,80 <=
(6) => vga:0x03c0 <=
(6) Allocating from guest 03be0000+20000
(6) VGA console 3be0000+20000 0x83fe0000
(6) => vbios_disk <=
(6) => vbios_keyboard <=
(6) => hostkeyb:0x10,0x60,1,,1 <=
(6) => vbios_mem <=
(6) => vbios_time <=
(6) => vbios_reset <=
(6) => vbios_multiboot <=
(6) => msi <=
(6) => ioapic <=
(6) => pcihostbridge:0,0x10,0xcf8,0xe0000000 <=
(6) => pmtimer:0x8000 <=
(6) => vcpus <=
(6) => vcpu <=
(6) create VCPU
(6) => halifax <=
(6) => vbios <=
(6) => lapic <=
(6) startup
(6) LAPIC freq 102903687
(6) => dpci:2,0,0 <=
(6) search_device(2,0,0) bdf c8
s0: PCI device 0:19:0 cannot be directly assigned again!
(6) DPCI failed
(6) DirectPciDevice() line 386: 'assign && !mb.bus_hostop.send(msg4)' error = 1 DPCI: could not directly assign c8 via iommu
(6) => 82576vf <=
(6) Attached 82576VF model at f7ce0000+0x4000, f7cc0000+0x1000
(6) void DBus<M>::debug_dump() [with M = MessageHwIOIn]: Bus used 0 times.
(6) 0: StaticReceiver<Y>::StaticReceiver() [with Y = IOAccess]
(6)
(6) do_gsi_boot eip 80004bd8 esp 80215fec
(6) do_gsi_boot eip 800059b8 esp 80214fec
(6) do_gsi_boot eip 800057d3 esp 80212fec
(6) RESET device state
(6) INIT done
(6) reset CPU from 9 mtr_in e0010
(6) > bool VirtualBiosMultiboot::receive(MessageBios&) rip ffff ilen 3 cr0 10 efl 10002
(6) module 0 start 0x81c00000+918 cmdline rom://bin/boot/munich
(6) module 1 start 0x81c02000+1df330 cmdline rom://imgs/bzImage-3.1-32 clocksource=ts
(6) module 2 start 0x81de3000+611e9c cmdline rom://imgs/slackware-32.bz2
(6) # MUNICH: v.0.4.6 starts Linux
(6) # MUNICH: 3.1.0 (us15@erwin) #1 SMP PREEMPT Thu Nov 17 14:02:47 CET 2011
(6) # MUNICH: clocksource=tsc console=ttyS0 root=/dev/ram0
(6) # MUNICH: initrd 19E3000
(6) # MUNICH: copy image
(6) # MUNICH: start kernel
(6) handle_int15 eax e801 ebx 0 ecx 0 edx 0 eip ffff efl 10002
(6) handle_int15 eax c000 ebx 0 ecx 0 edx 0 eip ffff efl 10002
(6) handle_int15 eax e980 ebx 0 ecx 0 edx 47534943 eip ffff efl 10002
(6) VESA 4f00 tag 0 base 40000+33d0 esi 0
(6) # Linux version 3.1.0 (us15@erwin) (gcc version 4.4.5 (Debian 4.4.5-8) ) #1 SMP P
(6) # | REEMPT Thu Nov 17 14:02:47 CET 2011
(6) # CPU: vendor_id 'NOVA microHV' unknown, using generic init.
(6) # CPU: Your system may be unstable.
(6) # BIOS-provided physical RAM map:
(6) # BIOS-e820: 0000000000000000 - 000000000009ac00 (usable)
(6) # BIOS-e820: 000000000009ac00 - 00000000000a0000 (reserved)
(6) # BIOS-e820: 0000000000100000 - 0000000003be0000 (usable)
(6) # Notice: NX (Execute Disable) protection missing in CPU!
(6) # DMI not present or invalid.
(6) # last_pfn = 0x3be0 max_arch_pfn = 0x100000
(6) # init_memory_mapping: 0000000000000000-0000000003be0000
(6) # RAMDISK: 019e3000 - 01ff5000
(6) # ACPI: RSDP 0009ce00 00014 (v00 NOVA )
(6) # ACPI: RSDT 0009e000 00030 (v01 NOVA bk@vmmon 00000001 00000000)
(6) # ACPI: APIC 0009f000 00064 (v01 NOVA bk@vmmon 00000001 00000000)
(6) # ACPI: MCFG 0009bc00 0003C (v01 NOVA bk@vmmon 00000001 00000000)
(6) # ACPI: FACP 0009ac00 000DC (v01 NOVA bk@vmmon 00000001 00000000)
(6) # ACPI Error: Required field Pm1aEventBlock has zero address and/or length: 0x000
(6) # | 0000000000000/0x0 (20110623/tbfadt-544)
(6) # ACPI Error: Required field Pm1aControlBlock has zero address and/or length: 0x0
(6) # | 000000000000000/0x0 (20110623/tbfadt-544)
(6) # ACPI Error: Null physical address for ACPI table [DSDT] (20110623/tbutils-459)
(6) # ACPI Error: Null physical address for ACPI table [FACS] (20110623/tbutils-459)
(6) # 59MB LOWMEM available.
(6) # mapped low ram: 0 - 03be0000
(6) # low ram: 0 - 03be0000
(6) # Zone PFN ranges:
(6) # DMA 0x00000010 -> 0x00001000
(6) # Normal 0x00001000 -> 0x00003be0
(6) # Movable zone start PFN for each node
(6) # early_node_map[2] active PFN ranges
(6) # 0: 0x00000010 -> 0x0000009a
(6) # 0: 0x00000100 -> 0x00003be0
(6) # Using APIC driver default
(6) # ACPI: PM-Timer IO Port: 0x8000
(6) # ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
(6) # ACPI: X2APIC_NMI (uid[0xffffffff] dfl dfl lint[0x1])
(6) # ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
(6) # ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
(6) # IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23
(6) # ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
(6) # ACPI: NMI_SRC (dfl dfl global_irq 23)
(6) # Using ACPI (MADT) for SMP configuration information
(6) # SMP: Allowing 1 CPUs, 0 hotplug CPUs
(6) # Allocating PCI resources starting at 3be0000 (gap: 3be0000:fc420000)
(6) # setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
(6) # PERCPU: Embedded 9 pages/cpu @c3400000 s22976 r0 d13888 u4194304
(6) # Built 1 zonelists in Zone order, mobility grouping on. Total pages: 15090
(6) # Kernel command line: clocksource=tsc console=ttyS0 root=/dev/ram0
(6) # PID hash table entries: 256 (order: -2, 1024 bytes)
(6) # Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
(6) # Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
(6) # Initializing CPU#0
(6) # Memory: 49960k/61312k available (2436k kernel code, 10880k reserved, 992k data,
(6) # | 312k init, 0k highmem)
(6) # virtual kernel memory layout:
(6) # fixmap : 0xfff17000 - 0xfffff000 ( 928 kB)
(6) # vmalloc : 0xc43e0000 - 0xfff15000 ( 955 MB)
(6) # lowmem : 0xc0000000 - 0xc3be0000 ( 59 MB)
(6) # .init : 0xc135a000 - 0xc13a8000 ( 312 kB)
(6) # .data : 0xc12613d0 - 0xc13595c0 ( 992 kB)
(6) # .text : 0xc1000000 - 0xc12613d0 (2436 kB)
(6) # Checking if this processor honours the WP bit even in supervisor mode...Ok.
(6) # Preemptible hierarchical RCU implementation.
(6) # Verbose stalled-CPUs detection is disabled.
(6) # NR_IRQS:512
(6) # Console: colour VGA+ 80x25
(6) # console [ttyS0] enabled
(6) # Fast TSC calibration using PIT
(6) # Detected 3292.608 MHz processor.
(6) # Calibrating delay loop (skipped), value calculated using timer frequency.. 6585
(6) # | .21 BogoMIPS (lpj=13170432)
(6) # pid_max: default: 32768 minimum: 301
(6) # Mount-cache hash table entries: 512
(6) # SMP alternatives: switching to UP code
(6) # Freeing SMP alternatives: 16k freed
(6) # ACPI: Core revision 20110623
(6) # ACPI Exception: AE_NO_ACPI_TABLES, While loading namespace from ACPI tables (20
(6) # | 110623/tbxface-640)
(6) # ACPI: Unable to load the System Description Tables
(6) # Enabling APIC mode: Flat. Using 1 I/O APICs
(6) # ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
(6) # CPU0: NOVA microHV Vancouver VMM proudly presents this VirtualCPU. stepping 03
(6) # | Performance Events:
(6) # Brought up 1 CPUs
(6) # Total of 1 processors activated (6585.21 BogoMIPS).
(6) # NET: Registered protocol family 16
(6) # PCI: Using configuration type 1 for base access
(6) # bio: create slab <bio-0> at 0
(6) # ACPI: Interpreter disabled.
(6) # vgaarb: loaded
(6) # SCSI subsystem initialized
(6) # usbcore: registered new interface driver usbfs
(6) # usbcore: registered new interface driver hub
(6) # usbcore: registered new device driver usb
(6) # PCI: Probing PCI hardware
(6) # pnp: PnP ACPI: disabled
(6) # Switching to clocksource acpi_pm
(6) # NET: Registered protocol family 2
(6) # Switched to NOHz mode on CPU #0
(6) # IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
(6) # TCP established hash table entries: 2048 (order: 2, 16384 bytes)
(6) # TCP bind hash table entries: 2048 (order: 2, 16384 bytes)
(6) # TCP: Hash tables configured (established 2048 bind 2048)
(6) # TCP reno registered
(6) # UDP hash table entries: 128 (order: 0, 4096 bytes)
(6) # UDP-Lite hash table entries: 128 (order: 0, 4096 bytes)
(6) # NET: Registered protocol family 1
(6) # Trying to unpack rootfs image as initramfs...
(6) # rootfs image is not initramfs (no cpio magic); looks like an initrd
(6) # Freeing initrd memory: 6216k freed
(6) # platform rtc_cmos: registered platform RTC device (no PNP device found)
(6) # microcode: no support for this CPU vendor
(6) # HugeTLB registered 4 MB page size, pre-allocated 0 pages
(6) # NTFS driver 2.1.30 [Flags: R/O].
(6) # msgmni has been set to 109
(6) # io scheduler noop registered
(6) # io scheduler deadline registered (default)
(6) # io scheduler cfq registered
(6) # Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
(6) # serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16450
(6) # Non-volatile memory driver v1.3
(6) # brd: module loaded
(6) # e1000e: Intel(R) PRO/1000 Network Driver - 1.4.4-k
(6) # e1000e: Copyright(c) 1999 - 2011 Intel Corporation.
(6) # Intel(R) Gigabit Ethernet Network Driver - version 3.0.6-k
(6) # Copyright (c) 2007-2011 Intel Corporation.
(6) # Intel(R) Virtual Function Network Driver - version 2.0.0-k
(6) # Copyright (c) 2009 - 2010 Intel Corporation.
(6) # igbvf 0000:00:01.0: enabling device (0000 -> 0002)
(6) VF_RESET 42:68:38:b4:a3:06
(6) VF_RESET 42:68:38:b4:a3:06
(6) VF_SET_MAC 42:68:38:b4:a3:06
(6) # igbvf 0000:00:01.0: Intel(R) 82576 Virtual Function
(6) # igbvf 0000:00:01.0: Address: 42:68:38:b4:a3:06
(6) # igbvf 0000:00:01.0: MAC: 1
(6) # tun: Universal TUN/TAP device driver, 1.6
(6) # tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
(6) # ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
(6) # Initializing USB Mass Storage driver...
(6) # usbcore: registered new interface driver usb-storage
(6) # USB Mass Storage support registered.
(6) # i8042: PNP: No PS/2 controller found. Probing ports directly.
(6) # serio: i8042 KBD port at 0x60,0x64 irq 1
(6) # serio: i8042 AUX port at 0x60,0x64 irq 12
(6) # mousedev: PS/2 mouse device common for all mice
(6) # input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/inp
(6) # | ut0
(6) # input: PC Speaker as /devices/platform/pcspkr/input/input1
(6) # rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
(6) # rtc0: alarms up to one day, 114 bytes nvram
(6) # cpuidle: using governor ladder
(6) # cpuidle: using governor menu
(6) # usbcore: registered new interface driver usbhid
(6) # usbhid: USB HID core driver
(6) # TCP cubic registered
(6) # NET: Registered protocol family 17
(6) # Using IPI No-Shortcut mode
(6) # rtc_cmos rtc_cmos: setting system clock to 2015-04-25 23:15:40 UTC (1430003740)
(6) # | Refined TSC clocksource calibration: 3292.918 MHz.
(6) # Override clocksource tsc is not HRT compatible. Cannot switch while in HRT/NOHZ
(6) # | mode
(6) # Switching to clocksource tsc
(6) # input: PS/2 Generic Mouse as /devices/platform/i8042/serio1/input/input2
(6) # RAMDISK: bzip2 image found at block 0
(6) # VFS: Mounted root (ext2 filesystem) readonly on device 1:0.
(6) # Freeing unused kernel memory: 312k freed
(6) # Write protecting the kernel text: 2440k
(6) # Write protecting the kernel read-only data: 736k
(6) # INIT: version 2.86 booting
(6) # proc on /proc type proc (rw)
(6) # sysfs on /sys type sysfs (rw)
(6) # Triggering udev events: /sbin/udevadm trigger --action=add
(6) # udev[395]: renamed network interface eth0 to int0
(6) # Setting system time from the hardware clock (localtime).
(6) # Testing root filesystem status: read-only filesystem
(6) # Checking root filesystem:
(6) # fsck 1.41.13 (13-Dec-2010)
(6) # ramdisk: clean, 502/4096 files, 15944/16384 blocks
(6) # Remounting root device with read-write enabled.
(6) # /dev/ram0 on / type ext2 (rw)
(6) # Checking non-root filesystems:
(6) # fsck 1.41.13 (13-Dec-2010)
(6) # Mounting non-root local filesystems:
(6) # tmpfs on /dev/shm type tmpfs (rw)
(6) # Using /etc/random-seed to initialize /dev/urandom.
(6) # INIT: Entering runlevel: 3
(6) # Going multiuser...
(6) # cannot (un)set powersave mode
(6) # [9;15][14;60]Starting sysklogd daemons: /usr/sbin/syslogd /usr/sbin/klogd -c
(6) # | 3 -x
(6) # Triggering udev events: /sbin/udevadm trigger --type=failed
(6) # Polling for DHCP server on interface int0:
(6) # dhcpcd[656]: version 5.2.7 starting
(6) VF_SET_MULTICAST 00000003 (0) c1638ac0
(6) TX queue 0: DISABLED
(6) TX queue 0: ENABLED
(6) 82576VF MAP f7ce2+1 from 0x80218000
(6) VF message unknown 00000005
(6) VF_SET_MULTICAST 00000003 (0) 00000000
(6) VF_SET_MULTICAST 00000003 (0) c13a2000
(6) VF_SET_MULTICAST 00010003 (1) c1230010
(6) # dhcpcd[656]: int0: broadcasting for a lease
(6) # dhcpcd[656]: int0: offered 147.32.86.212 from 147.32.86.2
(6) # dhcpcd[656]: int0: acknowledged 147.32.86.212 from 147.32.86.2
(6) # dhcpcd[656]: int0: leased 147.32.86.212 for 3600 seconds
(6) # dhcpcd[656]: forked to background, child pid 678
(6) # Starting Internet super-server daemon: /usr/sbin/inetd
(5) # dhcpcd[694]: br0: leased 147.32.86.155 for 3600 seconds
! /home/nul/nul/michal/boot/vancouver-dpci.wv:17 got_ip_address 5 okok
ÿýÿý ÿý#ÿý'ÿûÿýÿýÿûÿý!ÿûÿû
ooooo ooo .oooooo. oooooo oooo .o.
`888b. `8' d8P' `Y8b `888. .8' .888.
8 `88b. 8 888 888 `888. .8' .8"888.
8 `88b. 8 888 888 `888. .8' .8' `888.
8 `88b.8 888 888 `888.8' .88ooo8888.
8 `888 `88b d88' `888' .8' `888.
o8o `8 `Y8bood8P' `8' o88o o8888o
vm.felk.cvut.cz (i686 Linux 3.1.0) pts/0
vm login:
! /home/nul/nul/michal/boot/vancouver-dpci.wv:22 telnet_works 147.32.86.155 okok
(6) # dhcpcd[656]: int0: leased 147.32.86.212 for 3600 seconds
! /home/nul/nul/michal/boot/vancouver-dpci.wv:24 got_ip_address 6 okok
ÿýÿý ÿý#ÿý'ÿûÿýÿýÿûÿý!ÿûÿû
ooooo ooo .oooooo. oooooo oooo .o.
`888b. `8' d8P' `Y8b `888. .8' .888.
8 `88b. 8 888 888 `888. .8' .8"888.
8 `88b. 8 888 888 `888. .8' .8' `888.
8 `88b.8 888 888 `888.8' .88ooo8888.
8 `888 `88b d88' `888' .8' `888.
o8o `8 `Y8bood8P' `8' o88o o8888o
vm.felk.cvut.cz (i686 Linux 3.1.0) pts/0
vm login:
! /home/nul/nul/michal/boot/vancouver-dpci.wv:25 telnet_works 147.32.86.212 okok
! /home/nul/nul/michal/wvtest/wvnulrun: $assertions_executed > 0 okok
novaboot: Read /home/nul/nul/.novaboot