novaboot: Connecting to IP relay... done | |
<iprelayd: connected> | |
novaboot: Entering directory `/home/nul/nul/build' | |
novaboot: Created bin/apps/pingpong.nulconfig | |
novaboot: Created bin/apps/pong.nulconfig | |
novaboot: Created bin/apps/ping.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/pingpong.nul bin/apps/ping.nul bin/apps/pong.nul bin/apps/pingpong.nulconfig bin/apps/pong.nulconfig bin/apps/ping.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 | |
=> verbose <= | |
=> hostkeyb:0,0x60,1,12,2 <= | |
s0: map self 60000 -> 0 size 1000 offset 0 s 0 typed 1 | |
s0: map self 64000 -> 0 size 1000 offset 0 s 0 typed 1 | |
s0: map self daffb000 -> b6c00000 size 2000 offset 0 s 0 typed 2 | |
s0: map self daff9000 -> b6800000 size 2000 offset 0 s 0 typed 2 | |
=> script_start:1 <= | |
=> script_waitchild <= | |
=> script_start:2,2 <= | |
=> script_waitchild <= | |
sc: start 0-1 count 1 | |
s0: map self daff4000 -> b6400000 size 8000 offset 0 s 0 typed 2 | |
s0: [ 5] module 'namespace::/tmp sigma0::mem:16 name::/s0/log name::/s0/timer name::/s0/fs/rom name::/s0/admission ||' \ | |
s0: ... ' rom://bin/apps/pingpong.nul' | |
s0: map self 3000000 -> b5000000 size 1000000 offset 0 s 0 typed 1 | |
s0: [ 5] using memory: 16 MB (1000000) at 3000000 | |
s0: [ 5] creating PD on CPU 2 | |
s0: [ 5, 4284e] pagefault 4c/0 for 800022b1 err 14 at 800022b1 | |
sc: wait for child 5 | |
s0: [ 5, 4284e] b50022b1 b5000000+1000000 -> order 24: b5000000+1000000 | |
s0: [ 5, 4284e] map 0/1 for 800022b1 err 14 at 800022b1 | |
s0: [ 5, 4284e] pagefault 4c/0 for bffff006 err 4 at 800010c3 | |
s0: [ 5, 4284e] b6400006 b6400000+1000 -> order 12: b6400000+1000 | |
s0: [ 5, 4284e] map 0/1 for bffff006 err 4 at 800010c3 | |
tb: client data 3f000 guid 5 parent 925 | |
(5) ! michal/apps/tests/pingpong.cc:33 ec = create_ec4pt(this, utcb->head.nul_cpunr, 0) ok | ok |
(5) ! michal/apps/tests/pingpong.cc:34 ec = 0x809 ok | ok |
(5) ! michal/apps/tests/pingpong.cc:36 nova_create_pt(pt, ec, reinterpret_cast<unsigned long>(portal_func), 0) ok | ok |
(5) ! michal/apps/tests/pingpong.cc:56 counter == 1000u ok | ok |
(5) ! michal/apps/tests/pingpong.cc:57 PERF: avg 333 cycles ok | ok |
(5) ! michal/apps/tests/pingpong.cc:58 PERF: min 328 cycles ok | ok |
s0: => INIT done <= | |
| |
(5) ! michal/apps/tests/pingpong.cc:59 PERF: max 612 cycles ok | ok |
sc: start 1-2 count 1 | |
s0: [ 6] module 'namespace::/tmp sigma0::mem:16 sigma0::cpu:0 name::/s0/log name::/s0/timer name::/s0/fs/rom name::/s0/admission name::/tmp/pong ||' \ | |
s0: ... ' rom://bin/apps/pong.nul' | |
s0: map self 2000000 -> b4000000 size 1000000 offset 0 s 0 typed 1 | |
s0: [ 6] using memory: 16 MB (1000000) at 2000000 | |
s0: map self daff3000 -> b6000000 size 1000 offset 0 s 0 typed 1 | |
s0: [ 6] creating PD on CPU 0 | |
s0: [ 7] module 'namespace::/tmp sigma0::mem:16 sigma0::cpu:0 name::/s0/log name::/s0/timer name::/s0/fs/rom name::/s0/admission name::/tmp/pong ||' \ | |
s0: ... ' rom://bin/apps/ping.nul' | |
s0: map self 1f000000 -> b3000000 size 1000000 offset 0 s 0 typed 1 | |
s0: [ 7] using memory: 16 MB (1000000) at 1f000000 | |
s0: map self daff2000 -> b2c00000 size 1000 offset 0 s 0 typed 1 | |
s0: [ 7] creating PD on CPU 0 | |
sc: wait for child 7 | |
s0: [ 6, 4300e] pagefault 4c/0 for 8000216f err 14 at 8000216f | |
s0: [ 6, 4300e] b400216f b4000000+1000000 -> order 24: b4000000+1000000 | |
s0: [ 6, 4300e] map 0/1 for 8000216f err 14 at 8000216f | |
s0: [ 7, 4380e] pagefault 4c/0 for 80001fbb err 14 at 80001fbb | |
s0: [ 7, 4380e] b3001fbb b3000000+1000000 -> order 24: b3000000+1000000 | |
s0: [ 7, 4380e] map 0/1 for 80001fbb err 14 at 80001fbb | |
s0: [ 7, 4380e] pagefault 4c/0 for bffff006 err 4 at 800014c9 | |
s0: [ 7, 4380e] b2c00006 b2c00000+1000 -> order 12: b2c00000+1000 | |
s0: [ 7, 4380e] map 0/1 for bffff006 err 4 at 800014c9 | |
tb: client data 3f002 guid 7 parent 91f | |
(7) ! michal/apps/tests/ping.cc:35 ParentProtocol::get_pseudonym(*utcb, "pong", 0, pseudonym) ok | ok |
s0: [ 6, 4300e] pagefault 4c/0 for bffff006 err 4 at 8000100b | |
(7) ! michal/apps/tests/ping.cc:37 res = ParentProtocol::get_portal(*utcb, pseudonym, pt, true) ok | ok |
s0: [ 6, 4300e] b6000006 b6000000+1000 -> order 12: b6000000+1000 | |
s0: [ 6, 4300e] map 0/1 for bffff006 err 4 at 8000100b | |
tb: client data 3f004 guid 6 parent 3f003 | |
(6) ! michal/apps/tests/pong.cc:31 ec = create_ec4pt(this, utcb->head.nul_cpunr, 0) ok | ok |
(6) ! michal/apps/tests/pong.cc:32 ec = 0x80a ok | ok |
(6) ! michal/apps/tests/pong.cc:34 nova_create_pt(pt, ec, reinterpret_cast<unsigned long>(portal_func), 0) ok | ok |
(6) ! michal/apps/tests/pong.cc:35 ParentProtocol::register_service(*utcb, "/pong", utcb->head.nul_cpunr, pt, service_cap) ok | ok |
(7) ! michal/apps/tests/ping.cc:37 res = ParentProtocol::get_portal(*utcb, pseudonym, pt, true) ok | ok |
(7) ! michal/apps/tests/ping.cc:39 res ok | ok |
(7) ! michal/apps/tests/ping.cc:60 PERF: xpd_avg 712 cycles ok | ok |
(7) ! michal/apps/tests/ping.cc:61 PERF: xpd_min 708 cycles ok | ok |
(7) ! michal/apps/tests/ping.cc:62 PERF: xpd_max 980 cycles ok | ok |
sc: done. | |
! /home/nul/nul/michal/wvtest/wvnulrun: $assertions_executed > 0 ok | ok |
novaboot: Read /home/nul/nul/.novaboot | |