This is the output from the sim target from April 28, 2007
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^

os_start: Entry
mm_addregion: Region 1: base=805d240 size=4194304
malloc: Allocated 805e560
malloc: Allocated 805e7f0
malloc: Allocated 805ec00
malloc: Allocated 805f010
os_start: Starting init thread
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f6a0
malloc: Allocated 805f930
malloc: Allocated 805fd40
malloc: Allocated 8060150
malloc: Allocated 8060560
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
stdio_test: write fd=1
stdio_test: write fd=2
malloc: Allocated 8061570
malloc: Allocated 8061660
malloc: Allocated 80617f0
malloc: Allocated 8061a80
malloc: Allocated 8061e90
malloc: Allocated 80622a0
malloc: Allocated 80626b0
malloc: Allocated 80646c0
malloc: Allocated 80646d0
malloc: Allocated 80646e0
malloc: Allocated 80646f0
up_unblock_task: Unblocking TCB=8061570
stdio_test: Standard I/O Check: printf
user_start: Started user_main at PID=2
stdio_test: Standard I/O Check: fprintf to stderr
_exit: TCB=805f420 exitting
free: Freeing 8060560
free: Freeing 805f510
free: Freeing 805f930
free: Freeing 805fd40
free: Freeing 8060150
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 805f6a0
free: Freeing 805f420
_exit: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
os_start: Beginning Idle Loop
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_mutex_init: mutex=0x845d6f0 attr=0x0
pthread_mutex_init: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f530
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d6f0
pthread_mutex_lock: Returning 0
up_reprioritize_rtr: TCB=805f420 PRI=100
up_reprioritize_rtr: New Active Task TCB=8061570
malloc: Allocated 8064700
malloc: Allocated 8061540
malloc: Allocated 80647f0
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_reprioritize_rtr: TCB=805f420 PRI=100
up_reprioritize_rtr: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
up_reprioritize_rtr: TCB=805f420 PRI=100
up_reprioritize_rtr: New Active Task TCB=8061570
pthread_join: thread=3
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=805f420
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6f0
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805f420
pthread_mutex_lock: Returning 0
pthread_mutex_unlock: mutex=0x845d6f0
up_unblock_task: Unblocking TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_exit: exit_value=0
pthread_completejoin: process_id=3 exit_value=0
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: Returning 0
up_reprioritize_rtr: TCB=8064700 PRI=100
up_reprioritize_rtr: New Active Task TCB=8061570
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_reprioritize_rtr: TCB=8064700 PRI=100
up_reprioritize_rtr: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 805f530
free: Freeing 805f420
_exit: New Active Task TCB=8064700
up_reprioritize_rtr: TCB=8064700 PRI=100
up_reprioritize_rtr: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
pthread_join: thread=4
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: mutex=0x845d6f0
pthread_mutex_unlock: Returning 0
pthread_exit: exit_value=0
pthread_completejoin: process_id=4 exit_value=0
pthread_notifywaiters: pjoin=0x8061540
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=8061570
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=8064700 exitting
free: Freeing 80647f0
free: Freeing 8064700
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x8061540
free: Freeing 8061540
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570

user_main: Begin argument test
user_main: Started with argc=5
user_main: argv[0]="ostest"
user_main: argv[1]="Arg1"
user_main: argv[2]="Arg2"
user_main: argv[3]="Arg3"
user_main: argv[4]="Arg4"

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: /dev/null test
dev_null: Read 0 bytes from /dev/null
dev_null: Wrote 1024 bytes to /dev/null

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: mutex test
Initializing mutex
Starting thread 1
Starting thread 2
		Thread1	Thread2
	Loops	32	32
	Errors	0	0

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     53pthread_mutex_init: mutex=0x845d6a0 attr=0x0
pthread_mutex_init: Returning 0
pthread_cond_init: cond=0x845d6a8 attr=0x0
pthread_cond_init: Returning 0
pthread_attr_init: attr=0x80645ec
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x80645ec stacksize=16384
pthread_attr_setstacksize: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d6a0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6a8 mutex=0x845d6a0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_completejoin: process_id=5 exit_value=ffffffff
pthread_notifywaiters: pjoin=0x805f510
free: Freeing 8064700
free: Freeing 805f420
pthread_join: thread=5
pthread_join: Thread has terminated
pthread_join: exit_value=0xffffffff
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
pthread_cond_destroy: cond=0x845d6a8
pthread_cond_destroy: Returning 0
pthread_cond_destroy: cond=0x845d6a8
pthread_cond_destroy: Returning 0
pthread_mutex_init: mutex=0x845d6a0 attr=0x0
pthread_mutex_init: Returning 0
pthread_cond_init: cond=0x845d6a8 attr=0x0
pthread_cond_init: Returning 0
pthread_attr_init: attr=0x80645cc
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x80645cc stacksize=16384
pthread_attr_setstacksize: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d6a0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6a8 mutex=0x845d6a0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_detach: Thread=6
pthread_detach: Returning 0
pthread_completejoin: process_id=6 exit_value=ffffffff
pthread_notifywaiters: pjoin=0x805f510
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
free: Freeing 8064700
free: Freeing 805f420
pthread_join: thread=6
pthread_join: Could not find thread data
pthread_join: Returning 3
70     5370
fordblks   3fac90   3fac90

