The following is an example of a memory allocation problem that may occur during application execution. In this problem example, an overwriting of a memory of an object in the heap by an object in the stack of another object in the heap occurs.

guard_scheduler_cpu_affinity_test_string_buffer_link_allocation_error.txt

sending incremental file list
app/.epos_flag_file.txt
app/test.txt
include/thread.h
include/utility/spin.h
src/component/thread.cc

sent 11,666 bytes  received 5,269 bytes  11,290.00 bytes/sec
total size is 3,465,190  speedup is 204.62

The current directory is:
/home/linux/OperatingSystems/Epos2x86

The current path is: /usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games
Running the command: sh compile_and_run.sh guard_scheduler_cpu_affinity_test
Running the command: make APPLICATION=$APPLICATION_NAME run
mkdir -p /home/linux/OperatingSystems/Epos2x86/bin
mkdir -p /home/linux/OperatingSystems/Epos2x86/lib
make --print-directory run1
make[1]: Entering directory '/home/linux/OperatingSystems/Epos2x86'
mkdir -p /home/linux/OperatingSystems/Epos2x86/bin
mkdir -p /home/linux/OperatingSystems/Epos2x86/lib
(cd etc && make --print-directory)
make[2]: Entering directory '/home/linux/OperatingSystems/Epos2x86/etc'
sed -e 's/^#define MODE.*$/#define MODE library/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define ARCH.*$/#define ARCH ia32/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define MACH.*$/#define MACH pc/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define MMOD.*$/#define MMOD legacy_pc/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define APPL.*$/#define APPL guard_scheduler_cpu_affinity_test/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define __mode_.*__$/#define __mode_library__/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define __arch_.*__$/#define __arch_ia32__/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define __mach_.*__$/#define __mach_pc__/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
sed -e 's/^#define __mmod_.*__$/#define __mmod_legacy_pc__/' -i /home/linux/OperatingSystems/Epos2x86/include/system/config.h
make[2]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/etc'
(cd tools && make --print-directory)
make[2]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools'
make --print-directory all_multithread -j4
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools'
(cd eposcc && make --print-directory)
(cd eposcfg && make --print-directory)
(cd eposflash && make --print-directory)
(cd eposiotgw && make --print-directory)
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools/eposcfg'
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools/eposiotgw'
make[4]: Nothing to be done for 'all'.
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools/eposiotgw'
(cd eposmkbi && make --print-directory)
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools/eposflash'
chmod +x eposflash-emote3 eposflash-zynq
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools/eposcc'
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools/eposflash'
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools/eposmkbi'
(cd epossectst && make --print-directory)
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/tools/epossectst'
chmod +x eposbignumtst.py
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools/epossectst'
install -m 775 eposcfg /home/linux/OperatingSystems/Epos2x86/bin
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools/eposcfg'
install -m 775 eposcc /home/linux/OperatingSystems/Epos2x86/bin
sed -e 's/^EPOS=.*$/EPOS=\/home\/linux\/OperatingSystems\/Epos2x86/' -i /home/linux/OperatingSystems/Epos2x86/bin/eposcc
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools/eposcc'
install -m 775 eposmkbi /home/linux/OperatingSystems/Epos2x86/bin
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools/eposmkbi'
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools'
make[2]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/tools'
(cd src && make --print-directory)
make[2]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src'
(cd utility && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/utility'
make --print-directory all_multithread -j4
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/utility'
make[4]: Nothing to be done for 'all_multithread'.
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/utility'
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/utility'
(cd architecture && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/architecture'
make --print-directory all_multithread -j4
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/architecture'
(cd ia32 && make --print-directory)
make[5]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/architecture/ia32'
install ia32_crt0.o ia32_crtbegin.o ia32_crtend.o /home/linux/OperatingSystems/Epos2x86/lib
make[5]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/architecture/ia32'
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/architecture'
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/architecture'
(cd machine && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/machine'
make --print-directory all_multithread -j4
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/machine'
(cd common && make --print-directory)
(cd pc && make --print-directory)
make[5]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/machine/common'
make[5]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/machine/pc'
make[5]: Nothing to be done for 'all'.
make[5]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/machine/common'
make[5]: Nothing to be done for 'all'.
make[5]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/machine/pc'
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/machine'
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/machine'
(cd component && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/component'
make --print-directory all_multithread -j4
make[4]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/component'
/usr/local/ia32/gcc-4.4.4/bin/ia32-g++ -c --no-exceptions --no-rtti --no-use-cxa-atexit -std=c++0x -Wa,--32 -O2 -nostdinc -Wall -Werror -fdata-sections -ffunction-sections -I/home/linux/OperatingSystems/Epos2x86/include thread.cc
/usr/local/ia32/gcc-4.4.4/bin/ia32-ar rcs /home/linux/OperatingSystems/Epos2x86/lib/libsys_ia32.a thread.o
make[4]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/component'
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/component'
(cd setup && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/setup'
install pc_setup /home/linux/OperatingSystems/Epos2x86/img
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/setup'
(cd boot && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/boot'
dd if=pc_boot of=pc_boot.tmp ibs=32 skip=1 obs=512 >& /dev/null
install pc_boot.tmp /home/linux/OperatingSystems/Epos2x86/img/pc_boot
rm -f pc_boot.tmp
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/boot'
(cd system && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/system'
/usr/local/ia32/gcc-4.4.4/bin/ia32-ld  -nostdlib -L/home/linux/OperatingSystems/Epos2x86/lib -Bstatic -i system_scaffold.o system_binding.o -o pc_system.o
install application_scaffold.o pc_application.o
install pc_system.o /home/linux/OperatingSystems/Epos2x86/lib
install pc_application.o /home/linux/OperatingSystems/Epos2x86/lib
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/system'
(cd init && make --print-directory)
make[3]: Entering directory '/home/linux/OperatingSystems/Epos2x86/src/init'
install init_first.o pc_init_first.o
install init_system.o pc_init_system.o
install init_application.o pc_init_application.o
install pc_init_first.o /home/linux/OperatingSystems/Epos2x86/lib
install pc_init_system.o /home/linux/OperatingSystems/Epos2x86/lib
install pc_init_application.o /home/linux/OperatingSystems/Epos2x86/lib
make[3]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src/init'
make[2]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/src'
(cd app && make --print-directory)
make[2]: Entering directory '/home/linux/OperatingSystems/Epos2x86/app'
/home/linux/OperatingSystems/Epos2x86/bin/eposcc --library --gc-sections --nmagic -o guard_scheduler_cpu_affinity_test guard_scheduler_cpu_affinity_test.o
install guard_scheduler_cpu_affinity_test /home/linux/OperatingSystems/Epos2x86/img
make[2]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/app'
(cd img && make --print-directory)
make[2]: Entering directory '/home/linux/OperatingSystems/Epos2x86/img'
/home/linux/OperatingSystems/Epos2x86/bin/eposmkbi /home/linux/OperatingSystems/Epos2x86 guard_scheduler_cpu_affinity_test.img guard_scheduler_cpu_affinity_test

EPOS bootable image tool

  EPOS mode: library
  Machine: pc
  Model: legacy_pc
  Processor: ia32 (32 bits, little-endian)
  Memory: 262144 KBytes
  Boot Length: 512 - 512 (min - max) KBytes
  Node id: will get from the network
  EPOS Image UUID: 006c25bab518a979
  Creating EPOS bootable image in "guard_scheduler_cpu_affinity_test.img":
    Adding boot strap "/home/linux/OperatingSystems/Epos2x86/img/pc_boot": done.
    Adding setup "/home/linux/OperatingSystems/Epos2x86/img/pc_setup": done.
    Adding application "guard_scheduler_cpu_affinity_test": done.
    Adding system info: done.

  Adding specific boot features of "pc": done.

  Image successfully generated (163576 bytes)!

make[2]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/img'
(cd img && make --print-directory run)
make[2]: Entering directory '/home/linux/OperatingSystems/Epos2x86/img'
# qemu-system-i386 -smp 2 -m 262144k -nographic -no-reboot -drive format=raw,index=0,if=floppy,file=guard_scheduler_cpu_affinity_test.img | tee guard_scheduler_cpu_affinity_test.out
qemu-system-i386 -smp 2 -m 262144k -nographic -no-reboot -drive format=raw,index=0,if=floppy,file=guard_scheduler_cpu_affinity_test.img
<0>: PC_Setup(bi=0x0010e000,sp=0x0010df6c) :<0>
<0>: System_Info={
Boot_Map={n_cpus=2,mem_base=0x00000000,mem_top=0x10000000,io_base=0x00000000,io_top=0x00000000,node_id=-1,img_size=163064,setup_offset=0x200,init_offset=-1,system_offset=-1,application_offset=0xba34,extras_offset=-1}
Physical_Memory_Map={mem_base=0x01010101,mem_top=0x01010101,io_base=0x01010101,io_top=0x01010101,ext_base=0x01010101,ext_top=0x01010101,idt=0x01010101,gdt=0x01010101,sys_pt=0x01010101,sys_pd=0x01010101,sys_info=0x01010101,phy_mem_pts=0x01010101,io_pts=0x01010101,sys_code=0x01010101,sys_data=0x01010101,sys_stack=0x01010101,free1_base=0x01010101,free1_top=0x01010101,free2_base=0x01010101,free2_top=0x01010101,free3_base=0x01010101,free3_top=0x01010101}
Load_Map={has_stp=1,has_ini=1,has_sys=1,has_app=1,has_ext=1,stp_entry=0x01010101,stp_segments=16843009,stp_code=0x01010101,stp_code_size=16843009,stp_data=0x01010101,stp_data_size=16843009,ini_entry=0x01010101,ini_segments=16843009,ini_code=0x01010101,ini_code_size=16843009,ini_data=0x01010101,ini_data_size=16843009,sys_entry=0x01010101,sys_segments=16843009,sys_code=0x01010101,sys_code_size=16843009,sys_data=0x01010101,sys_data_size=16843009,sys_stack=0x01010101,sys_stack_size=16843009,app_entry=0x01010101,app_segments=16843009,app_code=0x01010101,app_code_size=16843009,app_data=0x01010101,app_stack=0x01010101,app_heap=0x01010101,app_data_size=16843009,app_extra=0x01010101,app_extra_size=16843009}
Time_Map={cpu_clock=16843009,bus_clock=16843009}} :<0>
<1>: PC_Setup(bi=0x0010e000,sp=0x0010cf6c) :<1>
<1>: System_Info={
Boot_Map={n_cpus=2,mem_base=0x00000000,mem_top=0x10000000,io_base=0x00000000,io_top=0x00000000,node_id=-1,img_size=163064,setup_offset=0x200,init_offset=-1,system_offset=-1,application_offset=0xba34,extras_offset=-1}
Physical_Memory_Map={mem_base=0x01010101,mem_top=0x01010101,io_base=0x01010101,io_top=0x01010101,ext_base=0x01010101,ext_top=0x01010101,idt=0x01010101,gdt=0x01010101,sys_pt=0x01010101,sys_pd=0x01010101,sys_info=0x01010101,phy_mem_pts=0x01010101,io_pts=0x01010101,sys_code=0x01010101,sys_data=0x01010101,sys_stack=0x01010101,free1_base=0x01010101,free1_top=0x01010101,free2_base=0x01010101,free2_top=0x01010101,free3_base=0x01010101,free3_top=0x01010101}
Load_Map={has_stp=1,has_ini=1,has_sys=1,has_app=1,has_ext=1,stp_entry=0x01010101,stp_segments=16843009,stp_code=0x01010101,stp_code_size=16843009,stp_data=0x01010101,stp_data_size=16843009,ini_entry=0x01010101,ini_segments=16843009,ini_code=0x01010101,ini_code_size=16843009,ini_data=0x01010101,ini_data_size=16843009,sys_entry=0x01010101,sys_segments=16843009,sys_code=0x01010101,sys_code_size=16843009,sys_data=0x01010101,sys_data_size=16843009,sys_stack=0x01010101,sys_stack_size=16843009,app_entry=0x01010101,app_segments=16843009,app_code=0x01010101,app_code_size=16843009,app_data=0x01010101,app_stack=0x01010101,app_heap=0x01010101,app_data_size=16843009,app_extra=0x01010101,app_extra_size=16843009}
Time_Map={cpu_clock=16843009,bus_clock=16843009}} :<1>
<0>: PC_Setup::detect_memory() :<0>
<0>: Memory={base=0x00000000,top=0x10000000} :<0>
<0>: PC_Setup::calibrate_timers() :<0>
<0>: PC_Setup::calibrate_timers:CPU clock=2669 MHz :<0>
<0>: PC_Setup::calibrate_timers:BUS clock=309 MHz :<0>
<0>: PC_Setup::detect_pci() :<0>
<0>: PCI[0:0.0]={vnd_id=0x00008086,dev_id=0x00001237,cmd=0x00000103,stat=0x00000000} :<0>
<0>: PCI[0:1.0]={vnd_id=0x00008086,dev_id=0x00007000,cmd=0x00000103,stat=0x00000200} :<0>
<0>: PCI[0:1.1]={vnd_id=0x00008086,dev_id=0x00007010,cmd=0x00000103,stat=0x00000280} :<0>
<0>:   reg[4]={io,phy=0x0000c040,size=0x00000010} :<0>
<0>: PCI: device [0:1.3] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:1.3] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:1.3] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:1.3] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:1.3] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:1.3] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI[0:1.3]={vnd_id=0x00008086,dev_id=0x00007113,cmd=0x00000103,stat=0x00000280} :<0>
<0>: PCI: device [0:2.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:2.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:2.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:2.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI[0:2.0]={vnd_id=0x00001234,dev_id=0x00001111,cmd=0x00000103,stat=0x00000000} :<0>
<0>:   reg[0]={mem,phy=0xfd000000,log=0xed00a000,size=0x01000000} :<0>
<0>:   reg[2]={mem,phy=0xfebb0000,log=0xeebba000,size=0x00001000} :<0>
<0>: PCI: device [0:3.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:3.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:3.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI: device [0:3.0] reports implausible region (starting at zero). Ignoring! :<0>
<0>: PCI[0:3.0]={vnd_id=0x00008086,dev_id=0x0000100e,cmd=0x00000103,stat=0x00000000} :<0>
<0>:   reg[0]={mem,phy=0xfeb80000,log=0xeeb8a000,size=0x00020000} :<0>
<0>:   reg[1]={io,phy=0x0000c000,size=0x00000040} :<0>
<0>: PCI address space={base=0xfd000000,top=0xfebb1000} :<0>
<0>: No SYSTEM in boot image, assuming EPOS is a library! :<0>
Setting up this machine as follows:
  Processor:    2 x IA32 at 2669 MHz (BUS clock = 309 MHz)
  Memory:       262144 Kbytes [0x00000000:0x10000000]
  User memory:  261800 Kbytes [0x00000000:0x0ffaa000]
  PCI aperture: 28356 Kbytes [0xfd000000:0xfebb1000]
  Node Id:      will get from the network!
  Setup:        48768 bytes
  APP code:     114768 bytes	data: 2400 bytes
<0>: setup_idt(idt=0x0ffff000) :<0>
<0>: IDT[0  ]={sel=1,off=0x80100860,p=1,dpl=3,d=0} (0x80100860) :<0>
<0>: IDT[255]={sel=1,off=0x80100860,p=1,dpl=3,d=0} (0x80100860) :<0>
<0>: setup_gdt(gdt=0x0fffe000) :<0>
<0>: GDT[NULL=0]={bas=0x00000000,lim=0x00000000,p=0,dpl=0,s=0,typ=0,g=0,d=0,a=0} :<0>
<0>: GDT[SYCD=1]={bas=0x00000000,lim=0x000fffff,p=1,dpl=0,s=1,typ=11,g=1,d=1,a=0} :<0>
<0>: GDT[SYDT=2]={bas=0x00000000,lim=0x000fffff,p=1,dpl=0,s=1,typ=3,g=1,d=1,a=0} :<0>
<0>: GDT[APCD=3]={bas=0x00000000,lim=0x000fffff,p=1,dpl=3,s=1,typ=11,g=1,d=1,a=0} :<0>
<0>: GDT[APDT=4]={bas=0x00000000,lim=0x000fffff,p=1,dpl=3,s=1,typ=3,g=1,d=1,a=0} :<0>
<0>: GDT[TSS0=5]={bas=0xff405000,lim=0x00000fff,p=1,dpl=3,s=0,typ=9,g=0,d=0,a=0} :<0>
<0>: GDT[TSS1=6]={bas=0xff406000,lim=0x00000fff,p=1,dpl=3,s=0,typ=9,g=0,d=0,a=0} :<0>
<0>: setup_sys_pt(pmm={idt=0x0ffff000,gdt=0x0fffe000,pt=0x0fffd000,pd=0x0fffc000,info=0x0fffb000,tss0=0x0fff9000,mem=0x0ffb9000,io=0x0ffb2000,sysc=0x0ffb2000,sysd=0x0ffb2000,syss=0x0ffaa000,memb=0x00000000,memt=0x0ffaa000,fr1b=0x0001d000,fr1t=0x000a0000,fr2b=0x00100000,fr2t=0x00400000},code_size=0,data_size=0,stack_size=8) :<0>
<0>: SPT={
[0]=0x0ffff023  [1]=0x0fffe023  [2]=0x0fffd023  [3]=0x0fffc023
[4]=0x0fffb023  [5]=0x0fff9023  [6]=0x0fffa023  [960]=0x0ffaa023
[961]=0x0ffab023  [962]=0x0ffac023  [963]=0x0ffad023  [964]=0x0ffae023
[965]=0x0ffaf023  [966]=0x0ffb0023  [967]=0x0ffb1023
} :<0>
<0>: setup_sys_pd(pmm={idt=0x0ffff000,...},mem_base=0x00000000,mem_top=0x0ffaa000,io_base=0xfd000000,io_top=0xfebb1000) :<0>
<0>: SPD={
[0]=0x0ffb9027  [1]=0x0ffba027  [2]=0x0ffbb027  [3]=0x0ffbc027
[4]=0x0ffbd027  [5]=0x0ffbe027  [6]=0x0ffbf027  [7]=0x0ffc0027
[8]=0x0ffc1027  [9]=0x0ffc2027  [10]=0x0ffc3027  [11]=0x0ffc4027
[12]=0x0ffc5027  [13]=0x0ffc6027  [14]=0x0ffc7027  [15]=0x0ffc8027
[16]=0x0ffc9027  [17]=0x0ffca027  [18]=0x0ffcb027  [19]=0x0ffcc027
[20]=0x0ffcd027  [21]=0x0ffce027  [22]=0x0ffcf027  [23]=0x0ffd0027
[24]=0x0ffd1027  [25]=0x0ffd2027  [26]=0x0ffd3027  [27]=0x0ffd4027
[28]=0x0ffd5027  [29]=0x0ffd6027  [30]=0x0ffd7027  [31]=0x0ffd8027
[32]=0x0ffd9027  [33]=0x0ffda027  [34]=0x0ffdb027  [35]=0x0ffdc027
[36]=0x0ffdd027  [37]=0x0ffde027  [38]=0x0ffdf027  [39]=0x0ffe0027
[40]=0x0ffe1027  [41]=0x0ffe2027  [42]=0x0ffe3027  [43]=0x0ffe4027
[44]=0x0ffe5027  [45]=0x0ffe6027  [46]=0x0ffe7027  [47]=0x0ffe8027
[48]=0x0ffe9027  [49]=0x0ffea027  [50]=0x0ffeb027  [51]=0x0ffec027
[52]=0x0ffed027  [53]=0x0ffee027  [54]=0x0ffef027  [55]=0x0fff0027
[56]=0x0fff1027  [57]=0x0fff2027  [58]=0x0fff3027  [59]=0x0fff4027
[60]=0x0fff5027  [61]=0x0fff6027  [62]=0x0fff7027  [63]=0x0fff8027
[512]=0x0ffb9023  [513]=0x0ffba023  [514]=0x0ffbb023  [515]=0x0ffbc023
[516]=0x0ffbd023  [517]=0x0ffbe023  [518]=0x0ffbf023  [519]=0x0ffc0023
[520]=0x0ffc1023  [521]=0x0ffc2023  [522]=0x0ffc3023  [523]=0x0ffc4023
[524]=0x0ffc5023  [525]=0x0ffc6023  [526]=0x0ffc7023  [527]=0x0ffc8023
[528]=0x0ffc9023  [529]=0x0ffca023  [530]=0x0ffcb023  [531]=0x0ffcc023
[532]=0x0ffcd023  [533]=0x0ffce023  [534]=0x0ffcf023  [535]=0x0ffd0023
[536]=0x0ffd1023  [537]=0x0ffd2023  [538]=0x0ffd3023  [539]=0x0ffd4023
[540]=0x0ffd5023  [541]=0x0ffd6023  [542]=0x0ffd7023  [543]=0x0ffd8023
[544]=0x0ffd9023  [545]=0x0ffda023  [546]=0x0ffdb023  [547]=0x0ffdc023
[548]=0x0ffdd023  [549]=0x0ffde023  [550]=0x0ffdf023  [551]=0x0ffe0023
[552]=0x0ffe1023  [553]=0x0ffe2023  [554]=0x0ffe3023  [555]=0x0ffe4023
[556]=0x0ffe5023  [557]=0x0ffe6023  [558]=0x0ffe7023  [559]=0x0ffe8023
[560]=0x0ffe9023  [561]=0x0ffea023  [562]=0x0ffeb023  [563]=0x0ffec023
[564]=0x0ffed023  [565]=0x0ffee023  [566]=0x0ffef023  [567]=0x0fff0023
[568]=0x0fff1023  [569]=0x0fff2023  [570]=0x0fff3023  [571]=0x0fff4023
[572]=0x0fff5023  [573]=0x0fff6023  [574]=0x0fff7023  [575]=0x0fff8023
[960]=0x0ffb2833  [961]=0x0ffb3833  [962]=0x0ffb4833  [963]=0x0ffb5833
[964]=0x0ffb6833  [965]=0x0ffb7833  [966]=0x0ffb8833  [1021]=0x0fffd023

} :<0>
<0>: IP=0x00105bb8 :<0>
<0>: SP=0x0010df6c :<0>
<0>: CR0=0x00000011 :<0>
<0>: CR3=0x00000000 :<0>
<0>: setup_tss(tss0=0xff405000) :<0>
<0>: TR=40,TSS0={ss0=16,esp0=0xff7c4000} :<0>
<0>: PC_Setup::load_app() :<0>
<1>: setup_tss(tss1=0xff406000) :<1>
<1>: TR=48,TSS1={ss0=16,esp0=0xff7c4000} :<1>
<0>: IP=0x001059be :<0>
<0>: SP=0x0010df6c :<0>
<0>: CR0=0x80000011 :<0>
<0>: CR3=0x0fffc000 :<0>
<0>: PC_Setup::call_next(ip=0x00000040,sp=0xff7c3ff8) => APPLICATION :<0>
<0>: System_Info={
Boot_Map={n_cpus=2,mem_base=0x00000000,mem_top=0x10000000,io_base=0x00000000,io_top=0x00000000,node_id=-1,img_size=163064,setup_offset=0x200,init_offset=-1,system_offset=-1,application_offset=0xba34,extras_offset=-1}
Physical_Memory_Map={mem_base=0x00000000,mem_top=0x0ffaa000,io_base=0xfd000000,io_top=0xfebb1000,ext_base=0x00000000,ext_top=0x00000000,idt=0x0ffff000,gdt=0x0fffe000,sys_pt=0x0fffd000,sys_pd=0x0fffc000,sys_info=0x0fffb000,phy_mem_pts=0x0ffb9000,io_pts=0x0ffb2000,sys_code=0x0ffb2000,sys_data=0x0ffb2000,sys_stack=0x0ffaa000,free1_base=0x0001d000,free1_top=0x000a0000,free2_base=0x00100000,free2_top=0x00400000,free3_base=0x00401000,free3_top=0x0ffaa000}
Load_Map={has_stp=1,has_ini=0,has_sys=0,has_app=1,has_ext=0,stp_entry=0x00100000,stp_segments=1,stp_code=0x00100000,stp_code_size=48768,stp_data=0xffffffff,stp_data_size=0,ini_entry=0x00000000,ini_segments=0,ini_code=0xffffffff,ini_code_size=0,ini_data=0xffffffff,ini_data_size=0,sys_entry=0x00000000,sys_segments=0,sys_code=0xffffffff,sys_code_size=0,sys_data=0xffffffff,sys_data_size=0,sys_stack=0xff7c0000,sys_stack_size=32768,app_entry=0x00000040,app_segments=0,app_code=0x00000000,app_code_size=114768,app_data=0x00400000,app_stack=0x01010101,app_heap=0x01010101,app_data_size=2400,app_extra=0x01010101,app_extra_size=16843009}
Time_Map={cpu_clock=2669791180,bus_clock=309603520}} :<0>
<0>: SETUP ends here! :<0>
<1>: IP=0x001059be :<1>
<1>: SP=0x0010cf6c :<1>
<1>: CR0=0x80000011 :<1>
<1>: CR3=0x0fffc000 :<1>
<1>: PC_Setup::call_next(ip=0x00000040,sp=0xff7c7ff8) => APPLICATION :<1>
<1>: System_Info={
Boot_Map={n_cpus=2,mem_base=0x00000000,mem_top=0x10000000,io_base=0x00000000,io_top=0x00000000,node_id=-1,img_size=163064,setup_offset=0x200,init_offset=-1,system_offset=-1,application_offset=0xba34,extras_offset=-1}
Physical_Memory_Map={mem_base=0x00000000,mem_top=0x0ffaa000,io_base=0xfd000000,io_top=0xfebb1000,ext_base=0x00000000,ext_top=0x00000000,idt=0x0ffff000,gdt=0x0fffe000,sys_pt=0x0fffd000,sys_pd=0x0fffc000,sys_info=0x0fffb000,phy_mem_pts=0x0ffb9000,io_pts=0x0ffb2000,sys_code=0x0ffb2000,sys_data=0x0ffb2000,sys_stack=0x0ffaa000,free1_base=0x0001d000,free1_top=0x000a0000,free2_base=0x00100000,free2_top=0x00400000,free3_base=0x00401000,free3_top=0x0ffaa000}
Load_Map={has_stp=1,has_ini=0,has_sys=0,has_app=1,has_ext=0,stp_entry=0x00100000,stp_segments=1,stp_code=0x00100000,stp_code_size=48768,stp_data=0xffffffff,stp_data_size=0,ini_entry=0x00000000,ini_segments=0,ini_code=0xffffffff,ini_code_size=0,ini_data=0xffffffff,ini_data_size=0,sys_entry=0x00000000,sys_segments=0,sys_code=0xffffffff,sys_code_size=0,sys_data=0xffffffff,sys_data_size=0,sys_stack=0xff7c0000,sys_stack_size=32768,app_entry=0x00000040,app_segments=0,app_code=0x00000000,app_code_size=114768,app_data=0x00400000,app_stack=0x01010101,app_heap=0x01010101,app_data_size=2400,app_extra=0x01010101,app_extra_size=16843009}
Time_Map={cpu_clock=2669791180,bus_clock=309603520}} :<1>
<1>: SETUP ends here! :<1>
<0>: Init_System() :<0>
<1>: Init_System() :<1>
<0>: Initializing the CPU:  :<0>
<0>: CPU::init() :<0>
<0>: MMU::init() :<0>
<0>: MMU::memory={base=0x00000000,size=262144KB} :<0>
<0>: MMU::free1={base=0x0001d000,size=524KB} :<0>
<0>: MMU::free2={base=0x00100000,size=3072KB} :<0>
<0>: MMU::free3={base=0x00401000,size=257700KB} :<0>
<0>: MMU::free(frame=0x0001d000,color=0,n=131) :<0>
<0>: Grouping_List::insert_merging(e=0x8001d000) :<0>
<0>: List::insert_tail(e=0x8001d000) => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400930]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List::insert_first(e=0x8001d000) => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400930]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: MMU::free(frame=0x00100000,color=0,n=768) :<0>
<0>: Grouping_List::insert_merging(e=0x80100000) :<0>
<0>: List::insert_tail(e=0x80100000) => {p=0x00000000,o=0x00100000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80100000 => {p=0x8001d000,o=0x00100000,n=0x00000000} :<0>
<0>: MMU::free(frame=0x00401000,color=0,n=64425) :<0>
<0>: Grouping_List::insert_merging(e=0x80401000) :<0>
<0>: List::insert_tail(e=0x80401000) => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80100000 => {p=0x8001d000,o=0x00100000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: MMU::master page directory=0x0fffc000 :<0>
<0>: PMU::init() :<0>
<0>: PMU::init:CPUID(0)={max=4,vendor=GenuineIntel} :<0>
<0>: PMU::init:CPUID(1)={family=6,model=6,cache line=64} :<0>
<0>: PMU::init:CPUID(10)={eax=0,ebx=0,ecx=0,edx=0} :<0>
<0>: PMU::init:CPUID(10)={ver=0,counters=0,width=0,fixed counters=0} :<0>
<0>: Initializing the CPU done! :<0>
<0>: Initializing system's heap:  :<0>
<0>: Grouping_List::search_decrementing(s=68) :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: MMU::alloc(frames=68,color=0) => 0x0005c000 :<0>
<0>: Heap(addr=0x0005c000,bytes=278528) => 0x004000b4 :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0005c000,bytes=278528) :<0>
<0>: Grouping_List::insert_merging(e=0x0005c000) :<0>
<0>: List::insert_tail(e=0x0005c000) => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x004000b4]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List::insert_first(e=0x0005c000) => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x004000b4]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: Initializing system's heap done! :<0>
<0>: Initializing the machine:  :<0>
<0>: Machine::init() :<0>
<0>: IC::init() :<0>
<0>: IC::disable() :<0>
<0>: PCI::init(pmm.io_mem=0xfd000000) :<0>
<0>: Timer::init() :<0>
<0>: IC::int_vector(int=32,h=0x0001a6d0) :<0>
<0>: IC::enable(int=32) :<0>
<0>: Initializing the machine done! :<0>
<0>: Initializing system abstractions:  :<0>
<0>: Alarm::init() :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=24Grouping_List::search_decrementing(s=28) :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: ) => 0x0009ffe8 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Timer(f=10,h=0x00013bd0,ch=1) => {count=1} :<0>
<0>: IC::int_vector(int=49,h=0x000182d0) :<0>
<0>: IC::enable(int=49) :<0>
<0>: Initializing system abstractions done! :<0>
<0>: Randomizing the Random Numbers Generator's seed:  :<0>
<0>: Randomizing the Random Numbers Generator done! :<0>
<0>: Initialization continues at init_first! :<0>
<0>: Guard(head=0x00000000, tail=0x00000000) => 0x00400050 :<0>
<0>: Init_Application() :<0>
<1>: CPU::init() :<1>
<1>: MMU is disabled! :<1>
<1>: PMU::init() :<1>
<1>: Timer::init() :<1>
<1>: IC::int_vector(int=32,h=0x0001a6d0) :<1>
<1>: IC::enable(int=32) :<1>
<1>: IC::enable(int=49) :<1>
<1>: Guard(head=0x00000000, tail=0x00000000) => 0x00400050 :<1>
<1>: Init_Application() :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x00000000, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x00000000, level=1, owner=1) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=1]() => {owner=0,level=0} :<0>
<0>: Initializing application's heap:  :<0>
<0>: Grouping_List::search_decrementing(s=63) :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List::remove(e=0x8001d000) => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400930]::head=0x8001d000 => {p=0x00000000,o=0x0001d000,n=0x80100000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x80100000 => {p=0x00000000,o=0x00100000,n=0x80401000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x80100000 => {p=0x00000000,o=0x00100000,n=0x80401000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: MMU::alloc(frames=63,color=0) => 0x0001d000 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0001d000,bytes=258048) :<0>
<0>: Grouping_List::insert_merging(e=0x0001d000) :<0>
<0>: List::insert_tail(e=0x0001d000) => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x0001d000} :<0>
<0>: List[0x004000b4]::tail=0x0001d000 => {p=0x0005c000,o=0x0001d000,n=0x00000000} :<0>
<0>: List::remove(e=0x0005c000) => {p=0x00000000,o=0x0005c000,n=0x0001d000} :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x0001d000} :<0>
<0>: List[0x004000b4]::tail=0x0001d000 => {p=0x0005c000,o=0x0001d000,n=0x00000000} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x004000b4]::head=0x0005c000 => {p=0x00000000,o=0x0005c000,n=0x0001d000} :<0>
<0>: List[0x004000b4]::tail=0x0001d000 => {p=0x0005c000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Grouping_List::search_decrementing(s=768) :<0>
<0>: List[0x00400930]::head=0x80100000 => {p=0x00000000,o=0x00100000,n=0x80401000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List::remove(e=0x80100000) => {p=0x00000000,o=0x00100000,n=0x80401000} :<0>
<0>: List[0x00400930]::head=0x80100000 => {p=0x00000000,o=0x00100000,n=0x80401000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400930]::head=0x80100000 => {p=0x00000000,o=0x00100000,n=0x80401000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x80100000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: MMU::alloc(frames=768,color=0) => 0x00100000 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x00100000,bytes=3145728) :<0>
<0>: Grouping_List::insert_merging(e=0x00100000) :<0>
<0>: List::insert_tail(e=0x00100000) => {p=0x00000000,o=0x00100000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::tail=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00100000 => {p=0x0001d000,o=0x00100000,n=0x00000000} :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Grouping_List::search_decrementing(s=64425) :<0>
<0>: List[0x00400930]::head=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List::remove(e=0x80401000) => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List::remove_last() :<0>
<0>: List[0x00400930]::head=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::tail=0x80401000 => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x00400930]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400930]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400930]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400930]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: MMU::alloc(frames=64425,color=0) => 0x00401000 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x00401000,bytes=263884800) :<0>
<0>: Grouping_List::insert_merging(e=0x00401000) :<0>
<0>: List::insert_tail(e=0x00401000) => {p=0x00000000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00100000 => {p=0x0001d000,o=0x00100000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x000<1>: Init_First() :<1>
00000,o=0x0001d000,n=0x00100000}
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Init_Application done! :<0>
<0>: Init_First() :<0>
<0>: Initializing the first process:  :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0009ffb4 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x00000000, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Scheduler[chosen=0x00000000]::insert(0x0009ffb4) :<0>
<0>: Scheduling_List::insert(e=0x0009ffd0) => {p=0x00000000,o=0x0009ffb4,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0009bfb0 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00000048,state=1,priority=0,stack={b=0x0009bfb0,s=16384},context={b=0x0009ff7c,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0009ff7c,eip=0x00000048,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x0009ffb4@0 :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=1) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=1]() => {owner=0,level=0} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0009bf7c :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Scheduler[chosen=0x0009ffb4]::insert(0x0009bf7c) :<0>
<0>: Scheduling_List::insert(e=0x0009bf98) => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: Ordered_List::insert(e=0x0009bf98) => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List::insert_first(e=0x0009bf98) => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400100]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00000001]() => {owner=1,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00097f78 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=1]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00017990,state=2,priority=2147483647,stack={b=0x00097f78,s=16384},context={b=0x0009bf44,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0009bf44,eip=<1>: Initializing the first process:  :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00000002]() => {owner=2,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: ) => 0x00097f44 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=2]() => {owner=0,level=0} :<1>
<1>: Thread::lock(this=0x00000000, level=1, owner=1) :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0009ffb4, level=1, owner=1) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00000001]() => {owner=1,level=2} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=2, owner=1) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=1]() => {owner=1,level=1} :<0>
0x00017990,esp3=0,cs=8,ccs=8,cds=16,ces=16,cfs=16,cgs=16,css=16,cr3=0x0fffc000}})| => 0x0009bf7c@0
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=1) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=1]() => {owner=0,level=0} :<0>
<1>: Spin::acquire[SPIN=0x00400120,ID=0x00000002]() => {owner=2,level=1} :<1>
<1>: Scheduler[chosen=0x00000000]::insert(0x00097f44) :<1>
<1>: Scheduling_List::insert(e=0x00097f60) => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00000002]() => {owner=2,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: ) => 0x00093f40 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=2]() => {owner=0,level=0} :<1>
<1>: Thread(task=0x00000000,entry=0x00017990,state=1,priority=2147483647,stack={b=0x00093f40,s=16384},context={b=0x00097f0c,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00097f0c,eip=0x00017990,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x00097f44@1 :<1>
<1>: Thread::unlock(this=0x00097f44, level=1, owner=2) :<1>
<1>: Spin::release[SPIN=0x00400120,ID=2]() => {owner=0,level=0} :<1>
<0>: Init_First: done! :<0>
<0>: INIT ends here! :<0>
<0>: Dispatching the first thread: 0x0009ffb4 :<0>
<1>: Init_First: done! :<1>
<1>: INIT ends here! :<1>
<1>: Dispatching the first thread: 0x00097f44 :<1>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00093f28 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Critical_Section_Base(_link=0x00093f2c) => <1>: Thread::idle(CPU=1,this=0x00097f44) :<1>
<1>: Thread::idle(level=0, owner=0) :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
0x00093f28
<0>: Closure(_entry=0x00008520, PARAMETERS_COUNT=0, PARAMETERS_LENGTH=0, sizeof=8) => 0x00093f34 :<0>
<0>: Critical_Section(_entry=0x00008520) => 0x00093f28 :<0>
<0>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x00000000 item=0x00093f2c, size=1, last=0x00000000) :<0>
<0>: Closure::_unpack_and_run(this=0x00093f34) :<0>
The Philosopher's Dinner:
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00093ef4 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Scheduler[chosen=0x0009ffb4]::insert(0x00093ef4) :<0>
<0>: Scheduling_List::insert(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: Ordered_List::insert(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: List::insert_first(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: List[0x00400110]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400110]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: List[0x00400110]::tail=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0008fef0 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00006f90,state=2,priority=2147483645,stack={b=0x0008fef0,s=16384},context={b=0x00093eb0,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00093eb0,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x00093ef4@1 :<0>
<0>: Thread::constructor_epilogue(locked=0) :<0>
<0>: Thread::reschedule(cpu=1, in) :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Thread::reschedule(cpu=1, out) :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0008febc :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Scheduler[chosen=0x0009ffb4]::insert(0x0008febc) :<0>
<0>: Scheduling_List::insert(e=0x0008fed8) => {p=0x00000000,o=0x0008febc,n=0x00000000} :<0>
<0>: Ordered_List::insert(e=0x0008fed8) => {p=0x00000000,o=0x0008febc,n=0x00000000} :<0>
<0>: List::insert_head(e=0x0008fed8) => {p=0x00000000,o=0x0008febc,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0008beb8 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00006f90,state=2,priority=2147483645,stack={b=0x0008beb8,s=16384},context={b=0x0008fe78,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0008fe78,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x0008febc@0 :<0>
<0>: Thread::constructor_epilogue(locked=0) :<0>
<0>: Thread::reschedule(cpu=0, in) :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Thread::reschedule() :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Scheduler[chosen=0x0009ffb4]::choose() => Scheduling_List::choose() :<0>
<0>: Ordered_List::insert(e=0x0009ffd0) => {p=0x00000000,o=0x0009ffb4,n=0x00000000} :<0>
<0>: List::insert_head(e=0x0009ffd0) => {p=0x00000000,o=0x0009ffb4,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0009ffd0 => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400100]::head=0x0009ffd0 => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: 0x0009ffb4 :<0>
<0>: Thread::dispatch(locked=0) :<0>
<0>: Thread::dispatch(this=0x0009ffb4, level=1, owner=655284, in) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::dispatch(this=0x0009ffb4, level=0, owner=0, out) :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0008be84 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Scheduler[chosen=0x0009ffb4]::insert(0x0008be84) :<0>
<0>: Scheduling_List::insert(e=0x0008bea0) => {p=0x00000000,o=0x0008be84,n=0x00000000} :<0>
<0>: Ordered_List::insert(e=0x0008bea0) => {p=0x00000000,o=0x0008be84,n=0x00000000} :<0>
<0>: List::insert_tail(e=0x0008bea0) => {p=0x00000000,o=0x0008be84,n=0x00000000} :<0>
<0>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: List[0x00400110]::tail=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<0>
<0>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<0>
<0>: List[0x00400110]::tail=0x0008bea0 => {p=0x00093f10,o=0x0008be84,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00087e80 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00006f90,state=2,priority=2147483645,stack={b=0x00087e80,s=16384},context={b=0x0008be40,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0008be40,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x0008be84@1 :<0>
<0>: Thread::constructor_epilogue(locked=0) :<0>
<0>: Thread::reschedule(cpu=1, in) :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Thread::reschedule(cpu=1, out) :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00087e4c :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Scheduler[chosen=0x0009ffb4]::insert(0x00087e4c) :<0>
<0>: Scheduling_List::insert(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x00000000} :<0>
<0>: Ordered_List::insert(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x00000000} :<0>
<0>: List::insert(e=0x00087e68,p=0x0008fed8,n=0x0009bf98) => {p=0x00000000,o=0x00087e4c,n=0x00000000},{p=0x00000000,o=0x0008febc,n=0x0009bf98},{p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x0008fed8,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x00087e68} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00083e48 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00006f90,state=2,priority=2147483645,stack={b=0x00083e48,s=16384},context={b=0x00087e08,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00087e08,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x00087e4c<1>: IC::dispatch(i=49) :<1>
<1>: Thread::lock(this=0x00097f44, level=1, owner=655284) :<1>
@0
<0>: Thread::constructor_epilogue(locked=0) :<0>
<0>: Thread::reschedule(cpu=0, in) :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Thread::reschedule() :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Scheduler[chosen=0x0009ffb4]::choose() => Scheduling_List::choose() :<0>
<0>: Ordered_List::insert(e=0x0009ffd0) => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List::insert_head(e=0x0009ffd0) => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x00087e68} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0009ffd0 => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400100]::head=0x0009ffd0 => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x00087e68} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: 0x0009ffb4 :<0>
<0>: Thread::dispatch(locked=0) :<0>
<0>: Thread::dispatch(this=0x0009ffb4, level=1, owner=655284, in) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::dispatch(this=0x0009ffb4, level=0, owner=0, out) :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=48Grouping_List::search_decrementing(s=52) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x00083e14 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Scheduler[chosen=0x0009ffb4]::insert(0x00083e14) :<0>
<0>: Scheduling_List::insert(e=0x00083e30) => {p=0x00000000,o=0x00083e14,n=0x00000000} :<0>
<0>: Ordered_List::insert(e=0x00083e30) => {p=0x00000000,o=0x00083e14,n=0x00000000} :<0>
<0>: List::insert_tail(e=0x00083e30) => {p=0x00000000,o=0x00083e14,n=0x00000000} :<0>
<0>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<0>
<0>: List[0x00400110]::tail=0x0008bea0 => {p=0x00093f10,o=0x0008be84,n=0x00000000} :<0>
<0>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<0>
<0>: List[0x00400110]::tail=0x00083e30 => {p=0x0008bea0,o=0x00083e14,n=0x00000000} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16384Grouping_List::search_decrementing(s=16388) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: ) => 0x0007fe10 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=655284]() => {owner=0,level=0} :<0>
<0>: Thread(task=0x00000000,entry=0x00006f90,state=2,priority=2147483645,stack={b=0x0007fe10,s=16384},context={b=0x00083dd0,{eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00083dd0,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}}) => 0x00083e14@1 :<0>
<0>: Thread::constructor_epilogue(locked=0) :<0>
<0>: Thread::reschedule(cpu=1, in) :<0>
<0>: Thread::reschedule(locked=0) :<0>
<0>: Thread::reschedule(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Thread::reschedule(cpu=1, out) :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
Philosophers are alive and hungry!
/\|/\The dinner is served ...
<0>: Guard::clear(this=0x00400050 head=0x00093f2c tail=0x00093f2c, size=0, next=0x00000000) :<0>
<0>: ~Closure(this=0x00093f34, _entry=0x00008520, PARAMETERS_COUNT=0, PARAMETERS_LENGTH=0, sizeof=8) :<0>
<0>: ~Critical_Section_Base(this=0x00093f28 _link=0x00093f2c) :<0>
<0>: Heap::free(this=0x004000b4,ptr=<1>: Spin::acquire[SPIN=0x00400120,ID=0x00097f44]() => {owner=622404,level=1} :<1>
<1>: Thread::rescheduler(interrupt=49) :<1>
<1>: Thread::reschedule() :<1>
<1>: Thread::reschedule(locked=1) :<1>
<1>: Thread::reschedule(this=0x00097f44, level=1, owner=622404) :<1>
<1>: Scheduler[chosen=0x00097f44]::choose() => Scheduling_List::choose() :<1>
<1>: Ordered_List::insert(e=0x00097f60) => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List::insert_tail(e=0x00097f60) => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<1>
<1>: List[0x00400110]::tail=0x00083e30 => {p=0x0008bea0,o=0x00083e14,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00083e30,o=0x00097f44,n=0x00000000} :<1>
<1>: List::remove_head() :<1>
<1>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00083e30,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x0008bea0 => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00083e30,o=0x00097f44,n=0x00000<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0009ffb4, level=1, owner=622404) :<0>
000}
<1>: 0x00093ef4 :<1>
<1>: Thread::dispatch(locked=1) :<1>
<1>: Thread::dispatch(this=0x00093ef4, level=1, owner=622404, in) :<1>
<1>: Thread::dispatch(prev=0x00097f44,next=0x00093ef4) :<1>
<1>: prev={0x00097f44,ctx={eflags=0,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00097f0c,eip=0x00000000,esp3=0,cs=0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: next={0x00093ef4,ctx={eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00093eb0,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: Spin::release[SPIN=0x00400120,ID=622404]() => {owner=0,level=0} :<1>
<1>: IC::dispatch(i=49) :<1>
<1>: Thread::lock(this=0x00093ef4, level=0, owner=0) :<1>
<1>: Spin::acquire[SPIN=0x00400120,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Thread::rescheduler(interrupt=49) :<1>
<1>: Thread::reschedule() :<1>
<1>: Thread::reschedule(locked=1) :<1>
<1>: Thread::reschedule(this=0x00093ef4, level=1, owner=605940) :<1>
<1>: Scheduler[chosen=0x00093ef4]::choose() => Scheduling_List::choose() :<1>
<1>: Ordered_List::insert(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x0008bea0} :<1>
<1>: List::insert(e=0x00093f10,p=0x00083e30,n=0x00097f60) => {p=0x00000000,o=0x00093ef4,n=0x0008bea0},{p=0x0008bea0,o=0x00083e14,n=0x00097f60},{p=0x00083e30,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x0008bea0 => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00083e30,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x0008bea0 => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00093f10,o=0x00097f44,n=0x00000000} :<1>
<1>: List::remove_head() :<1>
<1>: List[0x00400110]::head=0x0008bea0 => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00093f10,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x00083e30 => {p=0x00000000,o=0x00083e14,n=0x00093f10} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00093f10,o=0x00097f44,n=0x00000000} :<1>
<1>: 0x0008be84 :<1>
<1>: Thread::dispatch(locked=1) :<1>
<1>: Thread::dispatch(this=0x0008be84, level=1, owner=605940, in) :<1>
<1>: Thread::dispatch(prev=0x00093ef4,next=0x0008be84) :<1>
<1>: prev={0x00093ef4,ctx={eflags=0x202,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00093eb0,eip=0x00006f90,esp3=31,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: next={0x0008be84,ctx={eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0008be40,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: Spin::release[SPIN=0x00400120,ID=605940]() => {owner=0,level=0} :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: ) => 0x0007fdfc :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: StringStream(_buffer_size=101) => 0x0007fdfc :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=102Grouping_List::search_decrementing(s=106) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: ) => 0x0007fd92 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: StringStream::print(this=0x0007fdfc), string=thinking[, string_size=9, total_size=9, _last_position=9, _buffer=thinking[ :<1>
<1>: StringStream::print(this=0x0007fdfc), string=1, string_size=1, total_size=10, _last_position=10, _buffer=thinking[1 :<1>
<1>: StringStream::print(this=0x0007fdfc), string=], string_size=1, total_size=11, _last_position=11, _buffer=thinking[1] :<1>
<1>: StringStream::print(this=0x0007fdfc), string= (, string_size=2, total_size=13, _last_position=13, _buffer=thinking[1] ( :<1>
<1>: StringStream::print(this=0x0007fdfc), string=2, string_size=1, total_size=14, _last_position=14, _buffer=thinking[1] (2 :<1>
<1>: StringStream::print(this=0x0007fdfc), string=), string_size=1, total_size=15, _last_position=15, _buffer=thinking[1] (2) :<1>
<1>: StringStream::print(this=0x0007fdfc), string=
, string_size=1, total_size=16, _last_position=16, _buffer=thinking[1] (2)
 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: ) => 0x0007fd7a :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fd7e) => 0x0007fd7a :<1>
<1>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fd86 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: ) => 0x0007fd6a :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd6a) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd6e) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd72) :<1>
<1>: Critical_Section(_entry=0x00006030) => 0x0007fd7a :<1>
<1>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x00000000 item=0x0007fd7e, size=1, last=0x00000000) :<1>
<1>: Closure::_unpack_and_run(this=0x0007fd86) :<1>
<1>: Closure::unpack_helper(Head=4, address=0x0007fd72(0x0007fd6a), position=8) :<1>
<1>: Closure::unpack_helper(Head=4, address=0x0007fd6e(0x0007fd6a), position=4) :<1>
<1>: Closure::unpack_helper(Head=4, address=0x0007fd6a(0x0007fd6a), position=0) :<1>
<1>: thinking[1] (2)
~StringStream(this=0x0007fdfc, _buffer=0x0007fd92, _buffer_size=101), _last_position=16) :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fd8e,bytes=106) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fd8e) :<1>
<1>: List::insert_tail(e=0x0007fd8e) => {p=0x00000000,o=0x0007fd8e,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd8e => {p=0x00401000,o=0x0007fd8e,n=0x00000000} :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fdf8,bytes=20) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fdf8) :<1>
<1>: Guard::clear(this=0x00400050 head=0x0007fd7e tail=0x0007fd7e, size=0, next=0x00000000) :<1>
<1>: ~Closure(this=0x0007fd86, _entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fd66,bytes=16) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fd66) :<1>
<1>: ~Critical_Section_Base(this=0x0007fd7a _link=0x0007fd7e) :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fd76,bytes=24) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fd76) :<1>
<1>: List::remove(e=0x0007fd8e) => {p=0x00401000,o=0x0007fd8e,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd8e => {p=0x00401000,o=0x0007fd8e,n=0x00000000} :<1>
<1>: List::remove_tail() :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd8e => {p=0x00401000,o=0x0007fd8e,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<1>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0009ffb4, level=1, owner=655284) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
0x00093f24,bytes=24)
<0>: Grouping_List::insert_merging(e=0x00093f24) :<0>
<0>: List::insert_tail(e=0x00093f24) => {p=0x00000000,o=0x00093f24,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00401000 => {p=0x00100000,o=0x00401000,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: Thread::lock(this=0x0009ffb4, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009ffb4]() => {owner=655284,level=1} :<0>
<0>: Thread::join(this=0x00093ef4,state=2) :<0>
<0>: Thread::suspend(this=0x0009ffb4) :<0>
<0>: Scheduler[chosen=0x0009ffb4]::suspend(0x0009ffb4) :<0>
<0>: Scheduling_List::remove(e=0x0009ffd0) => {p=0x00000000,o=0x0009ffb4,n=0x0008fed8} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400100]::head=0x0008fed8 => {p=0x00000000,o=0x0008febc,n=0x00087e68} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x00087e68 => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: Thread::dispatch(locked=1) :<0>
<0>: Thread::dispatch(this=0x0008febc, level=1, owner=655284, in) :<0>
<0>: Thread::dispatch(prev=0x0009ffb4,next=0x0008febc) :<0>
<0>: prev={0x0009ffb4,ctx={eflags=52,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0009ff7c,eip=0x00000048,esp3=0,cs=0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<0>
<0>: next={0x0008febc,ctx={eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0008fe78,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<0>
<0>: Spin::release[SPIN=0x00400120,ID=655284]() => {owner=0,level=0} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: ) => 0x0007fdfc :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: StringStream(_buffer_size=101) => 0x0007fdfc :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=102Grouping_List::search_decrementing(s=106) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: ) => 0x0007fd92 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: StringStream::print(this=0x0007fdfc), string=thinking[, string_size=9, total_size=9, _last_position=9, _buffer=thinking[ :<0>
<0>: StringStream::print(this=0x0007fdfc), string=0, string_size=1, total_size=10, _last_position=10, _buffer=thinking[0 :<0>
<0>: StringStream::print(this=0x0007fdfc), string=], string_size=1, total_size=11, _last_position=11, _buffer=thinking[0] :<0>
<0>: StringStream::print(this=0x0007fdfc), string= (, string_size=2, total_size=13, _last_position=13, _buffer=thinking[0] ( :<0>
<0>: StringStream::print(this=0x0007fdfc), string=1, string_size=1, total_size=14, _last_position=14, _buffer=thinking[0] (1 :<0>
<0>: StringStream::print(this=0x0007fdfc), string=), string_size=1, total_size=15, _last_position=15, _buffer=thinking[0] (1) :<0>
<0>: StringStream::print(this=0x0007fdfc), string=
, string_size=1, total_size=16, _last_position=16, _buffer=thinking[0] (1)
 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: ) => 0x0007fd7a :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: Critical_Section_Base(_link=0x0007fd7e) => 0x0007fd7a :<0>
<0>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fd86 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: ) => 0x0007fd6a :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fd6a) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fd6e) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fd72) :<0>
<0>: Critical_Section(_entry=0x00006030) => 0x0007fd7a :<0>
<0>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x00000000 item=0x0007fd7e, size=1, last=0x00000000) :<0>
<0>: Closure::_unpack_and_run(this=0x0007fd86) :<0>
<0>: Closure::unpack_helper(Head=4, address=0x0007fd72(0x0007fd6a), position=8) :<0>
<0>: Closure::unpack_helper(Head=4, address=0x0007fd6e(0x0007fd6a), position=4) :<0>
<0>: Closure::unpack_helper(Head=4, address=0x0007fd6a(0x0007fd6a), position=0) :<0>
<0>: thinking[0] (1)
~StringStream(this=0x0007fdfc, _buffer=0x0007fd92, _buffer_size=101), _last_position=16) :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0007fd8e,bytes=106) :<0>
<0>: Grouping_List::insert_merging(e=0x0007fd8e) :<0>
<0>: List::insert_tail(e=0x0007fd8e) => {p=0x00000000,o=0x0007fd8e,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd8e => {p=0x00093f24,o=0x0007fd8e,n=0x00000000} :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0007fdf8,bytes=20) :<0>
<0>: Grouping_List::insert_merging(e=0x0007fdf8) :<0>
<0>: Guard::clear(this=0x00400050 head=0x0007fd7e tail=0x0007fd7e, size=0, next=0x00000000) :<0>
<0>: ~Closure(this=0x0007fd86, _entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0007fd66,bytes=16) :<0>
<0>: Grouping_List::insert_merging(e=0x0007fd66) :<0>
<0>: ~Critical_Section_Base(this=0x0007fd7a _link=0x0007fd7e) :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0007fd76,bytes=24) :<0>
<0>: Grouping_List::insert_merging(e=0x0007fd76) :<0>
<0>: List::remove(e=0x0007fd8e) => {p=0x00093f24,o=0x0007fd8e,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd8e => {p=0x00093f24,o=0x0007fd8e,n=0x00000000} :<0>
<0>: List::remove_tail() :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd8e => {p=0x00093f24,o=0x0007fd8e,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fdfc :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: StringStream(_buffer_size=102) => 0x0007fdfc :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=103Grouping_List::search_decrementing(s=107) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd91 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: StringStream::print(this=0x0007fdfc), string=  hungry[, string_size=9, total_size=9, _last_position=9, _buffer=  hungry[ :<1>
<1>: StringStream::print(this=0x0007fdfc), string=1, string_size=1, total_size=10, _last_position=10, _buffer=  hungry[1 :<1>
<1>: StringStream::print(this=0x0007fdfc), string=], string_size=1, total_size=11, _last_position=11, _buffer=  hungry[1] :<1>
<1>: StringStream::print(this=0x0007fdfc), string= (, string_size=2, total_size=13, _last_position=13, _buffer=  hungry[1] ( :<1>
<1>: StringStream::print(this=0x0007fdfc), string=2, string_size=1, total_size=14, _last_position=14, _buffer=  hungry[1] (2 :<1>
<1>: StringStream::print(this=0x0007fdfc), string=), string_size=1, total_size=15, _last_position=15, _buffer=  hungry[1] (2) :<1>
<1>: StringStream::print(this=0x0007fdfc), string=
, string_size=1, total_size=16, _last_position=16, _buffer=  hungry[1] (2)
 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd79 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fd7d) => 0x0007fd79 :<1>
<1>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fd85 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd69 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd69) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd6d) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd71) :<1>
<1>: Critical_Section(_entry=0x00006030) => 0x0007fd79 :<1>
<1>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x00000000 item=0x0007fd7d, size=1, last=0x00000000) :<1>
<1>: Closure::_unpack_and_run(this=0x0007fd85) :<1>
<1>: Closure::unpack_helper(Head=4, address=0x0007fd71(0x0007fd69), position=8) :<1>
<1>: Closure::unpack_helper(Head=4, address=0x0007fd6d(0x0007fd69), position=4) :<1>
<1>: Closure::unpack_helper(Head=4, address=0x0007fd69(0x0007fd69), position=0) :<1>
<1>:   hungry[1] (2)
~StringStream(this=0x0007fdfc, _buffer=0x0007fd91, _buffer_size=102), _last_position=16) :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fd8d,bytes=107) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fd8d) :<1>
<1>: List::insert_tail(e=0x0007fd8d) => {p=0x00000000,o=0x0007fd8d,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd8d => {p=0x00093f24,o=0x0007fd8d,n=0x00000000} :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fdf8,bytes=20) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fdf8) :<1>
<1>: Guard::clear(this=0x00400050 head=0x0007fd7d tail=0x0007fd7d, size=0, next=0x00000000) :<1>
<1>: ~Closure(this=0x0007fd85, _entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fd65,bytes=16) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fd65) :<1>
<1>: ~Critical_Section_Base(this=0x0007fd79 _link=0x0007fd7d) :<1>
<1>: Heap::free(this=0x004000b4,ptr=0x0007fd75,bytes=24) :<1>
<1>: Grouping_List::insert_merging(e=0x0007fd75) :<1>
<1>: List::remove(e=0x0007fd8d) => {p=0x00093f24,o=0x0007fd8d,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd8d => {p=0x00093f24,o=0x0007fd8d,n=0x00000000} :<0>
<0>: ) => 0x0007fd65 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: StringStream(_buffer_size=102) => 0x0007fd65 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=103Grouping_List::search_decrementing(s=107) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd8d => {p=0x00093f24,o=0x0007fd8d,n=0x00000000} :<0>
<0>: ) => 0x0007fcfa :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: StringStream::print(this=0x0007fd65), string=  hungry[, string_size=9, total_size=9, _last_position=9, _buffer=  hungry[ :<0>
<0>: StringStream::print(this=0x0007fd65), string=0, string_size=1, total_size=10, _last_position=10, _buffer=  hungry[0 :<0>
<0>: StringStream::print(this=0x0007fd65), 000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd8d => {p=0x00093f24,o=0x0007fd8d,n=0x00000000} :<1>
<1>: List::remove_tail() :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd8d => {p=0x00093f24,o=0x0007fd8d,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd79 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Condition(<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
string=], <0>: string_size=1, total_size=11, _last_position=11, _buffer=  hungry[0] :<0>
<0>: StringStream::print(this=0x0007fd65), string= (, string_size=2, total_size=13, _last_position=13, _buffer=  hungry[0] ( :<0>
<0>: StringStream::print(this=0x0007fd65), string=1, string_size=1, total_size=14, _last_position=14, _buffer=  hungry[0] (1 :<0>
<0>: StringStream::print(this=0x0007fd65), string=), string_size=1, total_size=15, _last_position=15, _buffer=  hungry[0] (1) :<0>
<0>: StringStream::print(this=0x0007fd65), string=
, string_size=1, total_size=16, _last_position=16, _buffer=  hungry[0] (1)
 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: ) => 0x0007fd61 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: Critical_Section_Base(_link=0x0007fd65) => 0x0007fd61 :<0>
<0>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fd6d :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: ) => 0x0007fd51 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=589500]() => {owner=0,level=0} :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fd51) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fd55) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fd59) :<0>
<0>: Critical_Section(_entry=0x00006030) => 0x0007fd61 :<0>
<0>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x00000000 item=0x0007fd65, size=1) => 0x0007fd7d :<1>
<1>: Future(_is_resolved=0, _condition=0) => 0x0007fd79 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd39 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fd3d) => 0x0007fd39 :<1>
<1>: Closure(_entry=0x00006a40, PARAMETERS_COUNT=4, PARAMETERS_LENGTH=16, sizeof=8) => 0x0007fd45 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd25 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=573060]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd25) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd29) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd2d) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fd31) :<1>
<1>: Critical_Section(_entry=0x00006a40) => 0x0007fd39 :<1>
<1>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x0007fd65 item=0x0007fd3d, size=2, last=0x0007fd65) :<1>
<1>: Future::get_value(this=0x0007fd79 _is_resolved=0 _condition=0) :<1>
<1>: Condition::wait(this=0x0007fd7d) :<1>
<1>: Thread::lock(this=0x0008be84, level=0, owner=0) :<1>
<1>: Spin::acquire[SPIN=0x00400120,ID=0x0008be84]() => {owner=573060,level=1} :<1>
<1>: Thread::sleep(running=0x0008be84,q=0x0007fd7d, size=0) :<1>
<1>: Scheduler[chosen=0x0008be84]::suspend(0x0008be84) :<1>
<1>: Scheduling_List::remove(e=0x0008bea0) => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List::remove_head() :<1>
<1>: List[0x00400110]::head=0x00083e30 => {p=0x00000000,o=0x00083e14,n=0x00093f10} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00093f10,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00097f60} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00093f10,o=0x00097f44,n=0x00000000} :<1>
<1>: Ordered_List::insert(e=0x0008bea0) => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List::insert_first(e=0x0008bea0) => {p=0x00000000,o=0x0008be84,n=0x00083e30} :<1>
<1>: List[0x0007fd7d]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x0007fd7d]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x0007fd7d]::head=0x0008bea0 => {p=0x00000000,o=0x0008be84,n=0x00000000} :<1>
<1>: List[0x0007fd7d]::tail=0x0008bea0 => {p=0x00000000,o=0x0008be84,n=0x00000000} :<1>
<1>: Thread::dispatch(locked=1) :<1>
<1>: Thread::dispatch(this=0x00083e14, level=1, owner=573060, in) :<1>
<1>: Thread::dispatch(prev=0x0008be84,next=0x00083e14) :<1>
<1>: prev={0x0008be84,ctx={eflags=0,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0008be40,eip=0x00000000,esp3=20,cs=0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: next={0x00083e14,ctx={eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00083dd0,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: Spin::release[SPIN=0x00400120,ID=573060]() => {owner=0,level=0} :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fd11 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: StringStream(_buffer_size=101) => 0x0007fd11 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=102Grouping_List::search_decrementing(s=106) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fca7 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: StringStream::print(this=0x0007fd11), string=thinking[, string_size=9, total_size=9, _last_position=9, _buffer=thinking[ :<1>
<1>: StringStream::print(this=0x0007fd11), string=1, string_size=1, total_size=10, _last_position=10, _buffer=thinking[1 :<1>
<1>: StringStream::print(this=0x0007fd11), string=], string_size=1, total_size=11, _last_position=11, _buffer=thinking[1] :<1>
<1>: StringStream::print(this=0x0007fd11), string= (, string_size=2, total_size=13, _last_position=13, _buffer=thinking[1] ( :<1>
<1>: StringStream::print(this=0x0007fd11), string=4, string_size=1, total_size=14, _last_position=14, _buffer=thinking[1] (4 :<1>
<1>: StringStream::print(this=0x0007fd11), string=), string_size=1, total_size=15, _last_position=15, _buffer=thinking[1] (4) :<1>
<1>: StringStream::print(this=0x0007fd11), string=
, string_size=1, total_size=16, _last_position=16, _buffer=thinking[1] (4)
 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fc8f :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fc93) => 0x0007fc8f :<1>
<1>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fc9b :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<1>
<1>: ) => 0x0007fc7f :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fc7f) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fc83) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fc87) :<1>
<1>: Critical_Section(_entry=0x00006030) => 0x0007fc8f :<1>
<1>: Guard::vouch(this=0x00400050 head=0x00000000 tail=0x0007fd3d item=0x0007fc93, size=3, last=0x0007fd3d) :<1>
, last=0x00000000)
<0>: Closure::_unpack_and_run(this=0x0007fd6d) :<0>
<0>: Closure::unpack_helper(Head=4, address=0x0007fd59(0x0007fd51), position=8) :<0>
<0>: Closure::unpack_helper(Head=4, address=0x0007fd55(0x0007fd51), position=4) :<0>
<0>: Closure::unpack_helper(Head=4, address=0x0007fd51(0x0007fd51), position=0) :<0>
<0>: 9ý~StringStream(this=0x0007fd65, _buffer=0x0007fd3d, _buffer_size=523601), _last_position=24624) :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0007fd39,bytes=110280) :<0>
<0>: Grouping_List::insert_merging(e=0x0007fd39) :<0>
<0>: List::insert_tail(e=0x0007fd39) => {p=0x00000000,o=0x0007fd39,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x00093f24 => {p=0x00401000,o=0x00093f24,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd39 => {p=0x00093f24,o=0x0007fd39,n=0x00000000} :<0>
<0>: Heap::free(this=0x004000b4,ptr=0x0007fd61,bytes=110344) :<0>
<0>: Grouping_List::insert_merging(e=0x0007fd61) :<0>
<0>: List::insert_tail(e=0x0007fd61) => {p=0x00000000,o=0x0007fd61,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd39 => {p=0x00093f24,o=0x0007fd39,n=0x00000000} :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x0007fd39,o=0x0007fd61,n=0x00000000} :<0>
<0>: Guard::clear(this=0x00400050 head=0x0007fd65 tail=0x0007fc93, size=2, next=0x0007fd39) :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fc6b :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: StringStream(_buffer_size=102) => 0x0007fc6b :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=103Grouping_List::search_decrementing(s=107) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fc00 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: StringStream::print(this=0x0007fc6b), string=  hungry[, string_size=9, total_size=9, _last_position=9, _buffer=  hungry[ :<1>
<1>: StringStream::print(this=0x0007fc6b), string=1, string_size=1, total_size=10, _last_position=10, _buffer=  hungry[1 :<1>
<1>: StringStream::print(this=0x0007fc6b), string=], string_size=1, total_size=11, _last_position=11, _buffer=  hungry[1] :<1>
<1>: StringStream::print(this=0x0007fc6b), string= (, string_size=2, total_size=13, _last_position=13, _buffer=  hungry[1] ( :<1>
<1>: StringStream::print(this=0x0007fc6b), string=4, string_size=1, total_size=14, _last_position=14, _buffer=  hungry[1] (4 :<1>
<1>: StringStream::print(this=0x0007fc6b), string=), string_size=1, total_size=15, _last_position=15, _buffer=  hungry[1] (4) :<1>
<1>: StringStream::print(this=0x0007fc6b), string=
, string_size=1, total_size=16, _last_position=16, _buffer=  hungry[1] (4)
 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fbe8 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fbec) => 0x0007fbe8 :<1>
<1>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fbf4 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fbd8 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fbd8) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fbdc) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fbe0) :<1>
<1>: Critical_Section(_entry=0x00006030) => 0x0007fbe8 :<1>
<1>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007fc93 item=0x0007fbec, size=60, last=0x0007fc93) :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fbc0 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Condition() => 0x0007fbc4 :<1>
<1>: Future(_is_resolved=0, _condition=0) => 0x0007fbc0 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fba8 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fbac) => 0x0007fba8 :<1>
<1>: Closure(_entry=0x00006a40, PARAMETERS_COUNT=4, PARAMETERS_LENGTH=16, sizeof=8) => 0x0007fbb4 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fb94 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=540180]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fb94) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fb98) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fb9c) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007fba0) :<1>
<1>: Critical_Section(_entry=0x00006a40) => 0x0007fba8 :<1>
<1>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007fbec item=0x0007fbac, size=61, last=0x0007fbec) :<1>
<1>: Future::get_value(this=0x0007fbc0 _is_resolved=0 _condition=0) :<1>
<1>: Condition::wait(this=0x0007fbc4) :<1>
<1>: Thread::lock(this=0x00083e14, level=0, owner=0) :<1>
<1>: Spin::acquire[SPIN=0x00400120,ID=0x00083e14]() => {owner=540180,level=1} :<1>
<1>: Thread::sleep(running=0x00083e14,q=0x0007fbc4, size=0) :<1>
<1>: Scheduler[chosen=0x00083e14]::suspend(0x00083e14) :<1>
<1>: Scheduling_List::remove(e=0x00083e30) => {p=0x00000000,o=0x00083e14,n=0x00093f10} :<1>
<1>: List::remove_head() :<1>
<1>: List[0x00400110]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00097f60} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00093f10,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x00097f60 => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: Ordered_List::insert(e=0x00083e30) => {p=0x00000000,o=0x00083e14,n=0x00093f10} :<1>
<1>: List::insert_first(e=0x00083e30) => {p=0x00000000,o=0x00083e14,n=0x00093f10} :<1>
<1>: List[0x0007fbc4]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x0007fbc4]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x0007fbc4]::head=0x00083e30 => {p=0x00000000,o=0x00083e14,n=0x00000000} :<1>
<1>: List[0x0007fbc4]::tail=0x00083e30 => {p=0x00000000,o=0x00083e14,n=0x00000000} :<1>
<1>: Thread::dispatch(locked=1) :<1>
<1>: Thread::dispatch(this=0x00093ef4, level=1, owner=540180, in) :<1>
<1>: Thread::dispatch(prev=0x00083e14,next=0x00093ef4) :<1>
<1>: prev={0x00083e14,ctx={eflags=0,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00083dd0,eip=0x00000000,esp3=0,cs=0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: next={0x00093ef4,ctx={eflags=6,eax=0x8be40,ebx=0x93f00,ecx=0x3fd,edx=0x3f8,esi=0x171eb,edi=0,ebp=0x00093d18,esp=0x00093ca0,eip=0x000171eb,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: Spin::release[SPIN=0x00400120,ID=540180]() => {owner=0,level=0} :<1>
<1>: Thread::dispatch(this=0x00093ef4, level=0, owner=0, out) :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fb80 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: StringStream(_buffer_size=101) => 0x0007fb80 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=102Grouping_List::search_decrementing(s=106) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fb16 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: StringStream::print(this=0x0007fb80), string=thinking[, string_size=9, total_size=9, _last_position=9, _buffer=thinking[ :<1>
<1>: StringStream::print(this=0x0007fb80), string=1, string_size=1, total_size=10, _last_position=10, _buffer=thinking[1 :<1>
<1>: StringStream::print(this=0x0007fb80), string=], string_size=1, total_size=11, _last_position=11, _buffer=thinking[1] :<1>
<1>: StringStream::print(this=0x0007fb80), string= (, string_size=2, total_size=13, _last_position=13, _buffer=thinking[1] ( :<1>
<1>: StringStream::print(this=0x0007fb80), string=0, string_size=1, total_size=14, _last_position=14, _buffer=thinking[1] (0 :<1>
<1>: StringStream::print(this=0x0007fb80), string=), string_size=1, total_size=15, _last_position=15, _buffer=thinking[1] (0) :<1>
<1>: StringStream::print(this=0x0007fb80), string=
, string_size=1, total_size=16, _last_position=16, _buffer=thinking[1] (0)
 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fafe :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007fb02) => 0x0007fafe :<1>
<1>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fb0a :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007faee :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007faee) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007faf2) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007faf6) :<1>
<1>: Critical_Section(_entry=0x00006030) => 0x0007fafe :<1>
<1>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007fbac item=0x0007fb02, size=62, last=0x0007fbac) :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0008febc, level=1, owner=589500) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: IC::exc_pf[address=0xffffffff](cs=8,ip=0x8b210005,fl=0x286,err=) :<0>
<0>:  :<0>


The running thread will now be terminated!
<0>: Thread::lock(this=0x0008febc, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0008febc]() => {owner=589500,level=1} :<0>
<0>: Thread::exit(status=-1) [running=0x0008febc] :<0>
<0>: Scheduler[chosen=0x0008febc]::remove(0x0008febc) :<0>
<0>: Scheduling_List::remove(e=0x0008fed8) => {p=0x00000000,o=0x0008febc,n=0x00087e68} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400100]::head=0x00087e68 => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: Scheduler[chosen=0x00087e4c]::choose() => Scheduling_List::choose() :<0>
<0>: Ordered_List::insert(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List::insert_head(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x00087e68 => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400100]::head=0x00087e68 => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00087e68,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: 0x00087e4c :<0>
<0>: Thread::dispatch(locked=1) :<0>
<0>: Thread::dispatch(this=0x00087e4c, level=1, owner=589500, in) :<0>
<0>: Thread::dispatch(prev=0x0008febc,next=0x00087e4c) :<0>
<0>: prev={0x0008febc,ctx={eflags=0,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0008fe78,eip=0x00000000,esp3=0,cs=0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<0>
<0>: next={0x00087e4c,ctx={eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00087e08,eip=0x00006f90,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<0>
<0>: Spin::release[SPIN=0x00400120,ID=589500]() => {owner=0,level=0} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007fada :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: StringStream(_buffer_size=101) => 0x0007fada :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=102Grouping_List::search_decrementing(s=106) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007fa70 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: StringStream::print(this=0x0007fada), string=thinking[, string_size=9, total_size=9, _last_position=9, _buffer=thinking[ :<0>
<0>: StringStream::print(this=0x0007fada), string=0, string_size=1, total_size=10, _last_position=10, _buffer=thinking[0 :<0>
<0>: StringStream::print(this=0x0007fada), string=], string_size=1, total_size=11, _last_position=11, _buffer=thinking[0] :<0>
<0>: StringStream::print(this=0x0007fada), string= (, string_size=2, total_size=13, _last_position=13, _buffer=thinking[0] ( :<0>
<0>: StringStream::print(this=0x0007fada), string=3, string_size=1, total_size=14, _last_position=14, _buffer=thinking[0] (3 :<0>
<0>: StringStream::print(this=0x0007fada), string=), string_size=1, total_size=15, _last_position=15, _buffer=thinking[0] (3) :<0>
<0>: StringStream::print(this=0x0007fada), string=
, string_size=1, total_size=16, _last_position=16, _buffer=thinking[0] (3)
 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007fa58 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Critical_Section_Base(_link=0x0007Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x00087e4c, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x00087e4c, level=1, owner=556620) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=556620]() => {owner=0,level=0} :<0>
fa5c) => 0x0007fa58
<0>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007fa64 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007fa48 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fa48) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fa4c) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007fa50) :<0>
<0>: Critical_Section(_entry=0x00006030) => 0x0007fa58 :<0>
<0>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007fb02 item=0x0007fa5c, size=254, last=0x0007fb02) :<0>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007fa34 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: StringStream(_buffer_size=102) => 0x0007fa34 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=103Grouping_List::search_decrementing(s=107) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007f9c9 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: StringStream::print(this=0x0007fa34), string=  hungry[, string_size=9, total_size=9, _last_position=9, _buffer=  hungry[ :<1>
<1>: StringStream::print(this=0x0007fa34), string=1, string_size=1, total_size=10, _last_position=10, _buffer=  hungry[1 :<1>
<1>: StringStream::print(this=0x0007fa34), string=], string_size=1, total_size=11, _last_position=11, _buffer=  hungry[1] :<1>
<1>: StringStream::print(this=0x0007fa34), string= (, string_size=2, total_size=13, _last_position=13, _buffer=  hungry[1] ( :<1>
<1>: StringStream::print(this=0x0007fa34), string=0, string_size=1, total_size=14, _last_position=14, _buffer=  hungry[1] (0 :<1>
<1>: StringStream::print(this=0x0007fa34), string=), string_size=1, total_size=15, _last_position=15, _buffer=  hungry[1] (0) :<1>
<1>: StringStream::print(this=0x0007fa34), string=
, string_size=1, total_size=16, _last_position=16, _buffer=  hungry[1] (0)
 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007f9b1 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007f9b5) => 0x0007f9b1 :<1>
<1>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007f9bd :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007f9a1 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f9a1) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f9a5) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f9a9) :<1>
<1>: Critical_Section(_entry=0x00006030) => 0x0007f9b1 :<1>
<1>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007fa5c item=0x0007f9b5, size=255, last=0x0007fa5c) :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007f989 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Condition() => 0x0007f98d :<1>
<1>: Future(_is_resolved=0, _condition=0) => 0x0007f989 :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007f971 :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Critical_Section_Base(_link=0x0007f975) => 0x0007f971 :<1>
<1>: Closure(_entry=0x00006a40, PARAMETERS_COUNT=4, PARAMETERS_LENGTH=16, sizeof=8) => 0x0007f97d :<1>
<1>: Spin::acquire[SPIN=0x004000c8,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<1>
<1>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<1>
<1>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<1>
<1>: ) => 0x0007f95d :<1>
<1>: Spin::release[SPIN=0x004000c8,ID=605940]() => {owner=0,level=0} :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f95d) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f961) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f965) :<1>
<1>: Closure::pack_helper(Head=4, address=0x0007f969) :<1>
<1>: Critical_Section(_entry=0x00006a40) => 0x0007f971 :<1>
<1>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007f9b5 item=0x0007f975, size=256, last=0x0007f9b5) :<1>
<1>: Future::get_value(this=0x0007f989 _is_resolved=0 _condition=0) :<1>
<1>: Condition::wait(this=0x0007f98d) :<1>
<1>: Thread::lock(this=0x00093ef4, level=0, owner=0) :<1>
<1>: Spin::acquire[SPIN=0x00400120,ID=0x00093ef4]() => {owner=605940,level=1} :<1>
<1>: Thread::sleep(running=0x00093ef4,q=0x0007f98d, size=0) :<1>
<1>: Scheduler[chosen=0x00093ef4]::suspend(0x00093ef4) :<1>
<1>: Scheduling_List::remove(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x00097f60} :<1>
<1>: List::remove_head() :<1>
<1>: List[0x00400110]::head=0x00097f60 => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List::remove_last() :<1>
<1>: List[0x00400110]::head=0x00097f60 => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::tail=0x00097f60 => {p=0x00000000,o=0x00097f44,n=0x00000000} :<1>
<1>: List[0x00400110]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x00400110]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: Ordered_List::insert(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x00097f60} :<1>
<1>: List::insert_first(e=0x00093f10) => {p=0x00000000,o=0x00093ef4,n=0x00097f60} :<1>
<1>: List[0x0007f98d]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x0007f98d]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<1>
<1>: List[0x0007f98d]::head=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<1>
<1>: List[0x0007f98d]::tail=0x00093f10 => {p=0x00000000,o=0x00093ef4,n=0x00000000} :<1>
<1>: Thread::dispatch(locked=1) :<1>
<1>: Thread::dispatch(this=0x00097f44, level=1, owner=605940, in) :<1>
<1>: Thread::dispatch(prev=0x00093ef4,next=0x00097f44) :<1>
<1>: prev={0x00093ef4,ctx={eflags=0x93d1c,eax=0x93ef4,ebx=0x93ca0,ecx=1a,edx=0x93ccc,esi=5,edi=0x97f44,ebp=0xffffffff,esp=0x00093ca0,eip=0x00097f44,esp3=0x93ef4,cs=0x93ca0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: next={0x00097f44,ctx={eflags=6,eax=0x93eb0,ebx=0x97f50,ecx=0x3fd,edx=0x3f8,esi=0x171eb,edi=0,ebp=0x00097ce8,esp=0x00097c70,eip=0x000171eb,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<1>
<1>: Spin::release[SPIN=0x00400120,ID=605940]() => {owner=0,level=0} :<1>
<1>: Thread::dispatch(this=0x00097f44, level=0, owner=0, out) :<1>
<1>: Thread::idle(CPU=1,this=0x00097f44) :<1>
<1>: Thread::idle(level=0, owner=0) :<1>
<1>: Thread::idle(CPU=1,this=0x00097f44) :<1>
<1>: Thread::idle(level=0, owner=0) :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x00087e4c, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x00087e4c, level=1, owner=556620) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=556620]() => {owner=0,level=0} :<0>
<1>: Thread::idle(CPU=1,this=0x00097f44) :<1>
<1>: Thread::idle(level=0, owner=0) :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x00087e4c, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x00087e4c, level=1, owner=556620) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=556620]() => {owner=0,level=0} :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f949 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: StringStream(_buffer_size=102) => 0x0007f949 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=103Grouping_List::search_decrementing(s=107) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f8de :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: StringStream::print(this=0x0007f949), string=  hungry[, string_size=9, total_size=9, _last_position=9, _buffer=  hungry[ :<0>
<0>: StringStream::print(this=0x0007f949), string=0, string_size=1, total_size=10, _last_position=10, _buffer=  hungry[0 :<0>
<0>: StringStream::print(this=0x0007f949), string=], string_size=1, total_size=11, _last_position=11, _buffer=  hungry[0] :<0>
<0>: StringStream::print(this=0x0007f949), string= (, string_size=2, total_size=13, _last_position=13, _buffer=  hungry[0] ( :<0>
<0>: StringStream::print(this=0x0007f949), string=3, string_size=1, total_size=14, _last_position=14, _buffer=  hungry[0] (3 :<0>
<0>: StringStream::print(this=0x0007f949), string=), string_size=1, total_size=15, _last_position=15, _buffer=  hungry[0] (3) :<0>
<0>: StringStream::print(this=0x0007f949), string=
, string_size=1, total_size=16, _last_position=16, _buffer=  hungry[0] (3)
 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f8c6 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Critical_Section_Base(_link=0x0007f8ca) => 0x0007f8c6 :<0>
<0>: Closure(_entry=0x00006030, PARAMETERS_COUNT=3, PARAMETERS_LENGTH=12, sizeof=8) => 0x0007f8d2 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=12Grouping_List::search_decrementing(s=16) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f8b6 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f8b6) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f8ba) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f8be) :<0>
<0>: Critical_Section(_entry=0x00006030) => 0x0007f8c6 :<0>
<0>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007f975 item=0x0007f8ca, size=257, last=0x0007f975) :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f89e :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Condition() => 0x0007f8a2 :<0>
<0>: Future(_is_resolved=0, _condition=0) => 0x0007f89e :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=20Grouping_List::search_decrementing(s=24) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f886 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Critical_Section_Base(_link=0x0007f88a) => 0x0007f886 :<0>
<0>: Closure(_entry=0x00006a40, PARAMETERS_COUNT=4, PARAMETERS_LENGTH=16, sizeof=8) => 0x0007f892 :<0>
<0>: Spin::acquire[SPIN=0x004000c8,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Heap::alloc(this=0x004000b4,bytes=16Grouping_List::search_decrementing(s=20) :<0>
<0>: List[0x004000b4]::head=0x0001d000 => {p=0x00000000,o=0x0001d000,n=0x00100000} :<0>
<0>: List[0x004000b4]::tail=0x0007fd61 => {p=0x00000001,o=0x0007fd61,n=0x00000000} :<0>
<0>: ) => 0x0007f872 :<0>
<0>: Spin::release[SPIN=0x004000c8,ID=556620]() => {owner=0,level=0} :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f872) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f876) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f87a) :<0>
<0>: Closure::pack_helper(Head=4, address=0x0007f87e) :<0>
<0>: Critical_Section(_entry=0x00006a40) => 0x0007f886 :<0>
<0>: Guard::vouch(this=0x00400050 head=0x0007fd39 tail=0x0007f8ca item=0x0007f88a, size=258, last=0x0007f8ca) :<0>
<0>: Future::get_value(this=0x0007f89e _is_resolved=0 _condition=0) :<0>
<0>: Condition::wait(this=0x0007f8a2) :<0>
<0>: Thread::lock(this=0x00087e4c, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x00087e4c]() => {owner=556620,level=1} :<0>
<0>: Thread::sleep(running=0x00087e4c,q=0x0007f8a2, size=0) :<0>
<0>: Scheduler[chosen=0x00087e4c]::suspend(0x00087e4c) :<0>
<0>: Scheduling_List::remove(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List::remove_head() :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List::remove_last() :<0>
<0>: List[0x00400100]::head=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::tail=0x0009bf98 => {p=0x00000000,o=0x0009bf7c,n=0x00000000} :<0>
<0>: List[0x00400100]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x00400100]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: Ordered_List::insert(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List::insert_first(e=0x00087e68) => {p=0x00000000,o=0x00087e4c,n=0x0009bf98} :<0>
<0>: List[0x0007f8a2]::head=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x0007f8a2]::tail=0x00000000 => {p=0xffffffff,o=0xffffffff,n=0xffffffff} :<0>
<0>: List[0x0007f8a2]::head=0x00087e68 => {p=0x00000000,o=0x00087e4c,n=0x00000000} :<0>
<0>: List[0x0007f8a2]::tail=0x00087e68 => {p=0x00000000,o=0x00087e4c,n=0x00000000} :<0>
<0>: Thread::dispatch(locked=1) :<0>
<0>: Thread::dispatch(this=0x0009bf7c, level=1, owner=556620, in) :<0>
<0>: Thread::dispatch(prev=0x00087e4c,next=0x0009bf7c) :<0>
<0>: prev={0x00087e4c,ctx={eflags=0,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x00087e08,eip=0x00000000,esp3=0,cs=0,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<0>
<0>: next={0x0009bf7c,ctx={eflags=0x200,eax=0,ebx=0,ecx=0,edx=0,esi=0,edi=0,ebp=0x00000000,esp=0x0009bf44,eip=0x00017990,esp3=0,cs=8,ccs=8,cds=10,ces=10,cfs=10,cgs=10,css=10,cr3=0x0fffc000}} :<0>
<0>: Spin::release[SPIN=0x00400120,ID=556620]() => {owner=0,level=0} :<0>
<0>: Thread::idle(CPU=0,this=0x0009bf7c) :<0>
<0>: Thread::idle(level=0, owner=0) :<0>
<1>: Thread::idle(CPU=1,this=0x00097f44) :<1>
<1>: Thread::idle(level=0, owner=0) :<1>
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0009bf7c, level=0, owner=0) :<0>
...
<0>: Alarm::lock(size=0) :<0>
<0>: Thread::lock(this=0x0009bf7c, level=0, owner=0) :<0>
<0>: Spin::acquire[SPIN=0x00400120,ID=0x0009bf7c]() => {owner=638844,level=1} :<0>
<0>: Alarm::unlock(size=0) :<0>
<0>: Thread::unlock(this=0x0009bf7c, level=1, owner=638844) :<0>
<0>: Spin::release[SPIN=0x00400120,ID=638844]() => {owner=0,level=0} :<0>
<0>: Thread::idle(CPU=0,this=0x0009bf7c) :<0>
<0>: Thread::idle(level=0, owner=0) :<0>
Travou completamente neste ponto por vários minutos, então matei o qemu.
qemu-system-i386: terminating on signal 15 from pid 59909 (htop)
make[2]: Leaving directory '/home/linux/OperatingSystems/Epos2x86/img'
make[1]: Leaving directory '/home/linux/OperatingSystems/Epos2x86'
Took '45.78' seconds to run the script 'compile_and_run.sh'.
Could not calculate the seconds to run './compile_remotely.sh' script this time.