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)

34. /home/nul/nul/michal/boot/netperf/vancouver-netperf.wv

novaboot: Connecting to IP relay... done
<iprelayd: connected>
novaboot: Entering directory `/home/nul/nul/build'
novaboot: Running: ( zcat imgs/initramfs-netperf.cpio.gz && cd $SRCDIR && find etc | cpio --dereference -o -H newc ) > initramfs-netperf.cpio
4 blocks
novaboot: Created vm1.nulconfig
novaboot: Created vm2.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-js initramfs-netperf.cpio vm1.nulconfig vm2.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 24.
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 24.
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 24.
handle id(3) is not a tty. Not changing mode at /usr/share/perl5/Expect.pm line 393, <> line 24.
***** 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
[ 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
[ 3] CORE:0:3: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,2 <=
sc: start 0-2 count 1
tb: client data 3f000 guid 5 parent 925
(5) Ignored parameter: 'rom://bin/apps/vancouver.nul'
sc: done.
tb: client data 3f002 guid 6 parent 928
(5) => PC_PS2 <=
(6) Ignored parameter: 'rom://bin/apps/vancouver.nul'
(5) => mem:0,0xa0000 <=
(6) => PC_PS2 <=
(5) physmem: 0 [0, a0000]
(6) => mem:0,0xa0000 <=
(5) => mem:0x100000 <=
(6) physmem: 0 [0, a0000]
(5) physmem: 0 [100000, 3c00000]
(6) => mem:0x100000 <=
(5) => ioio <=
(6) physmem: 0 [100000, 3c00000]
(5) => nullio:0x80 <=
(6) => ioio <=
(5) => pic:0x20,,0x4d0 <=
(6) => nullio:0x80 <=
(5) => pic:0xa0,2,0x4d1 <=
(6) => pic:0x20,,0x4d0 <=
(5) => pit:0x40,0 <=
(6) => pic:0xa0,2,0x4d1 <=
s0: => INIT done <=
(5) => scp:0x92,0x61 <=
(6) => pit:0x40,0 <=
(5) => kbc:0x60,1,12 <=
(6) => scp:0x92,0x61 <=
(5) => keyb:0,0x10000 <=
(6) => kbc:0x60,1,12 <=
(5) => mouse:1,0x10001 <=
(6) => keyb:0,0x10000 <=
(5) => rtc:0x70,8 <=
(6) => mouse:1,0x10001 <=
(5) => serial:0x3f8,0x4,0x4711 <=
(6) => rtc:0x70,8 <=
(5) => hostsink:0x4712,80 <=
(6) => serial:0x3f8,0x4,0x4711 <=
(5) => vga:0x03c0 <=
(6) => hostsink:0x4712,80 <=
(5) Allocating from guest 03be0000+20000
(6) => vga:0x03c0 <=
(5) VGA console 3be0000+20000 0x83fe0000
(6) Allocating from guest 03be0000+20000
(5) => vbios_disk <=
(6) VGA console 3be0000+20000 0x83fe0000
(5) => vbios_keyboard <=
(6) => vbios_disk <=
(5) => hostkeyb:0x10,0x60,1,,1 <=
(6) => vbios_keyboard <=
(5) => vbios_mem <=
(6) => hostkeyb:0x10,0x60,1,,1 <=
(5) => vbios_time <=
(6) => vbios_mem <=
(5) => vbios_reset <=
(6) => vbios_time <=
(5) => vbios_multiboot <=
(6) => vbios_reset <=
(5) => msi <=
(6) => vbios_multiboot <=
(5) => ioapic <=
(6) => msi <=
(5) => pcihostbridge:0,0x10,0xcf8,0xe0000000 <=
(6) => ioapic <=
(5) => pmtimer:0x8000 <=
(6) => pcihostbridge:0,0x10,0xcf8,0xe0000000 <=
(5) => vcpus <=
(6) => pmtimer:0x8000 <=
(5) => vcpu <=
(6) => vcpus <=
(5) create VCPU
(6) => vcpu <=
(5) => halifax <=
(6) create VCPU
(5) startup
(6) => halifax <=
(5) => vbios <=
(6) startup
(5) => lapic <=
(6) => vbios <=
(5) LAPIC freq 102903062
(6) => lapic <=
(5) => 82576vf <=
(6) LAPIC freq 102903062
(6) => 82576vf <=
(5) Attached 82576VF model at f7ce0000+0x4000, f7cc0000+0x1000
(6) Attached 82576VF model at f7ce0000+0x4000, f7cc0000+0x1000
(5) void DBus<M>::debug_dump() [with M = MessageHwIOIn]: Bus used 0 times.
(6) void DBus<M>::debug_dump() [with M = MessageHwIOIn]: Bus used 0 times.
(5) 0: StaticReceiver<Y>::StaticReceiver() [with Y = IOAccess]
(6) 0: StaticReceiver<Y>::StaticReceiver() [with Y = IOAccess]
(5)
(6)
(5) do_gsi_boot eip 80004bd8 esp 80216fec
(6) do_gsi_boot eip 80004bd8 esp 80216fec
(5) RESET device state
(6) RESET device state
(5) do_gsi_boot eip 800057d3 esp 80214fec
(6) do_gsi_boot eip 800057d3 esp 80214fec
(5) INIT done
(6) INIT done
(5) do_gsi_boot eip 800059b8 esp 80215fec
(6) do_gsi_boot eip 800059b8 esp 80215fec
(5) reset CPU from 9 mtr_in e0010
(6) reset CPU from 9 mtr_in e0010
(5) > bool VirtualBiosMultiboot::receive(MessageBios&) rip ffff ilen 3 cr0 10 efl 10002
(6) > bool VirtualBiosMultiboot::receive(MessageBios&) rip ffff ilen 3 cr0 10 efl 10002
(5) module 0 start 0x81c00000+918 cmdline rom://bin/boot/munich
(6) module 0 start 0x81c00000+918 cmdline rom://bin/boot/munich
(5) module 1 start 0x81c02000+32db80 cmdline rom://imgs/bzImage-js clocksource=tsc co
(6) module 1 start 0x81c02000+32db80 cmdline rom://imgs/bzImage-js clocksource=tsc co
(5) module 2 start 0x81f31000+1dd400 cmdline rom://initramfs-netperf.cpio
(6) module 2 start 0x81f31000+1dd400 cmdline rom://initramfs-netperf.cpio
(5) # MUNICH: v.0.4.6 starts Linux
(6) # MUNICH: v.0.4.6 starts Linux
(5) # MUNICH: 2.6.36-rc8-00002-g469008a-dirty (julian@monat) #13 SMP Mon Oct 18 17:10
(6) # MUNICH: 2.6.36-rc8-00002-g469008a-dirty (julian@monat) #13 SMP Mon Oct 18 17:10
(5) # | :10 CEST 2010
(6) # | :10 CEST 2010
(5) # MUNICH: clocksource=tsc console=ttyS0 quiet netserver
(6) # MUNICH: clocksource=tsc console=ttyS0 quiet netperf
(5) # MUNICH: initrd 1B31000
(6) # MUNICH: initrd 1B31000
(5) # MUNICH: copy image
(6) # MUNICH: copy image
(5) # MUNICH: start kernel
(6) # MUNICH: start kernel
(5) handle_int15 eax e801 ebx 0 ecx 0 edx 0 eip ffff efl 10002
(6) 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
(6) 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
(6) handle_int15 eax e980 ebx 0 ecx 0 edx 47534943 eip ffff efl 10002
(5) VESA 4f00 tag 0 base 40000+3610 esi 0
(6) VESA 4f00 tag 0 base 40000+3610 esi 0
(5) handle_int10 eax 4f15 ebx 0 ecx 0 edx 0 eip ffff efl 10003
(6) handle_int10 eax 4f15 ebx 0 ecx 0 edx 0 eip ffff efl 10003
(5) # [ 0.000000] CPU: vendor_id 'NOVA microHV' unknown, using generic init.
(6) # [ 0.000000] CPU: vendor_id 'NOVA microHV' unknown, using generic init.
(5) # [ 0.000000] CPU: Your system may be unstable.
(6) # [ 0.000000] CPU: Your system may be unstable.
(5) # [ 0.020632] ACPI: Unable to load the System Description Tables
(6) # [ 0.020623] ACPI: Unable to load the System Description Tables
(5) # [ 0.072000] NMI watchdog failed to create perf event on cpu0: ffffffed
(6) # [ 0.068000] NMI watchdog failed to create perf event on cpu0: ffffffed
(5) # [ 0.141852] microcode: no support for this CPU vendor
(6) # [ 0.142047] microcode: no support for this CPU vendor
(5) VF_RESET 42:68:38:b4:a3:05
(6) VF_RESET 42:68:38:b4:a3:06
(5) VF_RESET 42:68:38:b4:a3:05
(6) VF_RESET 42:68:38:b4:a3:06
(5) VF_SET_MAC 42:68:38:b4:a3:05
(6) VF_SET_MAC 42:68:38:b4:a3:06
(5) # ˙˙Starting logging: OK
(6) # ˙˙Starting logging: OK
(5) # Initializing random number generator... done.
(6) # Initializing random number generator... done.
(5) # Starting network...
(6) # Starting network...
(5) VF_SET_MULTICAST 00010003 (1) c1680010
(6) VF_SET_MULTICAST 00010003 (1) c1680010
(5) TX queue 0: DISABLED
(6) TX queue 0: DISABLED
(5) TX queue 0: ENABLED
(6) TX queue 0: ENABLED
(5) 82576VF MAP f7ce2+1 from 0x80219000
(6) 82576VF MAP f7ce2+1 from 0x80219000
(5) VF message unknown 00000005
(6) VF message unknown 00000005
(5) VF_SET_MULTICAST 00010003 (1) 00000010
(6) VF_SET_MULTICAST 00010003 (1) 00000010
(5) VF_SET_MULTICAST 00010003 (1) 00000010
(6) VF_SET_MULTICAST 00010003 (1) 00000010
(5) VF_SET_MULTICAST 00020003 (2) 00100010
(6) VF_SET_MULTICAST 00020003 (2) 00100010
(5) VF_SET_MULTICAST 00030003 (3) 00100010
(6) VF_SET_MULTICAST 00030003 (3) 00100010
(5) # Starting netserver at port 1234
(5) # Starting netserver at hostname 192.168.1.1 port 1234 and family AF_INET
(6) # TCP STREAM TEST from 0.0.0.0 (0.0.0.0) port 0 AF_INET to 192.168.1.1 (192.168.1
(6) # | .1) port 0 AF_INET
(6) # Recv Send Send
(6) # Socket Socket Message Elapsed
(6) # Size Size Size Time Throughput
(6) # bytes bytes bytes secs. 10^6bits/sec
(6) #
(6) # 87380 16384 16384 10.00 814.28
(6) # ! /etc/init.d/S99netperf PERF: TCP_offload_off 814.28 Mbps okok
(6) # TCP STREAM TEST from 0.0.0.0 (0.0.0.0) port 0 AF_INET to 192.168.1.1 (192.168.1
(6) # | .1) port 0 AF_INET
(6) # Recv Send Send
(6) # Socket Socket Message Elapsed
(6) # Size Size Size Time Throughput
(6) # bytes bytes bytes secs. 10^6bits/sec
(6) #
(6) # 87380 16384 16384 10.23 89.91
(6) # ! /etc/init.d/S99netperf PERF: TCP_offload_on 89.91 Mbps okok
(6) # wvtest: done
! /home/nul/nul/michal/wvtest/wvnulrun: $assertions_executed > 0 okok
novaboot: Read /home/nul/nul/.novaboot