user_main: cancel test
cancel_test: Test 1: Normal Cancelation
cancel_test: Starting thread
start_thread: Initializing mutex
start_thread: Initializing cond
start_thread: Starting thread
thread_waiter: Taking mutex
thread_waiter: Starting wait for condition
start_thread: Yielding
cancel_test: Canceling thread
cancel_test: Joining
cancel_test: waiter exited with result=ffffffff
cancel_test: PASS thread terminated with PTHREAD_CANCELED
cancel_test: Test 2: Cancelation of detached thread
cancel_test: Re-starting thread
restart_thread: Destroying cond
restart_thread: Destroying mutex
restart_thread: Re-starting thread
start_thread: Initializing mutex
start_thread: Initializing cond
start_thread: Starting thread
thread_waiter: Taking mutex
thread_waiter: Starting wait for condition
start_thread: Yielding
cancel_test: Canceling thread
cancel_test: Joining
cancel_test: PASS pthread_join failed with status=ESRCH
cancel_test: Test 3: Non-cancelable threads
cancel_test: Re-startipthread_cond_destroy: cond=0x845d6a8
pthread_cond_destroy: Returning 0
pthread_cond_destroy: cond=0x845d6a8
pthread_cond_destroy: Returning 0
pthread_mutex_init: mutex=0x845d6a0 attr=0x0
pthread_mutex_init: Returning 0
pthread_cond_init: cond=0x845d6a8 attr=0x0
pthread_cond_init: Returning 0
pthread_attr_init: attr=0x80645cc
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x80645cc stacksize=16384
pthread_attr_setstacksize: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d6a0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6a8 mutex=0x845d6a0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_mutex_lock: mutex=0x845d6a0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6a8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6a0
pthread_mutex_unlock: Returning 0
pthread_join: thread=7
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6a0
pthread_mutex_unlock: Returning 0
pthread_exit: exit_value=ffffffff
pthread_completejoin: process_id=7 exit_value=ffffffff
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0xffffffff
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 8064700
free: Freeing 805f420
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645f0
pthread_attr_init: Returning 0
pthread_attr_setschedparam: attr=0x80645f0 param=0x80645f8
pthread_attr_setschedparam: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f530
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
ng thread (non-cancelable)
restart_thread: Destroying cond
restart_thread: Destroying mutex
restart_thread: Re-starting thread
start_thread: Initializing mutex
start_thread: Initializing cond
start_thread: Starting thread
thread_waiter: Taking mutex
thread_waiter: Starting wait for condition
thread_waiter: Setting non-cancelable
start_thread: Yielding
cancel_test: Canceling thread
cancel_test: Joining
thread_waiter: Releasing mutex
thread_waiter: Setting cancelable
cancel_test: waiter exited with result=ffffffff
cancel_test: PASS thread terminated with PTHREAD_CANCELED

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: semaphore test
sem_test: Initializing semaphore to 0
sem_test: Starting waiter thread 1
sem_test: Set thread 1 priority to 191
waiter_func: Thread 1 Started
waiter_func: Thread 1 initial semaphore value = 0
waiter_func: Thup_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645f0
pthread_attr_init: Returning 0
pthread_attr_setschedparam: attr=0x80645f0 param=0x80645f8
pthread_attr_setschedparam: Returning 0
malloc: Allocated 8064700
malloc: Allocated 8061540
malloc: Allocated 80647f0
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645f0
pthread_attr_init: Returning 0
pthread_attr_setschedparam: attr=0x80645f0 param=0x80645f8
pthread_attr_setschedparam: Returning 0
malloc: Allocated 8066800
malloc: Allocated 80668f0
malloc: Allocated 8066910
up_unblock_task: Unblocking TCB=8066800
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_join: thread=8
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_exit: exit_value=0
pthread_completejoin: process_id=8 exit_value=0
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 805f530
free: Freeing 805f420
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
pthread_join: thread=9
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
up_unblock_task: Unblocking TCB=8064700
up_unblock_task: New Active Task TCB=8064700
pthread_exit: exit_value=0
pthread_completejoin: process_id=9 exit_value=0
pthread_notifywaiters: pjoin=0x8061540
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=8061570
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=8064700 exitting
free: Freeing 80647f0
free: Freeing 8064700
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x8061540
free: Freeing 8061540
pthread_join: Returning 0
pthread_join: thread=10
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
pthread_exit: exit_value=0
pthread_completejoin: process_id=10 exit_value=0
pthread_notifywaiters: pjoin=0x80668f0
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x80668f0
free: Freeing 80668f0
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
_exit: TCB=8066800 exitting
free: Freeing 8066910
free: Freeing 8066800
_exit: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
read 1 aiting on semaphore
sem_test: Starting waiter thread 2
sem_test: Set thread 2 priority to 128
waiter_func: Thread 2 Started
waiter_func: Thread 2 initial semaphore value = -1
waiter_func: Thread 2 aiting on semaphore
sem_test: Starting poster thread 3
sem_test: Set thread 3 priority to 64
poster_func: Thread 3 started
poster_func: Thread 3 semaphore value = -2
poster_func: Thread 3 posting semaphore
waiter_func: Thread 1 awakened
waiter_func: Thread 1 new semaphore value = -1
waiter_func: Thread 1 done
poster_func: Thread 3 new semaphore value = -1
poster_func: Thread 3 semaphore value = -1
poster_func: Thread 3 posting semaphore
waiter_func: Thread 2 awakened
waiter_func: Thread 2 new semaphore value = 0
waiter_func: Thread 2 done
poster_func: Thread 3 new semaphore value = 0
poster_func: Thread 3 done

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3facpthread_mutex_init: mutex=0x845d6d0 attr=0x0
pthread_mutex_init: Returning 0
pthread_cond_init: cond=0x845d6d8 attr=0x0
pthread_cond_init: Returning 0
pthread_attr_init: attr=0x80645f8
pthread_attr_init: Returning 0
pthread_attr_setschedparam: attr=0x80645f8 param=0x80645f4
pthread_attr_setschedparam: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f530
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645f8
pthread_attr_init: Returning 0
pthread_attr_setschedparam: attr=0x80645f8 param=0x80645f4
pthread_attr_setschedparam: Returning 0
malloc: Allocated 8064700
malloc: Allocated 8061540
malloc: Allocated 80647f0
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_join: thread=12
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_signal: cond=0x845d6d8
pthread_cond_signal: sval=-1
pthread_cond_signal: Signalling...
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_cond_wait: Reacquire mutex...
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_cond_signal: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8064700
up_release_pending: New Active Task TCB=805f420
pthread_cond_wait: Returning 0
pthread_mutex_unlock: mutex=0x845d6d0
pthread_mutex_unlock: Returning 0
pthread_mutex_lock: mutex=0x845d6d0
pthread_mutex_lock: Returning 0
pthread_cond_wait: cond=0x845d6d8 mutex=0x845d6d0
pthread_cond_wait: Give up mutex / take cond
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
pthread_mutex_unlock: Returning 0
pthread_exit: exit_value=0
pthread_completejoin: process_id=12 exit_value=0
pthread_notifywaiters: pjoin=0x8061540
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x8061540
free: Freeing 8061540
pthread_join: Returning 0
pthread_detach: Thread=11
pthread_detach: Returning 0
pthread_completejoin: process_id=11 exit_value=ffffffff
pthread_notifywaiters: pjoin=0x805f510
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
free: Freeing 805f530
free: Freeing 805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
_exit: TCB=8064700 exitting
free: Freeing 80647f0
free: Freeing 8064700
_exit: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_mutex_init: mutex=0x845d708 attr=0x0
pthread_mutex_init: Returning 0
pthread_cond_init: cond=0x845d710 attr=0x0
pthread_cond_init: Returning 0
pthread_attr_init: attr=0x8064604
pthread_attr_init: Returning 0
pthread_attr_setschedparam: attr=0x8064604 param=0x8064600
pthread_attr_setschedparam: Returning 0
90   3fac90

user_main: condition variable test
cond_test: Initializing mutex
cond_test: Initializing cond
cond_test: Starting waiter
cond_test: Set thread 1 priority to 128
waiter_thread: Started
cond_test: Starting signaler
cond_test: Set thread 2 priority to 64
thread_signaler: Started
thread_signaler: Terminating
cond_test: signaler terminated, now cancel the waiter
cond_test: 	Waiter	Signaler
cond_test: Loops	32	32
cond_test: Errors	0	0
cond_test: 
0 times, waiter did not have to wait for data
cond_test: 0 times, data was already available when the signaler run
cond_test: 0 times, the waiter was in an unexpected state when the signaler ran

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: timed wait test
thread_waiter: Initializing mutex
timedwait_test: Initializing cond
timedwait_test: Starting waiter
timedwait_test: Set thread 2 malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f530
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
pthread_mutex_lock: mutex=0x845d708
pthread_mutex_lock: Returning 0
clock_gettime: clock_id=0
clock_gettime: msecs = 70 g_tickbias=0
clock_gettime: secs = 70 + 1172534400 nsecs = 70000000 + 0
clock_gettime: Returning tp=(1172534400,70000000)
pthread_cond_timedwait: cond=0x845d710 mutex=0x845d708 abstime=0x80614fc
pthread_cond_timedwait: Give up mutex...
clock_gettime: clock_id=0
clock_gettime: msecs = 70 g_tickbias=0
clock_gettime: secs = 70 + 1172534400 nsecs = 70000000 + 0
clock_gettime: Returning tp=(1172534400,70000000)
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
priority to 177
thread_waiter: Taking mutex
thread_waiter: Starting 5 second wait for condition
timedwait_test: Joining
pthread_join: thread=13
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
sigqueue: TCB=0x0805f420 signo=3 value=0
sig_received: sig_received: TCB=0x0805f420 signo=3 code=1 value=0 mask=00000000
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805d140
up_release_pending: New Active Task TCB=805f420
up_release_pending: Delivering signals TCB=805f420
pthread_cond_timedwait: Timedout!
pthread_cond_timedwait: Re-locking...
pthread_cond_timedwait: Returning 110
pthread_mutex_unlock: mutex=0x845d708
pthread_mutex_unlock: Returning 0
pthread_exit: exit_value=12345678
pthread_completejoin: process_id=13 exit_value=12345678
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x12345678
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 805f530
free: Freeing 805f420
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645f4
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x80645f4 stacksize=16384
pthread_attr_setstacksize: Returning 0
pthread_attr_setschedparam: attr=0x80645f4 param=0x80645f0
pthread_attr_setschedparam: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
malloc: Allocated 805f530
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645f4
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x80645f4 stacksize=16384
pthread_attr_setstacksize: Returning 0
pthread_attr_setschedparam: attr=0x80645f4 param=0x80645f0
pthread_attr_setschedparam: Returning 0
malloc: Allocated 805f570
malloc: Allocated 805f660
malloc: Allocated 8068710
up_unblock_task: Unblocking TCB=805f570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_join: thread=15
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
thread_waiter: pthread_cond_timedwait timed out
thread_waiter: Releasing mutex
thread_waiter: Exit with status 0x12345678
timedwait_test: waiter exited with result=12345678

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: message queue test
mqueue_test: Starting receiver
mqueue_test: Set receiver priority to 128
receiver_thread: Starting
mqueue_test: Starting sender
mqueue_test: Set sender thread priority to 64
mqueue_test: Waiting for sender to complete
sender_thread: Starting
receiver_thread: mq_receive succeeded on msg 0
sender_thread: mq_send succeeded on msg 0
receiver_thread: mq_receive succeeded on msg 1
sender_thread: mq_send succeeded on msg 1
receiver_thread: mq_receive succeeded on msg 2
sender_thread: mq_send succeeded on msg 2
receiver_thread: mq_receive succeeded on msg 3
sender_thread: mq_send succeeded on msg 3
receiverup_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=805f570
up_release_pending: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805f570
pthread_exit: exit_value=0
pthread_completejoin: process_id=15 exit_value=0
pthread_notifywaiters: pjoin=0x805f660
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f570
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f660
free: Freeing 805f660
pthread_join: Returning 0
kill: TCB=0x0805f420 signo=9
sig_received: sig_received: TCB=0x0805f420 signo=9 code=0 value=0 mask=00000000
up_unblock_task: Unblocking TCB=805f420
up_release_pending: From TCB=8061570
up_release_pending: New Active Task TCB=805f420
up_release_pending: Delivering signals TCB=805f420
free: Freeing 805f530
pthread_exit: exit_value=0
pthread_completejoin: process_id=14 exit_value=0
pthread_notifywaiters: pjoin=0x805f510
_exit: TCB=805f420 exitting
free: Freeing 8064700
free: Freeing 805f420
_exit: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f570
_exit: TCB=805f570 exitting
free: Freeing 8068710
free: Freeing 805f570
_exit: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_join: thread=14
pthread_join: Thread has terminated
pthread_join: exit_value=0x0
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
_thread: mq_receive succeeded on msg 4
sender_thread: mq_send succeeded on msg 4
receiver_thread: mq_receive succeeded on msg 5
sender_thread: mq_send succeeded on msg 5
receiver_thread: mq_receive succeeded on msg 6
sender_thread: mq_send succeeded on msg 6
receiver_thread: mq_receive succeeded on msg 7
sender_thread: mq_send succeeded on msg 7
receiver_thread: mq_receive succeeded on msg 8
sender_thread: mq_send succeeded on msg 8
receiver_thread: mq_receive succeeded on msg 9
sender_thread: mq_send succeeded on msg 9
sender_thread: returning nerrors=0
mqueue_test: Killing receiver
receiver_thread: mq_receive interrupted!
receiver_thread: returning nerrors=0
mqueue_test: Canceling receiver
mqueue_test: receiver has already terminated

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: timed message queue test
timedmqueue_test: Starting pthread_attr_init: attr=0x8064600
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x8064600 stacksize=16384
pthread_attr_setstacksize: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
malloc: Allocated 805f530
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 5110 g_tickbias=0
clock_gettime: secs = 5110 + 1172534400 nsecs = 110000000 + 0
clock_gettime: Returning tp=(1172534405,110000000)
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: thread=16
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
sender
sender_thread: Starting
sender_thread: mq_timedsend succeeded on msg 0
sender_thread: mq_timedsend succeeded on msg 1
sender_thread: mq_timedsend succeeded on msg 2
sender_thread: mq_timedsend succeeded on msg 3
sender_thread: mq_timedsend succeeded on msg 4
sender_thread: mq_timedsend succeeded on msg 5
sender_thread: mq_timedsend succeeded on msg 6
sender_thread: mq_timedsend succeeded on msg 7
sender_thread: mq_timedsend succeeded on msg 8
timedmqueue_test: Waiting for sender to complete
sender_thread: mq_timedsend 9 timed out as expected
sender_thread: returning nerrors=0
pthread_exit: exit_value=0
pthread_completejoin: process_id=16 exit_value=0
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 8064700
free: Freeing 805f420
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
pthread_attr_init: attr=0x8064600
pthread_attr_init: Returning 0
pthread_attr_setstacksize: attr=0x8064600 stacksize=16384
pthread_attr_setstacksize: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
clock_gettime: clock_id=0
clock_gettime: msecs = 10120 g_tickbias=0
clock_gettime: secs = 10120 + 1172534400 nsecs = 120000000 + 0
clock_gettime: Returning tp=(1172534410,120000000)
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: thread=17
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
free: Freeing 805f530
timedmqueue_test: Starting receiver
receiver_thread: Starting
receiver_thread: mq_timedreceive succeeded on msg 0
receiver_thread: mq_timedreceive succeeded on msg 1
receiver_thread: mq_timedreceive succeeded on msg 2
receiver_thread: mq_timedreceive succeeded on msg 3
receiver_thread: mq_timedreceive succeeded on msg 4
receiver_thread: mq_timedreceive succeeded on msg 5
receiver_thread: mq_timedreceive succeeded on msg 6
receiver_thread: mq_timedreceive succeeded on msg 7
receiver_thread: mq_timedreceive succeeded on msg 8
timedmqueue_test: Waiting for sender to complete
receiver_thread: Receive 9 timed out as expected
receiver_thread: returning nerrors=0
pthread_exit: exit_value=0
pthread_completejoin: process_id=17 exit_value=0
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 8064700
free: Freeing 805f420
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f6a0
malloc: Allocated 805f930
malloc: Allocated 805fd40
malloc: Allocated 8060150
malloc: Allocated 8064700
up_unblock_task: Unblocking TCB=805f420
timedmqueue_test: Test complete

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: signal handler test
sighand_test: Initializing semaphore to 0
sighand_test: Starting waiter task
sighand_test: Started waiter_main pid=18
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
waiter_main: Waiter started
waiter_main: Unmasking signal 17
waiter_main: Registering signal handler
waiter_main: oact.sigaction=0 oact.sa_flags=0 oact.sa_mask=0
waiter_main: Waiting on semaphore
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
sigqueue: TCB=0x0805f420 signo=17 value=42
sig_received: sig_received: TCB=0x0805f420 signo=17 code=1 value=42 mask=00000000
up_unblock_task: Unblocking TCB=805f420
sighand_test: Signaling pid=18 with signo=17 sigvalue=42
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_block_task: Delivering signals TCB=805f420
sig_deliver: sig_deliver: Sending signal sigq=0x805d660
wakeup_action: Received signal 17
wakeup_action: sival_int=42
wakeup_action: si_code=1
wakeup_action: ucontext=0
waiter_main: sem_wait() successfully interrupted by signal
waiter_main: done
_exit: TCB=805f420 exitting
free: Freeing 8064700
free: Freeing 805f510
free: Freeing 805f930
free: Freeing 805fd40
free: Freeing 8060150
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 805f6a0
free: Freeing 805f420
_exit: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
sighand_test: done
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: POSIX timer test
timer_test: Initializing semaphore to 0
timer_test: Unmasking signal 17
timer_test: Registering signal handler
timer_test: oact.sigaction=0 oact.sa_flags=0 oact.sa_mask=0
timer_test: Creating timer
timer_test: Starting timer
timer_test: Waiting on semaphore
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
sig_received: sig_received: TCB=0x08061570 signo=17 code=2 value=42 mask=00000000
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_unblock_task: Delivering signals TCB=8061570
sig_deliver: sig_deliver: Sending signal sigq=0x805d678
timer_expiration: Received signal 17
timer_expiration: sival_int=42
timer_expiration: si_code=2 (SI_TIMER)
timer_expiration: ucontext=0
timer_test: sem_wait() successfully interrupted by signal
timer_test: g_nsigreceived=1
timer_test: Waiting on semaphore
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
sig_received: sig_received: TCB=0x08061570 signo=17 code=2 value=42 mask=00000000
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_unblock_task: Delivering signals TCB=8061570
sig_deliver: sig_deliver: Sending signal sigq=0x805d690
timer_expiration: Received signal 17
timer_expiration: sival_int=42
timer_expiration: si_code=2 (SI_TIMER)
timer_expiration: ucontext=0
timer_test: sem_wait() successfully interrupted by signal
timer_test: g_nsigreceived=2
timer_test: Waiting on semaphore
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
sig_received: sig_received: TCB=0x08061570 signo=17 code=2 value=42 mask=00000000
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_unblock_task: Delivering signals TCB=8061570
sig_deliver: sig_deliver: Sending signal sigq=0x805d6a8
timer_expiration: Received signal 17
timer_expiration: sival_int=42
timer_expiration: si_code=2 (SI_TIMER)
timer_expiration: ucontext=0
timer_test: sem_wait() successfully interrupted by signal
timer_test: g_nsigreceived=3
timer_test: Waiting on semaphore
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
sig_received: sig_received: TCB=0x08061570 signo=17 code=2 value=42 mask=00000000
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_unblock_task: Delivering signals TCB=8061570
sig_deliver: sig_deliver: Sending signal sigq=0x805d6c0
timer_expiration: Received signal 17
timer_expiration: sival_int=42
timer_expiration: si_code=2 (SI_TIMER)
timer_expiration: ucontext=0
timer_test: sem_wait() successfully interrupted by signal
timer_test: g_nsigreceived=4
timer_test: Waiting on semaphore
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
sig_received: sig_received: TCB=0x08061570 signo=17 code=2 value=42 mask=00000000
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_unblock_task: Delivering signals TCB=8061570
sig_deliver: sig_deliver: Sending signal sigq=0x805d6d8
timer_expiration: Received signal 17
timer_expiration: sival_int=42
timer_expiration: si_code=2 (SI_TIMER)
timer_expiration: ucontext=0
timer_test: sem_wait() successfully interrupted by signal
timer_test: g_nsigreceived=5
timer_test: Deleting timer
timer_test: done
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
pthread_attr_init: attr=0x80645e4
pthread_attr_init: Returning 0
malloc: Allocated 805f420
malloc: Allocated 805f510
malloc: Allocated 805f530
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
malloc: Allocated 8064700
malloc: Allocated 8061540
malloc: Allocated 80647f0
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=8061570
malloc: Allocated 8066800
malloc: Allocated 80668f0
malloc: Allocated 8066910
up_unblock_task: Unblocking TCB=8066800
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8066800
up_block_task: New Active Task TCB=8061570
malloc: Allocated 8068920
malloc: Allocated 8068a10
malloc: Allocated 8068a30
up_unblock_task: Unblocking TCB=8068920
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8068920
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8068920
up_block_task: New Active Task TCB=8061570
malloc: Allocated 806aa40
malloc: Allocated 806ab30
malloc: Allocated 806ab50
up_unblock_task: Unblocking TCB=806aa40
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=806aa40
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=806aa40
up_block_task: New Active Task TCB=8061570
malloc: Allocated 806cb60
malloc: Allocated 806cc50
malloc: Allocated 806cc70
up_unblock_task: Unblocking TCB=806cb60
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=806cb60
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=806cb60
up_block_task: New Active Task TCB=8061570
malloc: Allocated 806ec80
malloc: Allocated 806ed70
malloc: Allocated 806ed90
up_unblock_task: Unblocking TCB=806ec80
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=806ec80
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=806ec80
up_block_task: New Active Task TCB=8061570
malloc: Allocated 8070da0
malloc: Allocated 8070e90
malloc: Allocated 8070eb0
up_unblock_task: Unblocking TCB=8070da0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8070da0
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8070da0
up_block_task: New Active Task TCB=8061570
pthread_join: thread=19
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8064700
up_unblock_task: New Active Task TCB=8064700
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8066800
up_unblock_task: New Active Task TCB=8066800
up_block_task: Blocking TCB=8066800
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8068920
up_unblock_task: New Active Task TCB=8068920
up_block_task: Blocking TCB=8068920
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=806aa40
up_unblock_task: New Active Task TCB=806aa40

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

user_main: barrier test
barrier_test: Initializing barrier
barrier_func: Thread 0 started
barrier_test: Thread 0 created
barrier_func: Thread 1 started
barrier_test: Thread 1 created
barrier_func: Thread 2 started
barrier_test: Thread 2 created
barrier_func: Thread 3 started
barrier_test: Thread 3 created
barrier_func: Thread 4 started
barrier_test: Thread 4 created
barrier_func: Thread 5 started
barrier_test: Thread 5 created
barrier_func: Thread 6 started
barrier_test: Thread 6 created
barrier_func: Thread 7 started
barrier_test: Thread 7 created
barrier_func: Thread 0 calling pthread_barrier_wait()
barrier_func: Thread 1 calling pthread_barrier_wait()
barrier_func: Thread 2 calling pthread_barrier_wait()
barrier_func: Thread 3 calling pthread_barrier_wait()
barrier_func: Thread 4 calling pthreadup_block_task: Blocking TCB=806aa40
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=806cb60
up_unblock_task: New Active Task TCB=806cb60
up_block_task: Blocking TCB=806cb60
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=806ec80
up_unblock_task: New Active Task TCB=806ec80
up_block_task: Blocking TCB=806ec80
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8070da0
up_unblock_task: New Active Task TCB=8070da0
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: Unblocking TCB=8064700
up_unblock_task: Unblocking TCB=8066800
up_unblock_task: Unblocking TCB=8068920
up_unblock_task: Unblocking TCB=806aa40
up_unblock_task: Unblocking TCB=806cb60
up_unblock_task: Unblocking TCB=806ec80
up_block_task: Blocking TCB=8070da0
up_block_task: New Active Task TCB=805f420
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8064700
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=8066800
up_block_task: Blocking TCB=8066800
up_block_task: New Active Task TCB=8068920
up_block_task: Blocking TCB=8068920
up_block_task: New Active Task TCB=806aa40
up_block_task: Blocking TCB=806aa40
up_block_task: New Active Task TCB=806cb60
up_block_task: Blocking TCB=806cb60
up_block_task: New Active Task TCB=806ec80
up_block_task: Blocking TCB=806ec80
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8070da0
up_unblock_task: New Active Task TCB=8070da0
pthread_exit: exit_value=0
pthread_completejoin: process_id=26 exit_value=0
pthread_notifywaiters: pjoin=0x8070e90
_exit: TCB=8070da0 exitting
free: Freeing 8070eb0
free: Freeing 8070da0
_exit: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=805f420
up_unblock_task: New Active Task TCB=805f420
pthread_exit: exit_value=0
pthread_completejoin: process_id=19 exit_value=0
pthread_notifywaiters: pjoin=0x805f510
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=805f420
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=805f420
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805f420
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=805f420 exitting
free: Freeing 805f530
free: Freeing 805f420
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x805f510
free: Freeing 805f510
pthread_join: Returning 0
pthread_join: thread=20
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8064700
up_unblock_task: New Active Task TCB=8064700
pthread_exit: exit_value=0
pthread_completejoin: process_id=20 exit_value=0
pthread_notifywaiters: pjoin=0x8061540
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8064700
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=8064700
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8064700
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=8064700 exitting
free: Freeing 80647f0
free: Freeing 8064700
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x8061540
free: Freeing 8061540
pthread_join: Returning 0
pthread_join: thread=21
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8066800
up_unblock_task: New Active Task TCB=8066800
pthread_exit: exit_value=0
pthread_completejoin: process_id=21 exit_value=0
pthread_notifywaiters: pjoin=0x80668f0
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8066800
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=8066800
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8066800
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=8066800 exitting
free: Freeing 8066910
free: Freeing 8066800
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x80668f0
free: Freeing 80668f0
pthread_join: Returning 0
pthread_join: thread=22
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8068920
up_unblock_task: New Active Task TCB=8068920
pthread_exit: exit_value=0
pthread_completejoin: process_id=22 exit_value=0
pthread_notifywaiters: pjoin=0x8068a10
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=8068920
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=8068920
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=8068920
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=8068920 exitting
free: Freeing 8068a30
free: Freeing 8068920
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x8068a10
free: Freeing 8068a10
pthread_join: Returning 0
_barrier_wait()
barrier_func: Thread 5 calling pthread_barrier_wait()
barrier_func: Thread 6 calling pthread_barrier_wait()
barrier_func: Thread 7 calling pthread_barrier_wait()
barrier_func: Thread 7, back with status=PTHREAD_BARRIER_SERIAL_THREAD (I AM SPECIAL)
barrier_func: Thread 0, back with status=0 (I am not special)
barrier_func: Thread 1, back with status=0 (I am not special)
barrier_func: Thread 2, back with status=0 (I am not special)
barrier_func: Thread 3, back with status=0 (I am not special)
barrier_func: Thread 4, back with status=0 (I am not special)
barrier_func: Thread 5, back with status=0 (I am not special)
barrier_func: Thread 6, back with status=0 (I am not special)
barrier_func: Thread 7 done
barrier_func: Thread 0 done
barrier_test: Thread 0 completed with result=0
barrier_func: Thread 1 done
barrier_test: Thread 1 completed with result=0
barrier_func: Thread 2 done
barrier_test: Thread 2 completed with result=0
barrier_func: Thread 3 done
barrier_test: Thread 3 completed with result=pthread_join: thread=23
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=806aa40
up_unblock_task: New Active Task TCB=806aa40
pthread_exit: exit_value=0
pthread_completejoin: process_id=23 exit_value=0
pthread_notifywaiters: pjoin=0x806ab30
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=806aa40
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=806aa40
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=806aa40
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=806aa40 exitting
free: Freeing 806ab50
free: Freeing 806aa40
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x806ab30
free: Freeing 806ab30
pthread_join: Returning 0
pthread_join: thread=24
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=806cb60
up_unblock_task: New Active Task TCB=806cb60
pthread_exit: exit_value=0
pthread_completejoin: process_id=24 exit_value=0
pthread_notifywaiters: pjoin=0x806cc50
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=806cb60
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=806cb60
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=806cb60
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=806cb60 exitting
free: Freeing 806cc70
free: Freeing 806cb60
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x806cc50
free: Freeing 806cc50
pthread_join: Returning 0
pthread_join: thread=25
pthread_join: Thread is still running
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=806ec80
up_unblock_task: New Active Task TCB=806ec80
pthread_exit: exit_value=0
pthread_completejoin: process_id=25 exit_value=0
pthread_notifywaiters: pjoin=0x806ed70
up_unblock_task: Unblocking TCB=8061570
up_block_task: Blocking TCB=806ec80
up_block_task: New Active Task TCB=8061570
pthread_join: exit_value=0x0
up_unblock_task: Unblocking TCB=806ec80
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=806ec80
up_unblock_task: Unblocking TCB=8061570
_exit: TCB=806ec80 exitting
free: Freeing 806ed90
free: Freeing 806ec80
_exit: New Active Task TCB=8061570
pthread_destroyjoin: pjoin=0x806ed70
free: Freeing 806ed70
pthread_join: Returning 0
pthread_join: thread=26
pthread_join: Thread has terminated
pthread_join: exit_value=0x0
pthread_destroyjoin: pjoin=0x8070e90
free: Freeing 8070e90
pthread_join: Returning 0
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
up_block_task: Blocking TCB=8061570
up_block_task: New Active Task TCB=805d140
up_unblock_task: Unblocking TCB=8061570
up_unblock_task: New Active Task TCB=8061570
0
barrier_func: Thread 4 done
barrier_test: Thread 4 completed with result=0
barrier_func: Thread 5 done
barrier_test: Thread 5 completed with result=0
barrier_func: Thread 6 done
barrier_test: Thread 6 completed with result=0
barrier_test: Thread 7 completed with result=0

End of test memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90

Final memory usage:
VARIABLE  BEFORE   AFTER
======== ======== ========
arena      400000   400000
ordblks         2        2
mxordblk   3f8b40   3f8b40
uordblks     5370     5370
fordblks   3fac90   3fac90
user_main: Exitting
_exit: TCB=8061570 exitting
free: Freeing 80626b0
free: Freeing 80646c0
free: Freeing 80646d0
free: Freeing 80646e0
free: Freeing 80646f0
free: Freeing 8061660
free: Freeing 8061a80
free: Freeing 8061e90
free: Freeing 80622a0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 0
free: Freeing 80617f0
free: Freeing 8061570
_exit: New Active Task TCB=805d140
