Skip to content
Unstable

Console Output

Skipping 5,231 KB.. Full Log
 Got the lock again on the recursive mutex.
17:11:29 -Got the lock on the default mutex.
17:11:29 -Failed to relock the default mutex.
17:11:29 -Got the lock on the recursive mutex.
17:11:29 -Got the lock again on the recursive mutex.
17:11:29 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 17 unique states visited; 1 backtracks (3 transition replays, 20 states visited overall)
17:11:29 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 12 unique states visited; 0 backtracks (0 transition replays, 12 states visited overall)
17:11:29 Test suite `pthread-mc-mutex-recursive.tesh': NOK (<pthread-mc-mutex-recursive.tesh:4> output mismatch)
17:11:29 
17:11:29           Start  563: pthread-producer-consumer-boost
17:11:29  562/1072 Test  #562: pthread-mc-mutex-recursive-ucontext .........................***Failed    0.06 sec
17:11:29 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:29 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:29 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-mutex-recursive.tesh'
17:11:29 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:29 [pthread-mc-mutex-recursive.tesh:4]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-mutex-recursive --cfg=contexts/factory:ucontext
17:11:29 Output of <pthread-mc-mutex-recursive.tesh:4> mismatch:
17:11:29 --- expected
17:11:29 +++ obtained
17:11:29 @@ -3,8 +3,4 @@
17:11:29  Failed to relock the default mutex.
17:11:29  Got the lock on the recursive mutex.
17:11:29  Got the lock again on the recursive mutex.
17:11:29 -Got the lock on the default mutex.
17:11:29 -Failed to relock the default mutex.
17:11:29 -Got the lock on the recursive mutex.
17:11:29 -Got the lock again on the recursive mutex.
17:11:29 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 17 unique states visited; 1 backtracks (3 transition replays, 20 states visited overall)
17:11:29 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 12 unique states visited; 0 backtracks (0 transition replays, 12 states visited overall)
17:11:29 Test suite `pthread-mc-mutex-recursive.tesh': NOK (<pthread-mc-mutex-recursive.tesh:4> output mismatch)
17:11:29 
17:11:29           Start  564: pthread-producer-consumer-raw
17:11:29  563/1072 Test  #563: pthread-producer-consumer-boost .............................   Passed    0.07 sec
17:11:29           Start  565: pthread-producer-consumer-ucontext
17:11:29  564/1072 Test  #564: pthread-producer-consumer-raw ...............................   Passed    0.07 sec
17:11:29           Start  566: pthread-mc-producer-consumer-boost
17:11:29  565/1072 Test  #565: pthread-producer-consumer-ucontext ..........................   Passed    0.07 sec
17:11:29           Start  567: pthread-mc-producer-consumer-raw
17:11:30  566/1072 Test  #566: pthread-mc-producer-consumer-boost ..........................***Failed    0.49 sec
17:11:30 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:30 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:30 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-producer-consumer.tesh'
17:11:30 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:30 [pthread-mc-producer-consumer.tesh:4]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:boost
17:11:30 Output of <pthread-mc-producer-consumer.tesh:4> mismatch:
17:11:30 --- expected
17:11:30 +++ obtained
17:11:30 @@ -1,2 +1,2 @@
17:11:30  [0.000000] [mc_dfs/INFO] Start a DFS exploration. Reduction is: dpor.
17:11:30 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 735 unique states visited; 73 backtracks (1598 transition replays, 2333 states visited overall)
17:11:30 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 689 unique states visited; 53 backtracks (1112 transition replays, 1801 states visited overall)
17:11:30 Test suite `pthread-mc-producer-consumer.tesh': NOK (<pthread-mc-producer-consumer.tesh:4> output mismatch)
17:11:30 [pthread-mc-producer-consumer.tesh:8]  ./../../bin/simgrid-mc --cfg=model-check/reduction:sdpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:boost
17:11:30 
17:11:30 [pthread-mc-producer-consumer.tesh:13]  ./../../bin/simgrid-mc --cfg=model-check/reduction:odpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:boost
17:11:30 
17:11:30 
17:11:30           Start  568: pthread-mc-producer-consumer-ucontext
17:11:30  567/1072 Test  #567: pthread-mc-producer-consumer-raw ............................***Failed    0.48 sec
17:11:30 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:30 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:30 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-producer-consumer.tesh'
17:11:30 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:30 [pthread-mc-producer-consumer.tesh:4]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:raw
17:11:30 Output of <pthread-mc-producer-consumer.tesh:4> mismatch:
17:11:30 --- expected
17:11:30 +++ obtained
17:11:30 @@ -1,2 +1,2 @@
17:11:30  [0.000000] [mc_dfs/INFO] Start a DFS exploration. Reduction is: dpor.
17:11:30 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 735 unique states visited; 73 backtracks (1598 transition replays, 2333 states visited overall)
17:11:30 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 689 unique states visited; 53 backtracks (1112 transition replays, 1801 states visited overall)
17:11:30 Test suite `pthread-mc-producer-consumer.tesh': NOK (<pthread-mc-producer-consumer.tesh:4> output mismatch)
17:11:30 [pthread-mc-producer-consumer.tesh:8]  ./../../bin/simgrid-mc --cfg=model-check/reduction:sdpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:raw
17:11:30 
17:11:30 [pthread-mc-producer-consumer.tesh:13]  ./../../bin/simgrid-mc --cfg=model-check/reduction:odpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:raw
17:11:30 
17:11:30 
17:11:30           Start  569: pthread-mc-mutex-simpledeadlock-boost
17:11:30  568/1072 Test  #568: pthread-mc-producer-consumer-ucontext .......................***Failed    0.49 sec
17:11:30 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:30 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:30 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-producer-consumer.tesh'
17:11:30 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:30 [pthread-mc-producer-consumer.tesh:4]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:ucontext
17:11:30 Output of <pthread-mc-producer-consumer.tesh:4> mismatch:
17:11:30 --- expected
17:11:30 +++ obtained
17:11:30 @@ -1,2 +1,2 @@
17:11:30  [0.000000] [mc_dfs/INFO] Start a DFS exploration. Reduction is: dpor.
17:11:30 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 735 unique states visited; 73 backtracks (1598 transition replays, 2333 states visited overall)
17:11:30 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 689 unique states visited; 53 backtracks (1112 transition replays, 1801 states visited overall)
17:11:30 Test suite `pthread-mc-producer-consumer.tesh': NOK (<pthread-mc-producer-consumer.tesh:4> output mismatch)
17:11:30 [pthread-mc-producer-consumer.tesh:8]  ./../../bin/simgrid-mc --cfg=model-check/reduction:sdpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:ucontext
17:11:30 
17:11:30 [pthread-mc-producer-consumer.tesh:13]  ./../../bin/simgrid-mc --cfg=model-check/reduction:odpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-producer-consumer -q  -C 1 -P 1 --cfg=contexts/factory:ucontext
17:11:30 
17:11:30 
17:11:30           Start  570: pthread-mc-mutex-simpledeadlock-raw
17:11:31  569/1072 Test  #570: pthread-mc-mutex-simpledeadlock-raw .........................***Failed    0.60 sec
17:11:31 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:31 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:31 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-mutex-simpledeadlock.tesh'
17:11:31 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:31 [pthread-mc-mutex-simpledeadlock.tesh:7]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-mutex-simpledeadlock --cfg=contexts/factory:raw
17:11:31 Output of <pthread-mc-mutex-simpledeadlock.tesh:7> mismatch:
17:11:31 --- expected
17:11:31 +++ obtained
17:11:31 @@ -18,4 +18,4 @@
17:11:31  [0.000000] [mc_global/INFO]   Actor 3 in simcall MUTEX_WAIT(mutex: 1, owner: 3)
17:11:31  [0.000000] [mc_global/INFO]   Actor 3 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:31  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;3;2;3;3'
17:11:31 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 20 unique states visited; 2 backtracks (7 transition replays, 27 states visited overall)
17:11:31 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 19 unique states visited; 1 backtracks (2 transition replays, 21 states visited overall)
17:11:31 Test suite `pthread-mc-mutex-simpledeadlock.tesh': NOK (<pthread-mc-mutex-simpledeadlock.tesh:7> output mismatch)
17:11:31 [Tesh/INFO] setenv LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so
17:11:31 [pthread-mc-mutex-simpledeadlock.tesh:35]  ./pthread-mutex-simpledeadlock --cfg=model-check/replay:'2;2;3;2;3;3' --cfg=contexts/factory:raw
17:11:31 sthread is intercepting the execution of ./pthread-mutex-simpledeadlock. If it's not what you want, export STHREAD_IGNORE_BINARY=./pthread-mutex-simpledeadlock
17:11:31 [0.000000] [xbt_cfg/INFO] Configuration change: Set 'model-check/replay' to '2;2;3;2;3;3'
17:11:31 [0.000000] [xbt_cfg/INFO] Configuration change: Set 'contexts/factory' to 'raw'
17:11:31 [0.000000] [mc_record/INFO] path=2;2;3;2;3;3
17:11:31 All threads are started.
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #1 '2/0' Actor thread 1(pid:2): MUTEX_ASYNC_LOCK(mutex_id:0 owner:none)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 1):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:21
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #2 '2/0' Actor thread 1(pid:2): MUTEX_WAIT(mutex_id:0 owner:2)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 1):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:21
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #3 '3/0' Actor thread 2(pid:3): MUTEX_ASYNC_LOCK(mutex_id:1 owner:none)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 2):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:31
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #4 '2/0' Actor thread 1(pid:2): MUTEX_ASYNC_LOCK(mutex_id:1 owner:3)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 1):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:22
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #5 '3/0' Actor thread 2(pid:3): MUTEX_WAIT(mutex_id:1 owner:3)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 2):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:31
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #6 '3/0' Actor thread 2(pid:3): MUTEX_ASYNC_LOCK(mutex_id:0 owner:2)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 2):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:32
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] The replay of the trace is complete. DEADLOCK detected.
17:11:31 [0.000000] [ker_engine/INFO] 3 actors are still active, awaiting something. Here is their status:
17:11:31 [0.000000] [ker_engine/INFO]  - pid 1 (main thread@Lilibeth) simcall ActorJoin(pid:2)
17:11:31 [0.000000] [ker_engine/INFO]  - pid 2 (thread 1@Lilibeth) simcall MUTEX_WAIT(mutex_id:1 owner:3)
17:11:31 [0.000000] [ker_engine/INFO]  - pid 3 (thread 2@Lilibeth) simcall MUTEX_WAIT(mutex_id:0 owner:2)
17:11:31 [0.000000] [sthread/INFO] All threads exited. Terminating the simulation.
17:11:31 [0.000000] ../src/kernel/EngineImpl.cpp:271: [ker_engine/WARNING] Process called exit when leaving - Skipping cleanups
17:11:31 [0.000000] ../src/kernel/EngineImpl.cpp:271: [ker_engine/WARNING] Process called exit when leaving - Skipping cleanups
17:11:31 
17:11:31 (ignoring the output of <pthread-mc-mutex-simpledeadlock.tesh:35> as requested)
17:11:31 
17:11:31           Start  571: pthread-mc-mutex-simpledeadlock-ucontext
17:11:31  570/1072 Test  #569: pthread-mc-mutex-simpledeadlock-boost .......................***Failed    1.08 sec
17:11:31 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:31 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:31 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-mutex-simpledeadlock.tesh'
17:11:31 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:31 [pthread-mc-mutex-simpledeadlock.tesh:7]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-mutex-simpledeadlock --cfg=contexts/factory:boost
17:11:31 Output of <pthread-mc-mutex-simpledeadlock.tesh:7> mismatch:
17:11:31 --- expected
17:11:31 +++ obtained
17:11:31 @@ -18,4 +18,4 @@
17:11:31  [0.000000] [mc_global/INFO]   Actor 3 in simcall MUTEX_WAIT(mutex: 1, owner: 3)
17:11:31  [0.000000] [mc_global/INFO]   Actor 3 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:31  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;3;2;3;3'
17:11:31 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 20 unique states visited; 2 backtracks (7 transition replays, 27 states visited overall)
17:11:31 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 19 unique states visited; 1 backtracks (2 transition replays, 21 states visited overall)
17:11:31 Test suite `pthread-mc-mutex-simpledeadlock.tesh': NOK (<pthread-mc-mutex-simpledeadlock.tesh:7> output mismatch)
17:11:31 [Tesh/INFO] setenv LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so
17:11:31 [pthread-mc-mutex-simpledeadlock.tesh:35]  ./pthread-mutex-simpledeadlock --cfg=model-check/replay:'2;2;3;2;3;3' --cfg=contexts/factory:boost
17:11:31 sthread is intercepting the execution of ./pthread-mutex-simpledeadlock. If it's not what you want, export STHREAD_IGNORE_BINARY=./pthread-mutex-simpledeadlock
17:11:31 [0.000000] [xbt_cfg/INFO] Configuration change: Set 'model-check/replay' to '2;2;3;2;3;3'
17:11:31 [0.000000] [xbt_cfg/INFO] Configuration change: Set 'contexts/factory' to 'boost'
17:11:31 [0.000000] [mc_record/INFO] path=2;2;3;2;3;3
17:11:31 All threads are started.
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #1 '2/0' Actor thread 1(pid:2): MUTEX_ASYNC_LOCK(mutex_id:0 owner:none)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 1):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:21
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #7 make_fcontext at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #2 '2/0' Actor thread 1(pid:2): MUTEX_WAIT(mutex_id:0 owner:2)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 1):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:21
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #7 make_fcontext at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #3 '3/0' Actor thread 2(pid:3): MUTEX_ASYNC_LOCK(mutex_id:1 owner:none)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 2):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:31
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #7 make_fcontext at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #4 '2/0' Actor thread 1(pid:2): MUTEX_ASYNC_LOCK(mutex_id:1 owner:3)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 1):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:22
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #7 make_fcontext at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #5 '3/0' Actor thread 2(pid:3): MUTEX_WAIT(mutex_id:1 owner:3)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 2):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:31
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #7 make_fcontext at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 [0.000000] [mc_record/INFO] * Path chunk #6 '3/0' Actor thread 2(pid:3): MUTEX_ASYNC_LOCK(mutex_id:0 owner:2)
17:11:31 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:31 Backtrace (displayed in actor thread 2):
17:11:31   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:32
17:11:31   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31   ->  #7 make_fcontext at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:31 ??:0
17:11:31 
17:11:31 [0.000000] [mc_record/INFO] The replay of the trace is complete. DEADLOCK detected.
17:11:31 [0.000000] [ker_engine/INFO] 3 actors are still active, awaiting something. Here is their status:
17:11:31 [0.000000] [ker_engine/INFO]  - pid 1 (main thread@Lilibeth) simcall ActorJoin(pid:2)
17:11:31 [0.000000] [ker_engine/INFO]  - pid 2 (thread 1@Lilibeth) simcall MUTEX_WAIT(mutex_id:1 owner:3)
17:11:31 [0.000000] [ker_engine/INFO]  - pid 3 (thread 2@Lilibeth) simcall MUTEX_WAIT(mutex_id:0 owner:2)
17:11:31 [0.000000] [sthread/INFO] All threads exited. Terminating the simulation.
17:11:31 [0.000000] ../src/kernel/EngineImpl.cpp:271: [ker_engine/WARNING] Process called exit when leaving - Skipping cleanups
17:11:31 [0.000000] ../src/kernel/EngineImpl.cpp:271: [ker_engine/WARNING] Process called exit when leaving - Skipping cleanups
17:11:31 
17:11:31 (ignoring the output of <pthread-mc-mutex-simpledeadlock.tesh:35> as requested)
17:11:31 
17:11:31           Start  572: sthread-mc-stdobject-boost
17:11:31  571/1072 Test  #572: sthread-mc-stdobject-boost ..................................   Passed    0.08 sec
17:11:31           Start  573: sthread-mc-stdobject-raw
17:11:31  572/1072 Test  #573: sthread-mc-stdobject-raw ....................................   Passed    0.06 sec
17:11:31           Start  574: sthread-mc-stdobject-ucontext
17:11:31  573/1072 Test  #574: sthread-mc-stdobject-ucontext ...............................   Passed    0.06 sec
17:11:31           Start  575: sthread-mutex-simple-boost
17:11:31  574/1072 Test  #575: sthread-mutex-simple-boost ..................................   Passed    0.06 sec
17:11:31           Start  576: sthread-mutex-simple-raw
17:11:31  575/1072 Test  #576: sthread-mutex-simple-raw ....................................   Passed    0.05 sec
17:11:31           Start  577: sthread-mutex-simple-ucontext
17:11:31  576/1072 Test  #577: sthread-mutex-simple-ucontext ...............................   Passed    0.05 sec
17:11:31           Start  578: stack-overflow-boost
17:11:32  577/1072 Test  #578: stack-overflow-boost ........................................   Passed    0.50 sec
17:11:32           Start  579: stack-overflow-raw
17:11:32  578/1072 Test  #571: pthread-mc-mutex-simpledeadlock-ucontext ....................***Failed    0.94 sec
17:11:32 [Tesh/INFO] change directory to /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/examples/sthread
17:11:32 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:32 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/examples/sthread/pthread-mc-mutex-simpledeadlock.tesh'
17:11:32 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:32 [pthread-mc-mutex-simpledeadlock.tesh:7]  ./../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so ./pthread-mutex-simpledeadlock --cfg=contexts/factory:ucontext
17:11:32 Output of <pthread-mc-mutex-simpledeadlock.tesh:7> mismatch:
17:11:32 --- expected
17:11:32 +++ obtained
17:11:32 @@ -18,4 +18,4 @@
17:11:32  [0.000000] [mc_global/INFO]   Actor 3 in simcall MUTEX_WAIT(mutex: 1, owner: 3)
17:11:32  [0.000000] [mc_global/INFO]   Actor 3 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:32  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;3;2;3;3'
17:11:32 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 20 unique states visited; 2 backtracks (7 transition replays, 27 states visited overall)
17:11:32 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 19 unique states visited; 1 backtracks (2 transition replays, 21 states visited overall)
17:11:32 Test suite `pthread-mc-mutex-simpledeadlock.tesh': NOK (<pthread-mc-mutex-simpledeadlock.tesh:7> output mismatch)
17:11:32 [Tesh/INFO] setenv LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so
17:11:32 [pthread-mc-mutex-simpledeadlock.tesh:35]  ./pthread-mutex-simpledeadlock --cfg=model-check/replay:'2;2;3;2;3;3' --cfg=contexts/factory:ucontext
17:11:32 sthread is intercepting the execution of ./pthread-mutex-simpledeadlock. If it's not what you want, export STHREAD_IGNORE_BINARY=./pthread-mutex-simpledeadlock
17:11:32 [0.000000] [xbt_cfg/INFO] Configuration change: Set 'model-check/replay' to '2;2;3;2;3;3'
17:11:32 [0.000000] [xbt_cfg/INFO] Configuration change: Set 'contexts/factory' to 'ucontext'
17:11:32 [0.000000] [mc_record/INFO] path=2;2;3;2;3;3
17:11:32 All threads are started.
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 [0.000000] [mc_record/INFO] * Path chunk #1 '2/0' Actor thread 1(pid:2): MUTEX_ASYNC_LOCK(mutex_id:0 owner:none)
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 Backtrace (displayed in actor thread 1):
17:11:32   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:21
17:11:32   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #7 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32 
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 [0.000000] [mc_record/INFO] * Path chunk #2 '2/0' Actor thread 1(pid:2): MUTEX_WAIT(mutex_id:0 owner:2)
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 Backtrace (displayed in actor thread 1):
17:11:32   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:21
17:11:32   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #7 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32 
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 [0.000000] [mc_record/INFO] * Path chunk #3 '3/0' Actor thread 2(pid:3): MUTEX_ASYNC_LOCK(mutex_id:1 owner:none)
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 Backtrace (displayed in actor thread 2):
17:11:32   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:31
17:11:32   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #7 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32 
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 [0.000000] [mc_record/INFO] * Path chunk #4 '2/0' Actor thread 1(pid:2): MUTEX_ASYNC_LOCK(mutex_id:1 owner:3)
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 Backtrace (displayed in actor thread 1):
17:11:32   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 thread_fun1 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:22
17:11:32   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #7 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32 
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 [0.000000] [mc_record/INFO] * Path chunk #5 '3/0' Actor thread 2(pid:3): MUTEX_WAIT(mutex_id:1 owner:3)
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 Backtrace (displayed in actor thread 2):
17:11:32   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:31
17:11:32   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #7 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32 
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 [0.000000] [mc_record/INFO] * Path chunk #6 '3/0' Actor thread 2(pid:3): MUTEX_ASYNC_LOCK(mutex_id:0 owner:2)
17:11:32 [0.000000] [mc_record/INFO] ***********************************************************************************
17:11:32 Backtrace (displayed in actor thread 2):
17:11:32   ->  #0 simgrid::s4u::Mutex::lock() at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #1 sthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #2 pthread_mutex_lock at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #3 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 thread_fun2 at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ../build/examples/sthread/../examples/sthread/pthread-mutex-simpledeadlock.c:32
17:11:32   ->  #4 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #5 smx_ctx_wrapper at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #6 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32   ->  #7 sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ?? at sthread refuses to intercept the execution of /usr/bin/addr2line. Running the application unmodified.
17:11:32 ??:0
17:11:32 
17:11:32 [0.000000] [mc_record/INFO] The replay of the trace is complete. DEADLOCK detected.
17:11:32 [0.000000] [ker_engine/INFO] 3 actors are still active, awaiting something. Here is their status:
17:11:32 [0.000000] [ker_engine/INFO]  - pid 1 (main thread@Lilibeth) simcall ActorJoin(pid:2)
17:11:32 [0.000000] [ker_engine/INFO]  - pid 2 (thread 1@Lilibeth) simcall MUTEX_WAIT(mutex_id:1 owner:3)
17:11:32 [0.000000] [ker_engine/INFO]  - pid 3 (thread 2@Lilibeth) simcall MUTEX_WAIT(mutex_id:0 owner:2)
17:11:32 [0.000000] [sthread/INFO] All threads exited. Terminating the simulation.
17:11:32 [0.000000] ../src/kernel/EngineImpl.cpp:271: [ker_engine/WARNING] Process called exit when leaving - Skipping cleanups
17:11:32 [0.000000] ../src/kernel/EngineImpl.cpp:271: [ker_engine/WARNING] Process called exit when leaving - Skipping cleanups
17:11:32 
17:11:32 (ignoring the output of <pthread-mc-mutex-simpledeadlock.tesh:35> as requested)
17:11:32 
17:11:32           Start  580: stack-overflow-ucontext
17:11:32  579/1072 Test  #579: stack-overflow-raw ..........................................   Passed    0.13 sec
17:11:32           Start  581: tesh-kernel-context-default
17:11:32  580/1072 Test  #580: stack-overflow-ucontext .....................................   Passed    0.13 sec
17:11:32           Start  582: tesh-kernel-factory-raw
17:11:32  581/1072 Test  #581: tesh-kernel-context-default .................................   Passed    0.07 sec
17:11:32           Start  583: tesh-kernel-factory-thread
17:11:32  582/1072 Test  #582: tesh-kernel-factory-raw .....................................   Passed    0.06 sec
17:11:32           Start  584: tesh-kernel-factory-boost
17:11:32  583/1072 Test  #583: tesh-kernel-factory-thread ..................................   Passed    0.06 sec
17:11:32           Start  585: tesh-kernel-factory-ucontext
17:11:32  584/1072 Test  #584: tesh-kernel-factory-boost ...................................   Passed    0.06 sec
17:11:32           Start  586: mc-random-bug-replay
17:11:32  585/1072 Test  #585: tesh-kernel-factory-ucontext ................................   Passed    0.05 sec
17:11:32           Start  587: tesh-mc-mutex-handling
17:11:32  586/1072 Test  #586: mc-random-bug-replay ........................................   Passed    0.13 sec
17:11:32           Start  588: tesh-mc-mutex-handling-dpor
17:11:32  587/1072 Test  #588: tesh-mc-mutex-handling-dpor .................................   Passed    0.07 sec
17:11:32           Start  589: tesh-mc-without-mutex-handling
17:11:32  588/1072 Test  #589: tesh-mc-without-mutex-handling ..............................   Passed    0.13 sec
17:11:32           Start  590: tesh-mc-without-mutex-handling-dpor
17:11:32  589/1072 Test  #590: tesh-mc-without-mutex-handling-dpor .........................   Passed    0.07 sec
17:11:32           Start  591: mc-random-bug
17:11:33  590/1072 Test  #587: tesh-mc-mutex-handling ......................................   Passed    0.56 sec
17:11:33           Start  592: mc-mini-simple_barrier_ok
17:11:33  591/1072 Test  #592: mc-mini-simple_barrier_ok ...................................   Passed    0.08 sec
17:11:33           Start  593: mc-mini-simple_barrier_deadlock
17:11:33  592/1072 Test  #593: mc-mini-simple_barrier_deadlock .............................   Passed    0.09 sec
17:11:33           Start  594: mc-mini-simple_barrier_with_threads_ok
17:11:33  593/1072 Test  #594: mc-mini-simple_barrier_with_threads_ok ......................   Passed    0.10 sec
17:11:33           Start  595: mc-mini-simple_barrier_with_threads_deadlock
17:11:33  594/1072 Test  #595: mc-mini-simple_barrier_with_threads_deadlock ................   Passed    0.07 sec
17:11:33           Start  596: mc-mini-simple_cond_ok
17:11:33  595/1072 Test  #596: mc-mini-simple_cond_ok ......................................   Passed    0.07 sec
17:11:33           Start  597: mc-mini-simple_cond_deadlock
17:11:33  596/1072 Test  #591: mc-random-bug ...............................................   Passed    0.65 sec
17:11:33           Start  598: mc-mini-simple_cond_broadcast_ok
17:11:33  597/1072 Test  #597: mc-mini-simple_cond_deadlock ................................   Passed    0.07 sec
17:11:33           Start  599: mc-mini-simple_cond_broadcast_deadlock
17:11:33  598/1072 Test  #599: mc-mini-simple_cond_broadcast_deadlock ......................   Passed    0.07 sec
17:11:33           Start  600: mc-mini-simple_mutex_ok
17:11:33  599/1072 Test  #600: mc-mini-simple_mutex_ok .....................................   Passed    0.09 sec
17:11:33           Start  601: mc-mini-simple_mutex_deadlock
17:11:33  600/1072 Test  #601: mc-mini-simple_mutex_deadlock ...............................   Passed    0.07 sec
17:11:33           Start  602: mc-mini-simple_mutex_with_threads_ok
17:11:34  601/1072 Test  #598: mc-mini-simple_cond_broadcast_ok ............................   Passed    0.48 sec
17:11:34           Start  603: mc-mini-simple_mutex_with_threads_deadlock
17:11:34  602/1072 Test  #603: mc-mini-simple_mutex_with_threads_deadlock ..................   Passed    0.07 sec
17:11:34           Start  604: mc-mini-simple_semaphore_deadlock
17:11:34  603/1072 Test  #604: mc-mini-simple_semaphore_deadlock ...........................   Passed    0.07 sec
17:11:34           Start  605: mc-mini-simple_semaphores_deadlock
17:11:34  604/1072 Test  #605: mc-mini-simple_semaphores_deadlock ..........................   Passed    0.06 sec
17:11:34           Start  606: mc-mini-simple_semaphores_ok
17:11:34  605/1072 Test  #606: mc-mini-simple_semaphores_ok ................................   Passed    0.06 sec
17:11:34           Start  607: mc-mini-simple_semaphores_with_threads_ok
17:11:34  606/1072 Test  #607: mc-mini-simple_semaphores_with_threads_ok ...................   Passed    0.12 sec
17:11:34           Start  608: mc-mini-simple_semaphores_with_threads_deadlock
17:11:34  607/1072 Test  #608: mc-mini-simple_semaphores_with_threads_deadlock .............   Passed    0.06 sec
17:11:34           Start  609: mc-mini-simple_threads_ok
17:11:34  608/1072 Test  #609: mc-mini-simple_threads_ok ...................................   Passed    0.07 sec
17:11:34           Start  610: mc-mini-barber_shop_ok
17:11:34  609/1072 Test  #602: mc-mini-simple_mutex_with_threads_ok ........................***Failed    0.84 sec
17:11:34 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:34 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/teshsuite/mc/mcmini/simple_mutex_with_threads_ok.tesh'
17:11:34 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:34 [Tesh/INFO] setenv bindir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc
17:11:34 [simple_mutex_with_threads_ok.tesh:4]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:dpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsgmalloc.so:/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-simple_mutex_with_threads_ok 4
17:11:34 Output of <simple_mutex_with_threads_ok.tesh:4> mismatch:
17:11:34 --- expected
17:11:34 +++ obtained
17:11:34 @@ -1,3 +1,3 @@
17:11:34  [0.000000] [xbt_cfg/INFO] Configuration change: Set 'model-check/reduction' to 'dpor'
17:11:34  [0.000000] [mc_dfs/INFO] Start a DFS exploration. Reduction is: dpor.
17:11:34 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 623 unique states visited; 40 backtracks (279 transition replays, 902 states visited overall)
17:11:34 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 593 unique states visited; 23 backtracks (80 transition replays, 673 states visited overall)
17:11:34 Test suite `simple_mutex_with_threads_ok.tesh': NOK (<simple_mutex_with_threads_ok.tesh:4> output mismatch)
17:11:34 [simple_mutex_with_threads_ok.tesh:9]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:dpor --cfg=model-check/exploration-algo:OOO --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsgmalloc.so:/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-simple_mutex_with_threads_ok 4
17:11:34 Output of <simple_mutex_with_threads_ok.tesh:9> mismatch:
17:11:34 --- expected
17:11:34 +++ obtained
17:11:34 @@ -1,4 +1,4 @@
17:11:34  [0.000000] [xbt_cfg/INFO] Configuration change: Set 'model-check/reduction' to 'dpor'
17:11:34  [0.000000] [xbt_cfg/INFO] Configuration change: Set 'model-check/exploration-algo' to 'OOO'
17:11:34  [0.000000] [mc_ooo/INFO] Start an Out-of-Order exploration. Reduction is: dpor.
17:11:34 -[0.000000] [mc_ooo/INFO] Out-of-Order exploration ended. 623 unique states visited; 40 backtracks (279 transition replays, 902 states visited overall)
17:11:34 +[0.000000] [mc_ooo/INFO] Out-of-Order exploration ended. 593 unique states visited; 23 backtracks (80 transition replays, 673 states visited overall)
17:11:34 Test suite `simple_mutex_with_threads_ok.tesh': NOK (<simple_mutex_with_threads_ok.tesh:9> output mismatch)
17:11:34 [simple_mutex_with_threads_ok.tesh:15]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:odpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsgmalloc.so:/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-simple_mutex_with_threads_ok 4
17:11:34 
17:11:34 [simple_mutex_with_threads_ok.tesh:20]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:udpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsgmalloc.so:/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-simple_mutex_with_threads_ok 4
17:11:34 
17:11:34 
17:11:34           Start  611: mc-mini-barber_shop_deadlock
17:11:34  610/1072 Test  #611: mc-mini-barber_shop_deadlock ................................   Passed    0.07 sec
17:11:34           Start  612: mc-mini-philosophers_semaphores_ok
17:11:34  611/1072 Test  #612: mc-mini-philosophers_semaphores_ok ..........................   Passed    0.12 sec
17:11:34           Start  613: mc-mini-philosophers_semaphores_deadlock
17:11:35  612/1072 Test  #610: mc-mini-barber_shop_ok ......................................   Passed    0.54 sec
17:11:35           Start  614: mc-mini-philosophers_mutex_ok
17:11:35  613/1072 Test  #613: mc-mini-philosophers_semaphores_deadlock ....................***Failed    0.28 sec
17:11:35 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:35 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/teshsuite/mc/mcmini/philosophers_semaphores_deadlock.tesh'
17:11:35 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:35 [Tesh/INFO] setenv bindir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc
17:11:35 [philosophers_semaphores_deadlock.tesh:5]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-philosophers_semaphores_deadlock 3 0
17:11:35 Output of <philosophers_semaphores_deadlock.tesh:5> mismatch:
17:11:35 --- expected
17:11:35 +++ obtained
17:11:35 @@ -24,4 +24,4 @@
17:11:35  [0.000000] [mc_global/INFO]   Actor 4 in simcall MUTEX_WAIT(mutex: 2, owner: 4)
17:11:35  [0.000000] [mc_global/INFO]   Actor 4 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:35  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;2;2;3;3;3;2;3;4;4;4;3;4;4'
17:11:35 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 618 unique states visited; 53 backtracks (809 transition replays, 1427 states visited overall)
17:11:35 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 517 unique states visited; 30 backtracks (399 transition replays, 916 states visited overall)
17:11:35 Test suite `philosophers_semaphores_deadlock.tesh': NOK (<philosophers_semaphores_deadlock.tesh:5> output mismatch)
17:11:35 [philosophers_semaphores_deadlock.tesh:35]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/exploration-algo:OOO --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-philosophers_semaphores_deadlock 3 0
17:11:35 Output of <philosophers_semaphores_deadlock.tesh:35> mismatch:
17:11:35 --- expected
17:11:35 +++ obtained
17:11:35 @@ -25,4 +25,4 @@
17:11:35  [0.000000] [mc_global/INFO]   Actor 4 in simcall MUTEX_WAIT(mutex: 2, owner: 4)
17:11:35  [0.000000] [mc_global/INFO]   Actor 4 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:35  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;2;2;3;3;3;2;3;4;4;4;3;4;4'
17:11:35 -[0.000000] [mc_ooo/INFO] Out-of-Order exploration ended. 618 unique states visited; 53 backtracks (809 transition replays, 1427 states visited overall)
17:11:35 +[0.000000] [mc_ooo/INFO] Out-of-Order exploration ended. 517 unique states visited; 30 backtracks (399 transition replays, 916 states visited overall)
17:11:35 Test suite `philosophers_semaphores_deadlock.tesh': NOK (<philosophers_semaphores_deadlock.tesh:35> output mismatch)
17:11:35 
17:11:35           Start  615: mc-mini-philosophers_mutex_deadlock
17:11:35  614/1072 Test  #615: mc-mini-philosophers_mutex_deadlock .........................***Failed    0.25 sec
17:11:35 Ignore all cruft seen on SimGrid's continuous integration servers
17:11:35 Test suite '/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/teshsuite/mc/mcmini/philosophers_mutex_deadlock.tesh'
17:11:35 [Tesh/INFO] setenv libdir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib
17:11:35 [Tesh/INFO] setenv bindir=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc
17:11:35 [philosophers_mutex_deadlock.tesh:5]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:dpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-philosophers_mutex_deadlock 4 0
17:11:35 Output of <philosophers_mutex_deadlock.tesh:5> mismatch:
17:11:35 --- expected
17:11:35 +++ obtained
17:11:35 @@ -23,4 +23,4 @@
17:11:35  [0.000000] [mc_global/INFO]   Actor 5 in simcall MUTEX_WAIT(mutex: 3, owner: 5)
17:11:35  [0.000000] [mc_global/INFO]   Actor 5 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:35  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;3;2;3;4;3;4;5;4;5;5'
17:11:35 -[0.000000] [mc_dfs/INFO] DFS exploration ended. 296 unique states visited; 36 backtracks (494 transition replays, 790 states visited overall)
17:11:35 +[0.000000] [mc_dfs/INFO] DFS exploration ended. 141 unique states visited; 7 backtracks (68 transition replays, 209 states visited overall)
17:11:35 Test suite `philosophers_mutex_deadlock.tesh': NOK (<philosophers_mutex_deadlock.tesh:5> output mismatch)
17:11:35 [philosophers_mutex_deadlock.tesh:34]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:dpor --cfg=model-check/exploration-algo:OOO --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-philosophers_mutex_deadlock 4 0
17:11:35 Output of <philosophers_mutex_deadlock.tesh:34> mismatch:
17:11:35 --- expected
17:11:35 +++ obtained
17:11:35 @@ -24,4 +24,4 @@
17:11:35  [0.000000] [mc_global/INFO]   Actor 5 in simcall MUTEX_WAIT(mutex: 3, owner: 5)
17:11:35  [0.000000] [mc_global/INFO]   Actor 5 in simcall MUTEX_ASYNC_LOCK(mutex: 0, owner: 2)
17:11:35  [0.000000] [mc_Session/INFO] You can debug the problem (and see the whole details) by rerunning out of simgrid-mc with --cfg=model-check/replay:'2;2;3;2;3;4;3;4;5;4;5;5'
17:11:35 -[0.000000] [mc_ooo/INFO] Out-of-Order exploration ended. 296 unique states visited; 36 backtracks (494 transition replays, 790 states visited overall)
17:11:35 +[0.000000] [mc_ooo/INFO] Out-of-Order exploration ended. 141 unique states visited; 7 backtracks (68 transition replays, 209 states visited overall)
17:11:35 Test suite `philosophers_mutex_deadlock.tesh': NOK (<philosophers_mutex_deadlock.tesh:34> output mismatch)
17:11:35 [philosophers_mutex_deadlock.tesh:64]  /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/../../bin/simgrid-mc --cfg=model-check/reduction:odpor --cfg=model-check/setenv:LD_PRELOAD=/builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/lib/libsthread.so /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/teshsuite/mc/mcmini/mcmini-philosophers_mutex_deadlock 5 0
17:11:35 
17:11:35 
17:11:35           Start  616: mc-mini-producer_consumer_ok
17:11:35  615/1072 Test  #616: mc-mini-producer_consumer_ok ................................   Passed    0.28 sec
17:11:35           Start  617: mc-mini-producer_consumer_deadlock
17:11:35  616/1072 Test  #617: mc-mini-producer_consumer_deadlock ..........................   Passed    0.07 sec
17:11:35           Start  618: tesh-model-lmm_usage
17:11:35  617/1072 Test  #618: tesh-model-lmm_usage ........................................   Passed    0.07 sec
17:11:35           Start  619: tesh-model-core_usage
17:11:35  618/1072 Test  #619: tesh-model-core_usage .......................................   Passed    0.07 sec
17:11:35           Start  620: tesh-model-core_usage2
17:11:35  619/1072 Test  #620: tesh-model-core_usage2 ......................................   Passed    0.07 sec
17:11:35           Start  621: tesh-model-cloud-sharing
17:11:36  620/1072 Test  #621: tesh-model-cloud-sharing ....................................   Passed    0.08 sec
17:11:36           Start  622: tesh-model-ptask_L07_usage
17:11:36  621/1072 Test  #622: tesh-model-ptask_L07_usage ..................................   Passed    0.07 sec
17:11:36           Start  623: tesh-model-wifi_usage
17:11:36  622/1072 Test  #623: tesh-model-wifi_usage .......................................   Passed    0.07 sec
17:11:36           Start  624: tesh-model-wifi_usage_decay
17:11:36  623/1072 Test  #624: tesh-model-wifi_usage_decay .................................   Passed    0.07 sec
17:11:36           Start  625: tesh-model-cm02-set-lat-bw
17:11:36  624/1072 Test  #625: tesh-model-cm02-set-lat-bw ..................................   Passed    0.06 sec
17:11:36           Start  626: tesh-model-cm02-tcpgamma
17:11:36  625/1072 Test  #626: tesh-model-cm02-tcpgamma ....................................   Passed    0.07 sec
17:11:36           Start  627: tesh-model-issue105
17:11:36  626/1072 Test  #627: tesh-model-issue105 .........................................   Passed    0.07 sec
17:11:36           Start  628: tesh-model-ptask-subflows
17:11:36  627/1072 Test  #628: tesh-model-ptask-subflows ...................................   Passed    0.07 sec
17:11:36           Start  629: tesh-model-cm02-set-lat-bw-bmf
17:11:36  628/1072 Test  #629: tesh-model-cm02-set-lat-bw-bmf ..............................   Passed    0.05 sec
17:11:36           Start  630: tesh-maxmin-small
17:11:36  629/1072 Test  #630: tesh-maxmin-small ...........................................   Passed    0.09 sec
17:11:36           Start  631: tesh-maxmin-medium
17:11:37  630/1072 Test  #631: tesh-maxmin-medium ..........................................   Passed    0.49 sec
17:11:37           Start  632: tesh-maxmin-large
17:11:38  631/1072 Test  #632: tesh-maxmin-large ...........................................   Passed    0.94 sec
17:11:38           Start  633: tesh-platform-flatifier
17:11:38  632/1072 Test  #633: tesh-platform-flatifier .....................................   Passed    0.22 sec
17:11:38           Start  634: tesh-parser-bogus-symmetric
17:11:38  633/1072 Test  #634: tesh-parser-bogus-symmetric .................................   Passed    0.13 sec
17:11:38           Start  635: tesh-parser-bogus-missing-gw
17:11:38  634/1072 Test  #635: tesh-parser-bogus-missing-gw ................................   Passed    0.21 sec
17:11:38           Start  636: tesh-s4u-actor-thread
17:11:38  635/1072 Test  #636: tesh-s4u-actor-thread .......................................   Passed    0.07 sec
17:11:38           Start  637: tesh-s4u-actor-boost
17:11:38  636/1072 Test  #637: tesh-s4u-actor-boost ........................................   Passed    0.05 sec
17:11:38           Start  638: tesh-s4u-actor-raw
17:11:38  637/1072 Test  #638: tesh-s4u-actor-raw ..........................................   Passed    0.05 sec
17:11:38           Start  639: tesh-s4u-actor-ucontext
17:11:38  638/1072 Test  #639: tesh-s4u-actor-ucontext .....................................   Passed    0.05 sec
17:11:38           Start  640: tesh-s4u-actor-autorestart-thread
17:11:38  639/1072 Test  #640: tesh-s4u-actor-autorestart-thread ...........................   Passed    0.07 sec
17:11:38           Start  641: tesh-s4u-actor-autorestart-boost
17:11:39  640/1072 Test  #641: tesh-s4u-actor-autorestart-boost ............................   Passed    0.05 sec
17:11:39           Start  642: tesh-s4u-actor-autorestart-raw
17:11:39  641/1072 Test  #642: tesh-s4u-actor-autorestart-raw ..............................   Passed    0.05 sec
17:11:39           Start  643: tesh-s4u-actor-autorestart-ucontext
17:11:39  642/1072 Test  #643: tesh-s4u-actor-autorestart-ucontext .........................   Passed    0.05 sec
17:11:39           Start  644: tesh-s4u-actor-suspend-thread
17:11:39  643/1072 Test  #644: tesh-s4u-actor-suspend-thread ...............................   Passed    0.07 sec
17:11:39           Start  645: tesh-s4u-actor-suspend-boost
17:11:39  644/1072 Test  #645: tesh-s4u-actor-suspend-boost ................................   Passed    0.05 sec
17:11:39           Start  646: tesh-s4u-actor-suspend-raw
17:11:39  645/1072 Test  #646: tesh-s4u-actor-suspend-raw ..................................   Passed    0.05 sec
17:11:39           Start  647: tesh-s4u-actor-suspend-ucontext
17:11:39  646/1072 Test  #647: tesh-s4u-actor-suspend-ucontext .............................   Passed    0.05 sec
17:11:39           Start  648: tesh-s4u-activity-lifecycle-thread
17:11:39  647/1072 Test  #648: tesh-s4u-activity-lifecycle-thread ..........................   Passed    0.12 sec
17:11:39           Start  649: tesh-s4u-activity-lifecycle-boost
17:11:39  648/1072 Test  #649: tesh-s4u-activity-lifecycle-boost ...........................   Passed    0.07 sec
17:11:39           Start  650: tesh-s4u-activity-lifecycle-raw
17:11:39  649/1072 Test  #650: tesh-s4u-activity-lifecycle-raw .............................   Passed    0.07 sec
17:11:39           Start  651: tesh-s4u-activity-lifecycle-ucontext
17:11:39  650/1072 Test  #651: tesh-s4u-activity-lifecycle-ucontext ........................   Passed    0.07 sec
17:11:39           Start  652: tesh-s4u-comm-get-sender-thread
17:11:39  651/1072 Test  #652: tesh-s4u-comm-get-sender-thread .............................   Passed    0.07 sec
17:11:39           Start  653: tesh-s4u-comm-get-sender-boost
17:11:39  652/1072 Test  #653: tesh-s4u-comm-get-sender-boost ..............................   Passed    0.06 sec
17:11:39           Start  654: tesh-s4u-comm-get-sender-raw
17:11:39  653/1072 Test  #654: tesh-s4u-comm-get-sender-raw ................................   Passed    0.06 sec
17:11:39           Start  655: tesh-s4u-comm-get-sender-ucontext
17:11:39  654/1072 Test  #655: tesh-s4u-comm-get-sender-ucontext ...........................   Passed    0.05 sec
17:11:39           Start  656: tesh-s4u-cloud-interrupt-migration-thread
17:11:39  655/1072 Test  #656: tesh-s4u-cloud-interrupt-migration-thread ...................   Passed    0.07 sec
17:11:39           Start  657: tesh-s4u-cloud-interrupt-migration-boost
17:11:40  656/1072 Test  #657: tesh-s4u-cloud-interrupt-migration-boost ....................   Passed    0.05 sec
17:11:40           Start  658: tesh-s4u-cloud-interrupt-migration-raw
17:11:40  657/1072 Test  #658: tesh-s4u-cloud-interrupt-migration-raw ......................   Passed    0.05 sec
17:11:40           Start  659: tesh-s4u-cloud-interrupt-migration-ucontext
17:11:40  658/1072 Test  #659: tesh-s4u-cloud-interrupt-migration-ucontext .................   Passed    0.05 sec
17:11:40           Start  660: tesh-s4u-cloud-two-execs-thread
17:11:40  659/1072 Test  #660: tesh-s4u-cloud-two-execs-thread .............................   Passed    0.07 sec
17:11:40           Start  661: tesh-s4u-cloud-two-execs-boost
17:11:40  660/1072 Test  #661: tesh-s4u-cloud-two-execs-boost ..............................   Passed    0.05 sec
17:11:40           Start  662: tesh-s4u-cloud-two-execs-raw
17:11:40  661/1072 Test  #662: tesh-s4u-cloud-two-execs-raw ................................   Passed    0.05 sec
17:11:40           Start  663: tesh-s4u-cloud-two-execs-ucontext
17:11:40  662/1072 Test  #663: tesh-s4u-cloud-two-execs-ucontext ...........................   Passed    0.06 sec
17:11:40           Start  664: tesh-s4u-concurrent_rw-thread
17:11:40  663/1072 Test  #664: tesh-s4u-concurrent_rw-thread ...............................   Passed    0.07 sec
17:11:40           Start  665: tesh-s4u-concurrent_rw-boost
17:11:40  664/1072 Test  #665: tesh-s4u-concurrent_rw-boost ................................   Passed    0.05 sec
17:11:40           Start  666: tesh-s4u-concurrent_rw-raw
17:11:40  665/1072 Test  #666: tesh-s4u-concurrent_rw-raw ..................................   Passed    0.05 sec
17:11:40           Start  667: tesh-s4u-concurrent_rw-ucontext
17:11:40  666/1072 Test  #667: tesh-s4u-concurrent_rw-ucontext .............................   Passed    0.05 sec
17:11:40           Start  668: tesh-s4u-dag-incomplete-simulation-thread
17:11:40  667/1072 Test  #668: tesh-s4u-dag-incomplete-simulation-thread ...................   Passed    0.07 sec
17:11:40           Start  669: tesh-s4u-dag-incomplete-simulation-boost
17:11:40  668/1072 Test  #669: tesh-s4u-dag-incomplete-simulation-boost ....................   Passed    0.05 sec
17:11:40           Start  670: tesh-s4u-dag-incomplete-simulation-raw
17:11:40  669/1072 Test  #670: tesh-s4u-dag-incomplete-simulation-raw ......................   Passed    0.05 sec
17:11:40           Start  671: tesh-s4u-dag-incomplete-simulation-ucontext
17:11:40  670/1072 Test  #671: tesh-s4u-dag-incomplete-simulation-ucontext .................   Passed    0.05 sec
17:11:40           Start  672: tesh-s4u-dependencies-thread
17:11:40  671/1072 Test  #672: tesh-s4u-dependencies-thread ................................   Passed    0.06 sec
17:11:40           Start  673: tesh-s4u-dependencies-boost
17:11:40  672/1072 Test  #673: tesh-s4u-dependencies-boost .................................   Passed    0.05 sec
17:11:40           Start  674: tesh-s4u-dependencies-raw
17:11:41  673/1072 Test  #674: tesh-s4u-dependencies-raw ...................................   Passed    0.05 sec
17:11:41           Start  675: tesh-s4u-dependencies-ucontext
17:11:41  674/1072 Test  #675: tesh-s4u-dependencies-ucontext ..............................   Passed    0.05 sec
17:11:41           Start  676: tesh-s4u-io-set-bw-thread
17:11:41  675/1072 Test  #676: tesh-s4u-io-set-bw-thread ...................................   Passed    0.06 sec
17:11:41           Start  677: tesh-s4u-io-set-bw-boost
17:11:41  676/1072 Test  #677: tesh-s4u-io-set-bw-boost ....................................   Passed    0.05 sec
17:11:41           Start  678: tesh-s4u-io-set-bw-raw
17:11:41  677/1072 Test  #678: tesh-s4u-io-set-bw-raw ......................................   Passed    0.05 sec
17:11:41           Start  679: tesh-s4u-io-set-bw-ucontext
17:11:41  678/1072 Test  #679: tesh-s4u-io-set-bw-ucontext .................................   Passed    0.05 sec
17:11:41           Start  680: tesh-s4u-io-stream-thread
17:11:41  679/1072 Test  #680: tesh-s4u-io-stream-thread ...................................   Passed    0.09 sec
17:11:41           Start  681: tesh-s4u-io-stream-boost
17:11:41  680/1072 Test  #681: tesh-s4u-io-stream-boost ....................................   Passed    0.06 sec
17:11:41           Start  682: tesh-s4u-io-stream-raw
17:11:41  681/1072 Test  #682: tesh-s4u-io-stream-raw ......................................   Passed    0.07 sec
17:11:41           Start  683: tesh-s4u-io-stream-ucontext
17:11:41  682/1072 Test  #683: tesh-s4u-io-stream-ucontext .................................   Passed    0.07 sec
17:11:41           Start  684: tesh-s4u-vm-live-migration-thread
17:11:41  683/1072 Test  #684: tesh-s4u-vm-live-migration-thread ...........................   Passed    0.07 sec
17:11:41           Start  685: tesh-s4u-vm-live-migration-boost
17:11:41  684/1072 Test  #685: tesh-s4u-vm-live-migration-boost ............................   Passed    0.05 sec
17:11:41           Start  686: tesh-s4u-vm-live-migration-raw
17:11:41  685/1072 Test  #686: tesh-s4u-vm-live-migration-raw ..............................   Passed    0.05 sec
17:11:41           Start  687: tesh-s4u-vm-live-migration-ucontext
17:11:41  686/1072 Test  #687: tesh-s4u-vm-live-migration-ucontext .........................   Passed    0.05 sec
17:11:41           Start  688: tesh-s4u-vm-suicide-thread
17:11:41  687/1072 Test  #688: tesh-s4u-vm-suicide-thread ..................................   Passed    0.07 sec
17:11:41           Start  689: tesh-s4u-vm-suicide-boost
17:11:41  688/1072 Test  #689: tesh-s4u-vm-suicide-boost ...................................   Passed    0.05 sec
17:11:41           Start  690: tesh-s4u-vm-suicide-raw
17:11:41  689/1072 Test  #690: tesh-s4u-vm-suicide-raw .....................................   Passed    0.05 sec
17:11:41           Start  691: tesh-s4u-vm-suicide-ucontext
17:11:42  690/1072 Test  #691: tesh-s4u-vm-suicide-ucontext ................................   Passed    0.05 sec
17:11:42           Start  692: tesh-s4u-basic-link-test
17:11:42  691/1072 Test  #692: tesh-s4u-basic-link-test ....................................   Passed    0.07 sec
17:11:42           Start  693: tesh-s4u-basic-parsing-test
17:11:42  692/1072 Test  #693: tesh-s4u-basic-parsing-test .................................   Passed    0.15 sec
17:11:42           Start  694: tesh-s4u-host-on-off
17:11:42  693/1072 Test  #694: tesh-s4u-host-on-off ........................................   Passed    0.07 sec
17:11:42           Start  695: tesh-s4u-host-on-off-actors
17:11:42  694/1072 Test  #695: tesh-s4u-host-on-off-actors .................................   Passed    0.15 sec
17:11:42           Start  696: tesh-s4u-host-on-off-recv
17:11:42  695/1072 Test  #696: tesh-s4u-host-on-off-recv ...................................   Passed    0.06 sec
17:11:42           Start  697: tesh-s4u-comm-fault-scenarios
17:11:42  696/1072 Test  #697: tesh-s4u-comm-fault-scenarios ...............................   Passed    0.08 sec
17:11:42           Start  698: tesh-s4u-host-multicore-speed-file
17:11:42  697/1072 Test  #698: tesh-s4u-host-multicore-speed-file ..........................   Passed    0.06 sec
17:11:42           Start  699: tesh-s4u-is-router
17:11:42  698/1072 Test  #699: tesh-s4u-is-router ..........................................   Passed    0.06 sec
17:11:42           Start  700: tesh-s4u-listen_async
17:11:42  699/1072 Test  #700: tesh-s4u-listen_async .......................................   Passed    0.06 sec
17:11:42           Start  701: tesh-s4u-monkey-masterworkers
17:11:42  700/1072 Test  #701: tesh-s4u-monkey-masterworkers ...............................   Passed    0.06 sec
17:11:42           Start  702: tesh-s4u-monkey-semaphore
17:11:42  701/1072 Test  #702: tesh-s4u-monkey-semaphore ...................................   Passed    0.06 sec
17:11:42           Start  703: tesh-s4u-pid
17:11:42  702/1072 Test  #703: tesh-s4u-pid ................................................   Passed    0.06 sec
17:11:42           Start  704: tesh-s4u-storage_client_server
17:11:43  703/1072 Test  #704: tesh-s4u-storage_client_server ..............................   Passed    0.07 sec
17:11:43           Start  705: tesh-s4u-trace-integration
17:11:43  704/1072 Test  #705: tesh-s4u-trace-integration ..................................   Passed    0.21 sec
17:11:43           Start  706: tesh-s4u-seal-platform
17:11:43  705/1072 Test  #706: tesh-s4u-seal-platform ......................................   Passed    0.06 sec
17:11:43           Start  707: tesh-s4u-issue71
17:11:43  706/1072 Test  #707: tesh-s4u-issue71 ............................................   Passed    0.06 sec
17:11:43           Start  708: monkey-s4u-monkey-masterworkers
17:11:43  707/1072 Test  #708: monkey-s4u-monkey-masterworkers .............................   Passed    0.50 sec
17:11:43           Start  709: monkey-s4u-monkey-semaphore
17:11:44  708/1072 Test  #709: monkey-s4u-monkey-semaphore .................................   Passed    0.42 sec
17:11:44           Start  710: tesh-s4u-comm-pt2pt
17:11:44  709/1072 Test  #710: tesh-s4u-comm-pt2pt .........................................   Passed    0.02 sec
17:11:44           Start  711: tesh-s4u-cloud-two-execs-bmf
17:11:44  710/1072 Test  #711: tesh-s4u-cloud-two-execs-bmf ................................   Passed    0.06 sec
17:11:44           Start  712: tesh-s4u-concurrent_rw-bmf
17:11:44  711/1072 Test  #712: tesh-s4u-concurrent_rw-bmf ..................................   Passed    0.06 sec
17:11:44           Start  713: test-help-version
17:11:44  712/1072 Test  #713: test-help-version ...........................................   Passed    0.01 sec
17:11:44           Start  714: test-help-logs
17:11:44  713/1072 Test  #714: test-help-logs ..............................................   Passed    0.01 sec
17:11:44           Start  715: tesh-parser-bypass
17:11:44  714/1072 Test  #715: tesh-parser-bypass ..........................................   Passed    0.07 sec
17:11:44           Start  716: tesh-parser-sym-full
17:11:44  715/1072 Test  #716: tesh-parser-sym-full ........................................   Passed    0.10 sec
17:11:44           Start  717: tesh-parser-full-links01
17:11:44  716/1072 Test  #717: tesh-parser-full-links01 ....................................   Passed    0.01 sec
17:11:44           Start  718: tesh-parser-full-links02
17:11:44  717/1072 Test  #718: tesh-parser-full-links02 ....................................   Passed    0.01 sec
17:11:44           Start  719: tesh-parser-one-link-g5k
17:11:44  718/1072 Test  #719: tesh-parser-one-link-g5k ....................................   Passed    0.04 sec
17:11:44           Start  720: test-smpi-help-coll
17:11:44  719/1072 Test  #720: test-smpi-help-coll .........................................   Passed    0.08 sec
17:11:44           Start  721: tesh-smpi-macro-shared-thread
17:11:44  720/1072 Test  #721: tesh-smpi-macro-shared-thread ...............................   Passed    0.12 sec
17:11:44           Start  722: tesh-smpi-macro-shared-boost
17:11:44  721/1072 Test  #722: tesh-smpi-macro-shared-boost ................................   Passed    0.08 sec
17:11:44           Start  723: tesh-smpi-macro-shared-raw
17:11:45  722/1072 Test  #723: tesh-smpi-macro-shared-raw ..................................   Passed    0.08 sec
17:11:45           Start  724: tesh-smpi-macro-shared-ucontext
17:11:45  723/1072 Test  #724: tesh-smpi-macro-shared-ucontext .............................   Passed    0.08 sec
17:11:45           Start  725: tesh-smpi-auto-shared-thread
17:11:45  724/1072 Test  #725: tesh-smpi-auto-shared-thread ................................   Passed    0.09 sec
17:11:45           Start  726: tesh-smpi-auto-shared-boost
17:11:45  725/1072 Test  #726: tesh-smpi-auto-shared-boost .................................   Passed    0.08 sec
17:11:45           Start  727: tesh-smpi-auto-shared-raw
17:11:45  726/1072 Test  #727: tesh-smpi-auto-shared-raw ...................................   Passed    0.08 sec
17:11:45           Start  728: tesh-smpi-auto-shared-ucontext
17:11:45  727/1072 Test  #728: tesh-smpi-auto-shared-ucontext ..............................   Passed    0.08 sec
17:11:45           Start  729: tesh-smpi-macro-partial-shared-thread
17:11:45  728/1072 Test  #729: tesh-smpi-macro-partial-shared-thread .......................   Passed    0.18 sec
17:11:45           Start  730: tesh-smpi-macro-partial-shared-boost
17:11:45  729/1072 Test  #730: tesh-smpi-macro-partial-shared-boost ........................   Passed    0.15 sec
17:11:45           Start  731: tesh-smpi-macro-partial-shared-raw
17:11:45  730/1072 Test  #731: tesh-smpi-macro-partial-shared-raw ..........................   Passed    0.14 sec
17:11:45           Start  732: tesh-smpi-macro-partial-shared-ucontext
17:11:46  731/1072 Test  #732: tesh-smpi-macro-partial-shared-ucontext .....................   Passed    0.16 sec
17:11:46           Start  733: tesh-smpi-macro-partial-shared-communication-thread
17:11:46  732/1072 Test  #733: tesh-smpi-macro-partial-shared-communication-thread .........   Passed    0.13 sec
17:11:46           Start  734: tesh-smpi-macro-partial-shared-communication-boost
17:11:46  733/1072 Test  #734: tesh-smpi-macro-partial-shared-communication-boost ..........   Passed    0.13 sec
17:11:46           Start  735: tesh-smpi-macro-partial-shared-communication-raw
17:11:46  734/1072 Test  #735: tesh-smpi-macro-partial-shared-communication-raw ............   Passed    0.12 sec
17:11:46           Start  736: tesh-smpi-macro-partial-shared-communication-ucontext
17:11:46  735/1072 Test  #736: tesh-smpi-macro-partial-shared-communication-ucontext .......   Passed    0.12 sec
17:11:46           Start  737: tesh-smpi-coll-allgather-thread
17:11:46  736/1072 Test  #737: tesh-smpi-coll-allgather-thread .............................   Passed    0.13 sec
17:11:46           Start  738: tesh-smpi-coll-allgather-boost
17:11:46  737/1072 Test  #738: tesh-smpi-coll-allgather-boost ..............................   Passed    0.10 sec
17:11:46           Start  739: tesh-smpi-coll-allgather-raw
17:11:46  738/1072 Test  #739: tesh-smpi-coll-allgather-raw ................................   Passed    0.10 sec
17:11:46           Start  740: tesh-smpi-coll-allgather-ucontext
17:11:47  739/1072 Test  #740: tesh-smpi-coll-allgather-ucontext ...........................   Passed    0.10 sec
17:11:47           Start  741: tesh-smpi-coll-allgatherv-thread
17:11:47  740/1072 Test  #741: tesh-smpi-coll-allgatherv-thread ............................   Passed    0.12 sec
17:11:47           Start  742: tesh-smpi-coll-allgatherv-boost
17:11:47  741/1072 Test  #614: mc-mini-philosophers_mutex_ok ...............................   Passed   12.11 sec
17:11:47           Start  743: tesh-smpi-coll-allgatherv-raw
17:11:47  742/1072 Test  #742: tesh-smpi-coll-allgatherv-boost .............................   Passed    0.10 sec
17:11:47           Start  744: tesh-smpi-coll-allgatherv-ucontext
17:11:47  743/1072 Test  #743: tesh-smpi-coll-allgatherv-raw ...............................   Passed    0.11 sec
17:11:47           Start  745: tesh-smpi-coll-allreduce-thread
17:11:47  744/1072 Test  #744: tesh-smpi-coll-allgatherv-ucontext ..........................   Passed    0.12 sec
17:11:47           Start  746: tesh-smpi-coll-allreduce-boost
17:11:47  745/1072 Test  #745: tesh-smpi-coll-allreduce-thread .............................   Passed    0.12 sec
17:11:47           Start  747: tesh-smpi-coll-allreduce-raw
17:11:47  746/1072 Test  #746: tesh-smpi-coll-allreduce-boost ..............................   Passed    0.11 sec
17:11:47           Start  748: tesh-smpi-coll-allreduce-ucontext
17:11:47  747/1072 Test  #747: tesh-smpi-coll-allreduce-raw ................................   Passed    0.10 sec
17:11:47           Start  749: tesh-smpi-coll-alltoall-thread
17:11:47  748/1072 Test  #748: tesh-smpi-coll-allreduce-ucontext ...........................   Passed    0.09 sec
17:11:47           Start  750: tesh-smpi-coll-alltoall-boost
17:11:47  749/1072 Test  #750: tesh-smpi-coll-alltoall-boost ...............................   Passed    0.12 sec
17:11:47           Start  751: tesh-smpi-coll-alltoall-raw
17:11:47  750/1072 Test  #749: tesh-smpi-coll-alltoall-thread ..............................   Passed    0.12 sec
17:11:47           Start  752: tesh-smpi-coll-alltoall-ucontext
17:11:47  751/1072 Test  #751: tesh-smpi-coll-alltoall-raw .................................   Passed    0.10 sec
17:11:47           Start  753: tesh-smpi-coll-alltoallv-thread
17:11:47  752/1072 Test  #752: tesh-smpi-coll-alltoall-ucontext ............................   Passed    0.10 sec
17:11:47           Start  754: tesh-smpi-coll-alltoallv-boost
17:11:47  753/1072 Test  #754: tesh-smpi-coll-alltoallv-boost ..............................   Passed    0.12 sec
17:11:47           Start  755: tesh-smpi-coll-alltoallv-raw
17:11:47  754/1072 Test  #753: tesh-smpi-coll-alltoallv-thread .............................   Passed    0.13 sec
17:11:47           Start  756: tesh-smpi-coll-alltoallv-ucontext
17:11:47  755/1072 Test  #755: tesh-smpi-coll-alltoallv-raw ................................   Passed    0.10 sec
17:11:47           Start  757: tesh-smpi-coll-barrier-thread
17:11:47  756/1072 Test  #756: tesh-smpi-coll-alltoallv-ucontext ...........................   Passed    0.10 sec
17:11:47           Start  758: tesh-smpi-coll-barrier-boost
17:11:48  757/1072 Test  #758: tesh-smpi-coll-barrier-boost ................................   Passed    0.11 sec
17:11:48           Start  759: tesh-smpi-coll-barrier-raw
17:11:48  758/1072 Test  #757: tesh-smpi-coll-barrier-thread ...............................   Passed    0.11 sec
17:11:48           Start  760: tesh-smpi-coll-barrier-ucontext
17:11:48  759/1072 Test  #759: tesh-smpi-coll-barrier-raw ..................................   Passed    0.10 sec
17:11:48           Start  761: tesh-smpi-coll-bcast-thread
17:11:48  760/1072 Test  #760: tesh-smpi-coll-barrier-ucontext .............................   Passed    0.10 sec
17:11:48           Start  762: tesh-smpi-coll-bcast-boost
17:11:48  761/1072 Test  #762: tesh-smpi-coll-bcast-boost ..................................   Passed    0.10 sec
17:11:48           Start  763: tesh-smpi-coll-bcast-raw
17:11:48  762/1072 Test  #761: tesh-smpi-coll-bcast-thread .................................   Passed    0.11 sec
17:11:48           Start  764: tesh-smpi-coll-bcast-ucontext
17:11:48  763/1072 Test  #763: tesh-smpi-coll-bcast-raw ....................................   Passed    0.09 sec
17:11:48           Start  765: tesh-smpi-coll-gather-thread
17:11:48  764/1072 Test  #764: tesh-smpi-coll-bcast-ucontext ...............................   Passed    0.10 sec
17:11:48           Start  766: tesh-smpi-coll-gather-boost
17:11:48  765/1072 Test  #766: tesh-smpi-coll-gather-boost .................................   Passed    0.10 sec
17:11:48           Start  767: tesh-smpi-coll-gather-raw
17:11:48  766/1072 Test  #765: tesh-smpi-coll-gather-thread ................................   Passed    0.11 sec
17:11:48           Start  768: tesh-smpi-coll-gather-ucontext
17:11:48  767/1072 Test  #767: tesh-smpi-coll-gather-raw ...................................   Passed    0.09 sec
17:11:48           Start  769: tesh-smpi-coll-reduce-thread
17:11:48  768/1072 Test  #768: tesh-smpi-coll-gather-ucontext ..............................   Passed    0.09 sec
17:11:48           Start  770: tesh-smpi-coll-reduce-boost
17:11:48  769/1072 Test  #770: tesh-smpi-coll-reduce-boost .................................   Passed    0.10 sec
17:11:48           Start  771: tesh-smpi-coll-reduce-raw
17:11:48  770/1072 Test  #769: tesh-smpi-coll-reduce-thread ................................   Passed    0.11 sec
17:11:48           Start  772: tesh-smpi-coll-reduce-ucontext
17:11:48  771/1072 Test  #771: tesh-smpi-coll-reduce-raw ...................................   Passed    0.09 sec
17:11:48           Start  773: tesh-smpi-coll-reduce-scatter-thread
17:11:48  772/1072 Test  #772: tesh-smpi-coll-reduce-ucontext ..............................   Passed    0.09 sec
17:11:48           Start  774: tesh-smpi-coll-reduce-scatter-boost
17:11:48  773/1072 Test  #774: tesh-smpi-coll-reduce-scatter-boost .........................   Passed    0.11 sec
17:11:48           Start  775: tesh-smpi-coll-reduce-scatter-raw
17:11:48  774/1072 Test  #773: tesh-smpi-coll-reduce-scatter-thread ........................   Passed    0.12 sec
17:11:48           Start  776: tesh-smpi-coll-reduce-scatter-ucontext
17:11:49  775/1072 Test  #775: tesh-smpi-coll-reduce-scatter-raw ...........................   Passed    0.10 sec
17:11:49           Start  777: tesh-smpi-coll-scatter-thread
17:11:49  776/1072 Test  #776: tesh-smpi-coll-reduce-scatter-ucontext ......................   Passed    0.10 sec
17:11:49           Start  778: tesh-smpi-coll-scatter-boost
17:11:49  777/1072 Test  #778: tesh-smpi-coll-scatter-boost ................................   Passed    0.11 sec
17:11:49           Start  779: tesh-smpi-coll-scatter-raw
17:11:49  778/1072 Test  #777: tesh-smpi-coll-scatter-thread ...............................   Passed    0.11 sec
17:11:49           Start  780: tesh-smpi-coll-scatter-ucontext
17:11:49  779/1072 Test  #780: tesh-smpi-coll-scatter-ucontext .............................   Passed    0.10 sec
17:11:49           Start  781: tesh-smpi-macro-sample-thread
17:11:49  780/1072 Test  #779: tesh-smpi-coll-scatter-raw ..................................   Passed    0.11 sec
17:11:49           Start  782: tesh-smpi-macro-sample-boost
17:11:49  781/1072 Test  #781: tesh-smpi-macro-sample-thread ...............................   Passed    0.58 sec
17:11:49           Start  783: tesh-smpi-macro-sample-raw
17:11:49  782/1072 Test  #782: tesh-smpi-macro-sample-boost ................................   Passed    0.60 sec
17:11:49           Start  784: tesh-smpi-macro-sample-ucontext
17:11:50  783/1072 Test  #783: tesh-smpi-macro-sample-raw ..................................   Passed    0.58 sec
17:11:50           Start  785: tesh-smpi-pt2pt-dsend-thread
17:11:50  784/1072 Test  #784: tesh-smpi-macro-sample-ucontext .............................   Passed    0.58 sec
17:11:50           Start  786: tesh-smpi-pt2pt-dsend-boost
17:11:50  785/1072 Test  #786: tesh-smpi-pt2pt-dsend-boost .................................   Passed    0.08 sec
17:11:50           Start  787: tesh-smpi-pt2pt-dsend-raw
17:11:50  786/1072 Test  #785: tesh-smpi-pt2pt-dsend-thread ................................   Passed    0.10 sec
17:11:50           Start  788: tesh-smpi-pt2pt-dsend-ucontext
17:11:50  787/1072 Test  #787: tesh-smpi-pt2pt-dsend-raw ...................................   Passed    0.09 sec
17:11:50           Start  789: tesh-smpi-pt2pt-pingpong-thread
17:11:50  788/1072 Test  #788: tesh-smpi-pt2pt-dsend-ucontext ..............................   Passed    0.08 sec
17:11:50           Start  790: tesh-smpi-pt2pt-pingpong-boost
17:11:50  789/1072 Test  #790: tesh-smpi-pt2pt-pingpong-boost ..............................   Passed    0.08 sec
17:11:50           Start  791: tesh-smpi-pt2pt-pingpong-raw
17:11:50  790/1072 Test  #789: tesh-smpi-pt2pt-pingpong-thread .............................   Passed    0.08 sec
17:11:50           Start  792: tesh-smpi-pt2pt-pingpong-ucontext
17:11:50  791/1072 Test  #791: tesh-smpi-pt2pt-pingpong-raw ................................   Passed    0.06 sec
17:11:50           Start  793: tesh-smpi-type-hvector-thread
17:11:50  792/1072 Test  #792: tesh-smpi-pt2pt-pingpong-ucontext ...........................   Passed    0.07 sec
17:11:50           Start  794: tesh-smpi-type-hvector-boost
17:11:50  793/1072 Test  #794: tesh-smpi-type-hvector-boost ................................   Passed    0.07 sec
17:11:50           Start  795: tesh-smpi-type-hvector-raw
17:11:50  794/1072 Test  #793: tesh-smpi-type-hvector-thread ...............................   Passed    0.07 sec
17:11:50           Start  796: tesh-smpi-type-hvector-ucontext
17:11:50  795/1072 Test  #795: tesh-smpi-type-hvector-raw ..................................   Passed    0.07 sec
17:11:50           Start  797: tesh-smpi-type-indexed-thread
17:11:50  796/1072 Test  #796: tesh-smpi-type-hvector-ucontext .............................   Passed    0.07 sec
17:11:50           Start  798: tesh-smpi-type-indexed-boost
17:11:50  797/1072 Test  #798: tesh-smpi-type-indexed-boost ................................   Passed    0.07 sec
17:11:50           Start  799: tesh-smpi-type-indexed-raw
17:11:50  798/1072 Test  #797: tesh-smpi-type-indexed-thread ...............................   Passed    0.08 sec
17:11:50           Start  800: tesh-smpi-type-indexed-ucontext
17:11:51  799/1072 Test  #799: tesh-smpi-type-indexed-raw ..................................   Passed    0.07 sec
17:11:51           Start  801: tesh-smpi-type-struct-thread
17:11:51  800/1072 Test  #800: tesh-smpi-type-indexed-ucontext .............................   Passed    0.07 sec
17:11:51           Start  802: tesh-smpi-type-struct-boost
17:11:51  801/1072 Test  #802: tesh-smpi-type-struct-boost .................................   Passed    0.07 sec
17:11:51           Start  803: tesh-smpi-type-struct-raw
17:11:51  802/1072 Test  #801: tesh-smpi-type-struct-thread ................................   Passed    0.08 sec
17:11:51           Start  804: tesh-smpi-type-struct-ucontext
17:11:51  803/1072 Test  #803: tesh-smpi-type-struct-raw ...................................   Passed    0.06 sec
17:11:51           Start  805: tesh-smpi-type-vector-thread
17:11:51  804/1072 Test  #804: tesh-smpi-type-struct-ucontext ..............................   Passed    0.06 sec
17:11:51           Start  806: tesh-smpi-type-vector-boost
17:11:51  805/1072 Test  #806: tesh-smpi-type-vector-boost .................................   Passed    0.08 sec
17:11:51           Start  807: tesh-smpi-type-vector-raw
17:11:51  806/1072 Test  #805: tesh-smpi-type-vector-thread ................................   Passed    0.08 sec
17:11:51           Start  808: tesh-smpi-type-vector-ucontext
17:11:51  807/1072 Test  #807: tesh-smpi-type-vector-raw ...................................   Passed    0.07 sec
17:11:51           Start  809: tesh-smpi-bug-17132-thread
17:11:51  808/1072 Test  #808: tesh-smpi-type-vector-ucontext ..............................   Passed    0.06 sec
17:11:51           Start  810: tesh-smpi-bug-17132-boost
17:11:51  809/1072 Test  #810: tesh-smpi-bug-17132-boost ...................................   Passed    0.08 sec
17:11:51           Start  811: tesh-smpi-bug-17132-raw
17:11:51  810/1072 Test  #809: tesh-smpi-bug-17132-thread ..................................   Passed    0.09 sec
17:11:51           Start  812: tesh-smpi-bug-17132-ucontext
17:11:51  811/1072 Test  #811: tesh-smpi-bug-17132-raw .....................................   Passed    0.08 sec
17:11:51           Start  813: tesh-smpi-timers-thread
17:11:51  812/1072 Test  #812: tesh-smpi-bug-17132-ucontext ................................   Passed    0.07 sec
17:11:51           Start  814: tesh-smpi-timers-boost
17:11:51  813/1072 Test  #814: tesh-smpi-timers-boost ......................................   Passed    0.06 sec
17:11:51           Start  815: tesh-smpi-timers-raw
17:11:51  814/1072 Test  #813: tesh-smpi-timers-thread .....................................   Passed    0.08 sec
17:11:51           Start  816: tesh-smpi-timers-ucontext
17:11:51  815/1072 Test  #816: tesh-smpi-timers-ucontext ...................................   Passed    0.06 sec
17:11:51           Start  817: tesh-smpi-io-simple-thread
17:11:51  816/1072 Test  #815: tesh-smpi-timers-raw ........................................   Passed    0.06 sec
17:11:51           Start  818: tesh-smpi-io-simple-boost
17:11:51  817/1072 Test  #818: tesh-smpi-io-simple-boost ...................................   Passed    0.07 sec
17:11:51           Start  819: tesh-smpi-io-simple-raw
17:11:51  818/1072 Test  #817: tesh-smpi-io-simple-thread ..................................   Passed    0.07 sec
17:11:51           Start  820: tesh-smpi-io-simple-ucontext
17:11:51  819/1072 Test  #819: tesh-smpi-io-simple-raw .....................................   Passed    0.07 sec
17:11:51           Start  821: tesh-smpi-io-simple-at-thread
17:11:51  820/1072 Test  #820: tesh-smpi-io-simple-ucontext ................................   Passed    0.07 sec
17:11:51           Start  822: tesh-smpi-io-simple-at-boost
17:11:51  821/1072 Test  #822: tesh-smpi-io-simple-at-boost ................................   Passed    0.07 sec
17:11:51           Start  823: tesh-smpi-io-simple-at-raw
17:11:51  822/1072 Test  #821: tesh-smpi-io-simple-at-thread ...............................   Passed    0.08 sec
17:11:51           Start  824: tesh-smpi-io-simple-at-ucontext
17:11:51  823/1072 Test  #823: tesh-smpi-io-simple-at-raw ..................................   Passed    0.07 sec
17:11:51           Start  825: tesh-smpi-io-all-thread
17:11:51  824/1072 Test  #824: tesh-smpi-io-simple-at-ucontext .............................   Passed    0.07 sec
17:11:51           Start  826: tesh-smpi-io-all-boost
17:11:51  825/1072 Test  #826: tesh-smpi-io-all-boost ......................................   Passed    0.07 sec
17:11:51           Start  827: tesh-smpi-io-all-raw
17:11:51  826/1072 Test  #825: tesh-smpi-io-all-thread .....................................   Passed    0.08 sec
17:11:51           Start  828: tesh-smpi-io-all-ucontext
17:11:52  827/1072 Test  #827: tesh-smpi-io-all-raw ........................................   Passed    0.07 sec
17:11:52           Start  829: tesh-smpi-io-all-at-thread
17:11:52  828/1072 Test  #828: tesh-smpi-io-all-ucontext ...................................   Passed    0.07 sec
17:11:52           Start  830: tesh-smpi-io-all-at-boost
17:11:52  829/1072 Test  #830: tesh-smpi-io-all-at-boost ...................................   Passed    0.07 sec
17:11:52           Start  831: tesh-smpi-io-all-at-raw
17:11:52  830/1072 Test  #829: tesh-smpi-io-all-at-thread ..................................   Passed    0.09 sec
17:11:52           Start  832: tesh-smpi-io-all-at-ucontext
17:11:52  831/1072 Test  #831: tesh-smpi-io-all-at-raw .....................................   Passed    0.07 sec
17:11:52           Start  833: tesh-smpi-io-shared-thread
17:11:52  832/1072 Test  #832: tesh-smpi-io-all-at-ucontext ................................   Passed    0.07 sec
17:11:52           Start  834: tesh-smpi-io-shared-boost
17:11:52  833/1072 Test  #834: tesh-smpi-io-shared-boost ...................................   Passed    0.07 sec
17:11:52           Start  835: tesh-smpi-io-shared-raw
17:11:52  834/1072 Test  #833: tesh-smpi-io-shared-thread ..................................   Passed    0.08 sec
17:11:52           Start  836: tesh-smpi-io-shared-ucontext
17:11:52  835/1072 Test  #835: tesh-smpi-io-shared-raw .....................................   Passed    0.07 sec
17:11:52           Start  837: tesh-smpi-io-ordered-thread
17:11:52  836/1072 Test  #836: tesh-smpi-io-shared-ucontext ................................   Passed    0.06 sec
17:11:52           Start  838: tesh-smpi-io-ordered-boost
17:11:52  837/1072 Test  #838: tesh-smpi-io-ordered-boost ..................................   Passed    0.07 sec
17:11:52           Start  839: tesh-smpi-io-ordered-raw
17:11:52  838/1072 Test  #837: tesh-smpi-io-ordered-thread .................................   Passed    0.08 sec
17:11:52           Start  840: tesh-smpi-io-ordered-ucontext
17:11:52  839/1072 Test  #839: tesh-smpi-io-ordered-raw ....................................   Passed    0.07 sec
17:11:52           Start  841: tesh-smpi-topo-cart-sub-thread
17:11:52  840/1072 Test  #840: tesh-smpi-io-ordered-ucontext ...............................   Passed    0.07 sec
17:11:52           Start  842: tesh-smpi-topo-cart-sub-boost
17:11:52  841/1072 Test  #842: tesh-smpi-topo-cart-sub-boost ...............................   Passed    0.06 sec
17:11:52           Start  843: tesh-smpi-topo-cart-sub-raw
17:11:52  842/1072 Test  #841: tesh-smpi-topo-cart-sub-thread ..............................   Passed    0.07 sec
17:11:52           Start  844: tesh-smpi-topo-cart-sub-ucontext
17:11:52  843/1072 Test  #843: tesh-smpi-topo-cart-sub-raw .................................   Passed    0.07 sec
17:11:52           Start  845: tesh-smpi-fort_args-thread
17:11:52  844/1072 Test  #844: tesh-smpi-topo-cart-sub-ucontext ............................   Passed    0.06 sec
17:11:52           Start  846: tesh-smpi-fort_args-boost
17:11:52  845/1072 Test  #845: tesh-smpi-fort_args-thread ..................................   Passed    0.07 sec
17:11:52           Start  847: tesh-smpi-fort_args-raw
17:11:52  846/1072 Test  #846: tesh-smpi-fort_args-boost ...................................   Passed    0.07 sec
17:11:52           Start  848: tesh-smpi-fort_args-ucontext
17:11:52  847/1072 Test  #848: tesh-smpi-fort_args-ucontext ................................   Passed    0.06 sec
17:11:52           Start  849: tesh-smpi-coll-allgather-2dmesh
17:11:52  848/1072 Test  #847: tesh-smpi-fort_args-raw .....................................   Passed    0.07 sec
17:11:52           Start  850: tesh-smpi-coll-allgather-3dmesh
17:11:52  849/1072 Test  #849: tesh-smpi-coll-allgather-2dmesh .............................   Passed    0.10 sec
17:11:52           Start  851: tesh-smpi-coll-allgather-bruck
17:11:52  850/1072 Test  #850: tesh-smpi-coll-allgather-3dmesh .............................   Passed    0.10 sec
17:11:52           Start  852: tesh-smpi-coll-allgather-GB
17:11:52  851/1072 Test  #851: tesh-smpi-coll-allgather-bruck ..............................   Passed    0.10 sec
17:11:52           Start  853: tesh-smpi-coll-allgather-loosely_lr
17:11:52  852/1072 Test  #852: tesh-smpi-coll-allgather-GB .................................   Passed    0.10 sec
17:11:52           Start  854: tesh-smpi-coll-allgather-NTSLR
17:11:53  853/1072 Test  #854: tesh-smpi-coll-allgather-NTSLR ..............................   Passed    0.10 sec
17:11:53           Start  855: tesh-smpi-coll-allgather-NTSLR_NB
17:11:53  854/1072 Test  #853: tesh-smpi-coll-allgather-loosely_lr .........................   Passed    0.11 sec
17:11:53           Start  856: tesh-smpi-coll-allgather-pair
17:11:53  855/1072 Test  #855: tesh-smpi-coll-allgather-NTSLR_NB ...........................   Passed    0.11 sec
17:11:53           Start  857: tesh-smpi-coll-allgather-rdb
17:11:53  856/1072 Test  #856: tesh-smpi-coll-allgather-pair ...............................   Passed    0.10 sec
17:11:53           Start  858: tesh-smpi-coll-allgather-rhv
17:11:53  857/1072 Test  #857: tesh-smpi-coll-allgather-rdb ................................   Passed    0.10 sec
17:11:53           Start  859: tesh-smpi-coll-allgather-ring
17:11:53  858/1072 Test  #858: tesh-smpi-coll-allgather-rhv ................................   Passed    0.10 sec
17:11:53           Start  860: tesh-smpi-coll-allgather-SMP_NTS
17:11:53  859/1072 Test  #859: tesh-smpi-coll-allgather-ring ...............................   Passed    0.10 sec
17:11:53           Start  861: tesh-smpi-coll-allgather-smp_simple
17:11:53  860/1072 Test  #860: tesh-smpi-coll-allgather-SMP_NTS ............................   Passed    0.10 sec
17:11:53           Start  862: tesh-smpi-coll-allgather-spreading_simple
17:11:53  861/1072 Test  #862: tesh-smpi-coll-allgather-spreading_simple ...................   Passed    0.09 sec
17:11:53           Start  863: tesh-smpi-coll-allgather-ompi
17:11:53  862/1072 Test  #861: tesh-smpi-coll-allgather-smp_simple .........................   Passed    0.10 sec
17:11:53           Start  864: tesh-smpi-coll-allgather-mpich
17:11:53  863/1072 Test  #863: tesh-smpi-coll-allgather-ompi ...............................   Passed    0.09 sec
17:11:53           Start  865: tesh-smpi-coll-allgather-ompi_neighborexchange
17:11:53  864/1072 Test  #864: tesh-smpi-coll-allgather-mpich ..............................   Passed    0.09 sec
17:11:53           Start  866: tesh-smpi-coll-allgather-mvapich2
17:11:53  865/1072 Test  #865: tesh-smpi-coll-allgather-ompi_neighborexchange ..............   Passed    0.09 sec
17:11:53           Start  867: tesh-smpi-coll-allgather-mvapich2_smp
17:11:53  866/1072 Test  #866: tesh-smpi-coll-allgather-mvapich2 ...........................   Passed    0.10 sec
17:11:53           Start  868: tesh-smpi-coll-allgather-impi
17:11:53  867/1072 Test  #867: tesh-smpi-coll-allgather-mvapich2_smp .......................   Passed    0.10 sec
17:11:53           Start  869: tesh-smpi-coll-allgatherv-GB
17:11:53  868/1072 Test  #868: tesh-smpi-coll-allgather-impi ...............................   Passed    0.09 sec
17:11:53           Start  870: tesh-smpi-coll-allgatherv-pair
17:11:53  869/1072 Test  #870: tesh-smpi-coll-allgatherv-pair ..............................   Passed    0.10 sec
17:11:53           Start  871: tesh-smpi-coll-allgatherv-ring
17:11:53  870/1072 Test  #869: tesh-smpi-coll-allgatherv-GB ................................   Passed    0.11 sec
17:11:53           Start  872: tesh-smpi-coll-allgatherv-ompi
17:11:53  871/1072 Test  #872: tesh-smpi-coll-allgatherv-ompi ..............................   Passed    0.09 sec
17:11:53           Start  873: tesh-smpi-coll-allgatherv-mpich
17:11:53  872/1072 Test  #871: tesh-smpi-coll-allgatherv-ring ..............................   Passed    0.10 sec
17:11:53           Start  874: tesh-smpi-coll-allgatherv-ompi_neighborexchange
17:11:54  873/1072 Test  #874: tesh-smpi-coll-allgatherv-ompi_neighborexchange .............   Passed    0.09 sec
17:11:54           Start  875: tesh-smpi-coll-allgatherv-ompi_bruck
17:11:54  874/1072 Test  #873: tesh-smpi-coll-allgatherv-mpich .............................   Passed    0.10 sec
17:11:54           Start  876: tesh-smpi-coll-allgatherv-mpich_rdb
17:11:54  875/1072 Test  #875: tesh-smpi-coll-allgatherv-ompi_bruck ........................   Passed    0.09 sec
17:11:54           Start  877: tesh-smpi-coll-allgatherv-mpich_ring
17:11:54  876/1072 Test  #876: tesh-smpi-coll-allgatherv-mpich_rdb .........................   Passed    0.10 sec
17:11:54           Start  878: tesh-smpi-coll-allgatherv-mvapich2
17:11:54  877/1072 Test  #877: tesh-smpi-coll-allgatherv-mpich_ring ........................   Passed    0.10 sec
17:11:54           Start  879: tesh-smpi-coll-allgatherv-impi
17:11:54  878/1072 Test  #878: tesh-smpi-coll-allgatherv-mvapich2 ..........................   Passed    0.10 sec
17:11:54           Start  880: tesh-smpi-coll-allreduce-lr
17:11:54  879/1072 Test  #880: tesh-smpi-coll-allreduce-lr .................................   Passed    0.10 sec
17:11:54           Start  881: tesh-smpi-coll-allreduce-rab1
17:11:54  880/1072 Test  #879: tesh-smpi-coll-allgatherv-impi ..............................   Passed    0.10 sec
17:11:54           Start  882: tesh-smpi-coll-allreduce-rab2
17:11:54  881/1072 Test  #881: tesh-smpi-coll-allreduce-rab1 ...............................   Passed    0.09 sec
17:11:54           Start  883: tesh-smpi-coll-allreduce-rab_rdb
17:11:54  882/1072 Test  #882: tesh-smpi-coll-allreduce-rab2 ...............................   Passed    0.09 sec
17:11:54           Start  884: tesh-smpi-coll-allreduce-rdb
17:11:54  883/1072 Test  #884: tesh-smpi-coll-allreduce-rdb ................................   Passed    0.09 sec
17:11:54           Start  885: tesh-smpi-coll-allreduce-smp_binomial
17:11:54  884/1072 Test  #883: tesh-smpi-coll-allreduce-rab_rdb ............................   Passed    0.09 sec
17:11:54           Start  886: tesh-smpi-coll-allreduce-smp_binomial_pipeline
17:11:54  885/1072 Test  #886: tesh-smpi-coll-allreduce-smp_binomial_pipeline ..............   Passed    0.09 sec
17:11:54           Start  887: tesh-smpi-coll-allreduce-smp_rdb
17:11:54  886/1072 Test  #885: tesh-smpi-coll-allreduce-smp_binomial .......................   Passed    0.10 sec
17:11:54           Start  888: tesh-smpi-coll-allreduce-smp_rsag
17:11:54  887/1072 Test  #887: tesh-smpi-coll-allreduce-smp_rdb ............................   Passed    0.10 sec
17:11:54           Start  889: tesh-smpi-coll-allreduce-smp_rsag_lr
17:11:54  888/1072 Test  #888: tesh-smpi-coll-allreduce-smp_rsag ...........................   Passed    0.10 sec
17:11:54           Start  890: tesh-smpi-coll-allreduce-impi
17:11:54  889/1072 Test  #890: tesh-smpi-coll-allreduce-impi ...............................   Passed    0.09 sec
17:11:54           Start  891: tesh-smpi-coll-allreduce-smp_rsag_rab
17:11:54  890/1072 Test  #889: tesh-smpi-coll-allreduce-smp_rsag_lr ........................   Passed    0.10 sec
17:11:54           Start  892: tesh-smpi-coll-allreduce-redbcast
17:11:54  891/1072 Test  #892: tesh-smpi-coll-allreduce-redbcast ...........................   Passed    0.09 sec
17:11:54           Start  893: tesh-smpi-coll-allreduce-ompi
17:11:54  892/1072 Test  #891: tesh-smpi-coll-allreduce-smp_rsag_rab .......................   Passed    0.10 sec
17:11:54           Start  894: tesh-smpi-coll-allreduce-mpich
17:11:54  893/1072 Test  #893: tesh-smpi-coll-allreduce-ompi ...............................   Passed    0.09 sec
17:11:54           Start  895: tesh-smpi-coll-allreduce-ompi_ring_segmented
17:11:54  894/1072 Test  #894: tesh-smpi-coll-allreduce-mpich ..............................   Passed    0.09 sec
17:11:54           Start  896: tesh-smpi-coll-allreduce-mvapich2
17:11:55  895/1072 Test  #896: tesh-smpi-coll-allreduce-mvapich2 ...........................   Passed    0.09 sec
17:11:55           Start  897: tesh-smpi-coll-allreduce-mvapich2_rs
17:11:55  896/1072 Test  #895: tesh-smpi-coll-allreduce-ompi_ring_segmented ................   Passed    0.10 sec
17:11:55           Start  898: tesh-smpi-coll-allreduce-mvapich2_two_level
17:11:55  897/1072 Test  #897: tesh-smpi-coll-allreduce-mvapich2_rs ........................   Passed    0.09 sec
17:11:55           Start  899: tesh-smpi-coll-alltoall-2dmesh
17:11:55  898/1072 Test  #898: tesh-smpi-coll-allreduce-mvapich2_two_level .................   Passed    0.09 sec
17:11:55           Start  900: tesh-smpi-coll-alltoall-3dmesh
17:11:55  899/1072 Test  #899: tesh-smpi-coll-alltoall-2dmesh ..............................   Passed    0.10 sec
17:11:55           Start  901: tesh-smpi-coll-alltoall-pair
17:11:55  900/1072 Test  #900: tesh-smpi-coll-alltoall-3dmesh ..............................   Passed    0.09 sec
17:11:55           Start  902: tesh-smpi-coll-alltoall-pair_rma
17:11:55  901/1072 Test  #901: tesh-smpi-coll-alltoall-pair ................................   Passed    0.09 sec
17:11:55           Start  903: tesh-smpi-coll-alltoall-pair_one_barrier
17:11:55  902/1072 Test  #902: tesh-smpi-coll-alltoall-pair_rma ............................   Passed    0.10 sec
17:11:55           Start  904: tesh-smpi-coll-alltoall-pair_light_barrier
17:11:55  903/1072 Test  #903: tesh-smpi-coll-alltoall-pair_one_barrier ....................   Passed    0.10 sec
17:11:55           Start  905: tesh-smpi-coll-alltoall-pair_mpi_barrier
17:11:55  904/1072 Test  #904: tesh-smpi-coll-alltoall-pair_light_barrier ..................   Passed    0.10 sec
17:11:55           Start  906: tesh-smpi-coll-alltoall-rdb
17:11:55  905/1072 Test  #906: tesh-smpi-coll-alltoall-rdb .................................   Passed    0.09 sec
17:11:55           Start  907: tesh-smpi-coll-alltoall-ring
17:11:55  906/1072 Test  #905: tesh-smpi-coll-alltoall-pair_mpi_barrier ....................   Passed    0.10 sec
17:11:55           Start  908: tesh-smpi-coll-alltoall-ring_light_barrier
17:11:55  907/1072 Test  #907: tesh-smpi-coll-alltoall-ring ................................   Passed    0.10 sec
17:11:55           Start  909: tesh-smpi-coll-alltoall-ring_mpi_barrier
17:11:55  908/1072 Test  #908: tesh-smpi-coll-alltoall-ring_light_barrier ..................   Passed    0.09 sec
17:11:55           Start  910: tesh-smpi-coll-alltoall-ring_one_barrier
17:11:55  909/1072 Test  #910: tesh-smpi-coll-alltoall-ring_one_barrier ....................   Passed    0.10 sec
17:11:55           Start  911: tesh-smpi-coll-alltoall-bruck
17:11:55  910/1072 Test  #909: tesh-smpi-coll-alltoall-ring_mpi_barrier ....................   Passed    0.10 sec
17:11:55           Start  912: tesh-smpi-coll-alltoall-basic_linear
17:11:55  911/1072 Test  #911: tesh-smpi-coll-alltoall-bruck ...............................   Passed    0.11 sec
17:11:55           Start  913: tesh-smpi-coll-alltoall-ompi
17:11:55  912/1072 Test  #912: tesh-smpi-coll-alltoall-basic_linear ........................   Passed    0.11 sec
17:11:55           Start  914: tesh-smpi-coll-alltoall-mpich
17:11:55  913/1072 Test  #914: tesh-smpi-coll-alltoall-mpich ...............................   Passed    0.09 sec
17:11:55           Start  915: tesh-smpi-coll-alltoall-mvapich2
17:11:55  914/1072 Test  #913: tesh-smpi-coll-alltoall-ompi ................................   Passed    0.10 sec
17:11:55           Start  916: tesh-smpi-coll-alltoall-mvapich2_scatter_dest
17:11:56  915/1072 Test  #915: tesh-smpi-coll-alltoall-mvapich2 ............................   Passed    0.10 sec
17:11:56           Start  917: tesh-smpi-coll-alltoall-impi
17:11:56  916/1072 Test  #916: tesh-smpi-coll-alltoall-mvapich2_scatter_dest ...............   Passed    0.10 sec
17:11:56           Start  918: tesh-smpi-coll-alltoallv-pair
17:11:56  917/1072 Test  #917: tesh-smpi-coll-alltoall-impi ................................   Passed    0.10 sec
17:11:56           Start  919: tesh-smpi-coll-alltoallv-pair_light_barrier
17:11:56  918/1072 Test  #918: tesh-smpi-coll-alltoallv-pair ...............................   Passed    0.10 sec
17:11:56           Start  920: tesh-smpi-coll-alltoallv-pair_mpi_barrier
17:11:56  919/1072 Test  #919: tesh-smpi-coll-alltoallv-pair_light_barrier .................   Passed    0.10 sec
17:11:56           Start  921: tesh-smpi-coll-alltoallv-pair_one_barrier
17:11:56  920/1072 Test  #920: tesh-smpi-coll-alltoallv-pair_mpi_barrier ...................   Passed    0.10 sec
17:11:56           Start  922: tesh-smpi-coll-alltoallv-ring
17:11:56  921/1072 Test  #922: tesh-smpi-coll-alltoallv-ring ...............................   Passed    0.10 sec
17:11:56           Start  923: tesh-smpi-coll-alltoallv-ring_light_barrier
17:11:56  922/1072 Test  #921: tesh-smpi-coll-alltoallv-pair_one_barrier ...................   Passed    0.10 sec
17:11:56           Start  924: tesh-smpi-coll-alltoallv-ring_mpi_barrier
17:11:56  923/1072 Test  #923: tesh-smpi-coll-alltoallv-ring_light_barrier .................   Passed    0.10 sec
17:11:56           Start  925: tesh-smpi-coll-alltoallv-ring_one_barrier
17:11:56  924/1072 Test  #924: tesh-smpi-coll-alltoallv-ring_mpi_barrier ...................   Passed    0.11 sec
17:11:56           Start  926: tesh-smpi-coll-alltoallv-bruck
17:11:56  925/1072 Test  #925: tesh-smpi-coll-alltoallv-ring_one_barrier ...................   Passed    0.10 sec
17:11:56           Start  927: tesh-smpi-coll-alltoallv-ompi
17:11:56  926/1072 Test  #926: tesh-smpi-coll-alltoallv-bruck ..............................   Passed    0.10 sec
17:11:56           Start  928: tesh-smpi-coll-alltoallv-mpich
17:11:56  927/1072 Test  #928: tesh-smpi-coll-alltoallv-mpich ..............................   Passed    0.10 sec
17:11:56           Start  929: tesh-smpi-coll-alltoallv-mvapich2
17:11:56  928/1072 Test  #927: tesh-smpi-coll-alltoallv-ompi ...............................   Passed    0.10 sec
17:11:56           Start  930: tesh-smpi-coll-alltoallv-ompi_basic_linear
17:11:56  929/1072 Test  #929: tesh-smpi-coll-alltoallv-mvapich2 ...........................   Passed    0.10 sec
17:11:56           Start  931: tesh-smpi-coll-alltoallv-impi
17:11:56  930/1072 Test  #930: tesh-smpi-coll-alltoallv-ompi_basic_linear ..................   Passed    0.10 sec
17:11:56           Start  932: tesh-smpi-coll-barrier-ompi
17:11:56  931/1072 Test  #932: tesh-smpi-coll-barrier-ompi .................................   Passed    0.09 sec
17:11:56           Start  933: tesh-smpi-coll-barrier-mpich
17:11:56  932/1072 Test  #931: tesh-smpi-coll-alltoallv-impi ...............................   Passed    0.10 sec
17:11:56           Start  934: tesh-smpi-coll-barrier-mpich_smp
17:11:56  933/1072 Test  #933: tesh-smpi-coll-barrier-mpich ................................   Passed    0.10 sec
17:11:56           Start  935: tesh-smpi-coll-barrier-ompi_basic_linear
17:11:56  934/1072 Test  #934: tesh-smpi-coll-barrier-mpich_smp ............................   Passed    0.10 sec
17:11:56           Start  936: tesh-smpi-coll-barrier-ompi_tree
17:11:57  935/1072 Test  #935: tesh-smpi-coll-barrier-ompi_basic_linear ....................   Passed    0.10 sec
17:11:57           Start  937: tesh-smpi-coll-barrier-ompi_bruck
17:11:57  936/1072 Test  #936: tesh-smpi-coll-barrier-ompi_tree ............................   Passed    0.09 sec
17:11:57           Start  938: tesh-smpi-coll-barrier-ompi_recursivedoubling
17:11:57  937/1072 Test  #938: tesh-smpi-coll-barrier-ompi_recursivedoubling ...............   Passed    0.09 sec
17:11:57           Start  939: tesh-smpi-coll-barrier-ompi_doublering
17:11:57  938/1072 Test  #937: tesh-smpi-coll-barrier-ompi_bruck ...........................   Passed    0.10 sec
17:11:57           Start  940: tesh-smpi-coll-barrier-mvapich2_pair
17:11:57  939/1072 Test  #940: tesh-smpi-coll-barrier-mvapich2_pair ........................   Passed    0.09 sec
17:11:57           Start  941: tesh-smpi-coll-barrier-mvapich2
17:11:57  940/1072 Test  #939: tesh-smpi-coll-barrier-ompi_doublering ......................   Passed    0.10 sec
17:11:57           Start  942: tesh-smpi-coll-barrier-impi
17:11:57  941/1072 Test  #941: tesh-smpi-coll-barrier-mvapich2 .............................   Passed    0.10 sec
17:11:57           Start  943: tesh-smpi-coll-bcast-arrival_pattern_aware
17:11:57  942/1072 Test  #942: tesh-smpi-coll-barrier-impi .................................   Passed    0.10 sec
17:11:57           Start  944: tesh-smpi-coll-bcast-arrival_pattern_aware_wait
17:11:57  943/1072 Test  #944: tesh-smpi-coll-bcast-arrival_pattern_aware_wait .............   Passed    0.09 sec
17:11:57           Start  945: tesh-smpi-coll-bcast-arrival_scatter
17:11:57  944/1072 Test  #943: tesh-smpi-coll-bcast-arrival_pattern_aware ..................   Passed    0.10 sec
17:11:57           Start  946: tesh-smpi-coll-bcast-binomial_tree
17:11:57  945/1072 Test  #946: tesh-smpi-coll-bcast-binomial_tree ..........................   Passed    0.09 sec
17:11:57           Start  947: tesh-smpi-coll-bcast-flattree
17:11:57  946/1072 Test  #945: tesh-smpi-coll-bcast-arrival_scatter ........................   Passed    0.10 sec
17:11:57           Start  948: tesh-smpi-coll-bcast-flattree_pipeline
17:11:57  947/1072 Test  #947: tesh-smpi-coll-bcast-flattree ...............................   Passed    0.10 sec
17:11:57           Start  949: tesh-smpi-coll-bcast-NTSB
17:11:57  948/1072 Test  #948: tesh-smpi-coll-bcast-flattree_pipeline ......................   Passed    0.10 sec
17:11:57           Start  950: tesh-smpi-coll-bcast-NTSL
17:11:57  949/1072 Test  #950: tesh-smpi-coll-bcast-NTSL ...................................   Passed    0.09 sec
17:11:57           Start  951: tesh-smpi-coll-bcast-NTSL_Isend
17:11:57  950/1072 Test  #949: tesh-smpi-coll-bcast-NTSB ...................................   Passed    0.10 sec
17:11:57           Start  952: tesh-smpi-coll-bcast-scatter_LR_allgather
17:11:57  951/1072 Test  #951: tesh-smpi-coll-bcast-NTSL_Isend .............................   Passed    0.11 sec
17:11:57           Start  953: tesh-smpi-coll-bcast-scatter_rdb_allgather
17:11:57  952/1072 Test  #952: tesh-smpi-coll-bcast-scatter_LR_allgather ...................   Passed    0.12 sec
17:11:57           Start  954: tesh-smpi-coll-bcast-SMP_binary
17:11:57  953/1072 Test  #953: tesh-smpi-coll-bcast-scatter_rdb_allgather ..................   Passed    0.11 sec
17:11:57           Start  955: tesh-smpi-coll-bcast-SMP_binomial
17:11:57  954/1072 Test  #954: tesh-smpi-coll-bcast-SMP_binary .............................   Passed    0.11 sec
17:11:57           Start  956: tesh-smpi-coll-bcast-SMP_linear
17:11:58  955/1072 Test  #955: tesh-smpi-coll-bcast-SMP_binomial ...........................   Passed    0.10 sec
17:11:58           Start  957: tesh-smpi-coll-bcast-ompi
17:11:58  956/1072 Test  #956: tesh-smpi-coll-bcast-SMP_linear .............................   Passed    0.10 sec
17:11:58           Start  958: tesh-smpi-coll-bcast-mpich
17:11:58  957/1072 Test  #957: tesh-smpi-coll-bcast-ompi ...................................   Passed    0.10 sec
17:11:58           Start  959: tesh-smpi-coll-bcast-ompi_split_bintree
17:11:58  958/1072 Test  #958: tesh-smpi-coll-bcast-mpich ..................................   Passed    0.10 sec
17:11:58           Start  960: tesh-smpi-coll-bcast-ompi_pipeline
17:11:58  959/1072 Test  #959: tesh-smpi-coll-bcast-ompi_split_bintree .....................   Passed    0.10 sec
17:11:58           Start  961: tesh-smpi-coll-bcast-mvapich2
17:11:58  960/1072 Test  #960: tesh-smpi-coll-bcast-ompi_pipeline ..........................   Passed    0.10 sec
17:11:58           Start  962: tesh-smpi-coll-bcast-mvapich2_intra_node
17:11:58  961/1072 Test  #962: tesh-smpi-coll-bcast-mvapich2_intra_node ....................   Passed    0.10 sec
17:11:58           Start  963: tesh-smpi-coll-bcast-mvapich2_knomial_intra_node
17:11:58  962/1072 Test  #961: tesh-smpi-coll-bcast-mvapich2 ...............................   Passed    0.11 sec
17:11:58           Start  964: tesh-smpi-coll-bcast-impi
17:11:58  963/1072 Test  #964: tesh-smpi-coll-bcast-impi ...................................   Passed    0.10 sec
17:11:58           Start  965: tesh-smpi-coll-gather-ompi
17:11:58  964/1072 Test  #963: tesh-smpi-coll-bcast-mvapich2_knomial_intra_node ............   Passed    0.11 sec
17:11:58           Start  966: tesh-smpi-coll-gather-mpich
17:11:58  965/1072 Test  #966: tesh-smpi-coll-gather-mpich .................................   Passed    0.09 sec
17:11:58           Start  967: tesh-smpi-coll-gather-ompi_basic_linear
17:11:58  966/1072 Test  #965: tesh-smpi-coll-gather-ompi ..................................   Passed    0.10 sec
17:11:58           Start  968: tesh-smpi-coll-gather-ompi_linear_sync
17:11:58  967/1072 Test  #967: tesh-smpi-coll-gather-ompi_basic_linear .....................   Passed    0.10 sec
17:11:58           Start  969: tesh-smpi-coll-gather-ompi_binomial
17:11:58  968/1072 Test  #968: tesh-smpi-coll-gather-ompi_linear_sync ......................   Passed    0.10 sec
17:11:58           Start  970: tesh-smpi-coll-gather-mvapich2
17:11:58  969/1072 Test  #969: tesh-smpi-coll-gather-ompi_binomial .........................   Passed    0.10 sec
17:11:58           Start  971: tesh-smpi-coll-gather-mvapich2_two_level
17:11:58  970/1072 Test  #970: tesh-smpi-coll-gather-mvapich2 ..............................   Passed    0.09 sec
17:11:58           Start  972: tesh-smpi-coll-gather-impi
17:11:58  971/1072 Test  #971: tesh-smpi-coll-gather-mvapich2_two_level ....................   Passed    0.10 sec
17:11:58           Start  973: tesh-smpi-coll-reduce-arrival_pattern_aware
17:11:58  972/1072 Test  #972: tesh-smpi-coll-gather-impi ..................................   Passed    0.10 sec
17:11:58           Start  974: tesh-smpi-coll-reduce-binomial
17:11:58  973/1072 Test  #974: tesh-smpi-coll-reduce-binomial ..............................   Passed    0.09 sec
17:11:58           Start  975: tesh-smpi-coll-reduce-flat_tree
17:11:58  974/1072 Test  #973: tesh-smpi-coll-reduce-arrival_pattern_aware .................   Passed    0.10 sec
17:11:58           Start  976: tesh-smpi-coll-reduce-NTSL
17:11:59  975/1072 Test  #975: tesh-smpi-coll-reduce-flat_tree .............................   Passed    0.09 sec
17:11:59           Start  977: tesh-smpi-coll-reduce-scatter_gather
17:11:59  976/1072 Test  #976: tesh-smpi-coll-reduce-NTSL ..................................   Passed    0.09 sec
17:11:59           Start  978: tesh-smpi-coll-reduce-ompi
17:11:59  977/1072 Test  #978: tesh-smpi-coll-reduce-ompi ..................................   Passed    0.09 sec
17:11:59           Start  979: tesh-smpi-coll-reduce-mpich
17:11:59  978/1072 Test  #977: tesh-smpi-coll-reduce-scatter_gather ........................   Passed    0.10 sec
17:11:59           Start  980: tesh-smpi-coll-reduce-ompi_chain
17:11:59  979/1072 Test  #980: tesh-smpi-coll-reduce-ompi_chain ............................   Passed    0.09 sec
17:11:59           Start  981: tesh-smpi-coll-reduce-ompi_binary
17:11:59  980/1072 Test  #979: tesh-smpi-coll-reduce-mpich .................................   Passed    0.10 sec
17:11:59           Start  982: tesh-smpi-coll-reduce-impi
17:11:59  981/1072 Test  #981: tesh-smpi-coll-reduce-ompi_binary ...........................   Passed    0.09 sec
17:11:59           Start  983: tesh-smpi-coll-reduce-ompi_basic_linear
17:11:59  982/1072 Test  #982: tesh-smpi-coll-reduce-impi ..................................   Passed    0.10 sec
17:11:59           Start  984: tesh-smpi-coll-reduce-ompi_binomial
17:11:59  983/1072 Test  #984: tesh-smpi-coll-reduce-ompi_binomial .........................   Passed    0.09 sec
17:11:59           Start  985: tesh-smpi-coll-reduce-ompi_in_order_binary
17:11:59  984/1072 Test  #983: tesh-smpi-coll-reduce-ompi_basic_linear .....................   Passed    0.10 sec
17:11:59           Start  986: tesh-smpi-coll-reduce-mvapich2
17:11:59  985/1072 Test  #985: tesh-smpi-coll-reduce-ompi_in_order_binary ..................   Passed    0.10 sec
17:11:59           Start  987: tesh-smpi-coll-reduce-mvapich2_knomial
17:11:59  986/1072 Test  #986: tesh-smpi-coll-reduce-mvapich2 ..............................   Passed    0.10 sec
17:11:59           Start  988: tesh-smpi-coll-reduce-mvapich2_two_level
17:11:59  987/1072 Test  #987: tesh-smpi-coll-reduce-mvapich2_knomial ......................   Passed    0.10 sec
17:11:59           Start  989: tesh-smpi-coll-reduce-rab
17:11:59  988/1072 Test  #988: tesh-smpi-coll-reduce-mvapich2_two_level ....................   Passed    0.10 sec
17:11:59           Start  990: tesh-smpi-coll-reduce-scatter-ompi
17:11:59  989/1072 Test  #990: tesh-smpi-coll-reduce-scatter-ompi ..........................   Passed    0.09 sec
17:11:59           Start  991: tesh-smpi-coll-reduce-scatter-mpich
17:11:59  990/1072 Test  #989: tesh-smpi-coll-reduce-rab ...................................   Passed    0.10 sec
17:11:59           Start  992: tesh-smpi-coll-reduce-scatter-ompi_basic_recursivehalving
17:11:59  991/1072 Test  #991: tesh-smpi-coll-reduce-scatter-mpich .........................   Passed    0.09 sec
17:11:59           Start  993: tesh-smpi-coll-reduce-scatter-ompi_ring
17:11:59  992/1072 Test  #992: tesh-smpi-coll-reduce-scatter-ompi_basic_recursivehalving ...   Passed    0.10 sec
17:11:59           Start  994: tesh-smpi-coll-reduce-scatter-ompi_butterfly
17:11:59  993/1072 Test  #994: tesh-smpi-coll-reduce-scatter-ompi_butterfly ................   Passed    0.10 sec
17:11:59           Start  995: tesh-smpi-coll-reduce-scatter-mpich_noncomm
17:11:59  994/1072 Test  #993: tesh-smpi-coll-reduce-scatter-ompi_ring .....................   Passed    0.10 sec
17:11:59           Start  996: tesh-smpi-coll-reduce-scatter-mpich_pair
17:12:00  995/1072 Test  #995: tesh-smpi-coll-reduce-scatter-mpich_noncomm .................   Passed    0.10 sec
17:12:00           Start  997: tesh-smpi-coll-reduce-scatter-mvapich2
17:12:00  996/1072 Test  #996: tesh-smpi-coll-reduce-scatter-mpich_pair ....................   Passed    0.10 sec
17:12:00           Start  998: tesh-smpi-coll-reduce-scatter-mpich_rdb
17:12:00  997/1072 Test  #997: tesh-smpi-coll-reduce-scatter-mvapich2 ......................   Passed    0.10 sec
17:12:00           Start  999: tesh-smpi-coll-reduce-scatter-impi
17:12:00  998/1072 Test  #998: tesh-smpi-coll-reduce-scatter-mpich_rdb .....................   Passed    0.10 sec
17:12:00           Start 1000: tesh-smpi-coll-scatter-ompi
17:12:00  999/1072 Test #1000: tesh-smpi-coll-scatter-ompi .................................   Passed    0.09 sec
17:12:00           Start 1001: tesh-smpi-coll-scatter-mpich
17:12:00 1000/1072 Test  #999: tesh-smpi-coll-reduce-scatter-impi ..........................   Passed    0.10 sec
17:12:00           Start 1002: tesh-smpi-coll-scatter-ompi_basic_linear
17:12:00 1001/1072 Test #1001: tesh-smpi-coll-scatter-mpich ................................   Passed    0.10 sec
17:12:00           Start 1003: tesh-smpi-coll-scatter-ompi_binomial
17:12:00 1002/1072 Test #1002: tesh-smpi-coll-scatter-ompi_basic_linear ....................   Passed    0.10 sec
17:12:00           Start 1004: tesh-smpi-coll-scatter-ompi_linear_nb
17:12:00 1003/1072 Test #1003: tesh-smpi-coll-scatter-ompi_binomial ........................   Passed    0.09 sec
17:12:00           Start 1005: tesh-smpi-coll-scatter-mvapich2
17:12:00 1004/1072 Test #1004: tesh-smpi-coll-scatter-ompi_linear_nb .......................   Passed    0.10 sec
17:12:00           Start 1006: tesh-smpi-coll-scatter-mvapich2_two_level_binomial
17:12:00 1005/1072 Test #1006: tesh-smpi-coll-scatter-mvapich2_two_level_binomial ..........   Passed    0.09 sec
17:12:00           Start 1007: tesh-smpi-coll-scatter-mvapich2_two_level_direct
17:12:00 1006/1072 Test #1005: tesh-smpi-coll-scatter-mvapich2 .............................   Passed    0.10 sec
17:12:00           Start 1008: tesh-smpi-coll-scatter-impi
17:12:00 1007/1072 Test #1008: tesh-smpi-coll-scatter-impi .................................   Passed    0.09 sec
17:12:00           Start 1009: tesh-smpi-coll-allreduce-large
17:12:00 1008/1072 Test #1007: tesh-smpi-coll-scatter-mvapich2_two_level_direct ............   Passed    0.10 sec
17:12:00           Start 1010: tesh-smpi-coll-allreduce-automatic
17:12:00 1009/1072 Test #1010: tesh-smpi-coll-allreduce-automatic ..........................   Passed    0.14 sec
17:12:00           Start 1011: tesh-smpi-cluster-types
17:12:00 1010/1072 Test #1009: tesh-smpi-coll-allreduce-large ..............................   Passed    0.14 sec
17:12:00           Start 1012: tesh-smpi-coll-allreduce-with-leaks
17:12:00 1011/1072 Test #1012: tesh-smpi-coll-allreduce-with-leaks .........................   Passed    0.11 sec
17:12:00           Start 1013: tesh-mc-smpi-coll-allreduce-with-leaks
17:12:01 1012/1072 Test #1013: tesh-mc-smpi-coll-allreduce-with-leaks ......................   Passed    0.24 sec
17:12:01           Start 1014: tesh-smpi-broken-thread
17:12:01 1013/1072 Test #1011: tesh-smpi-cluster-types .....................................   Passed    0.39 sec
17:12:01           Start 1015: tesh-smpi-replay-ti-tracing
17:12:01 1014/1072 Test #1014: tesh-smpi-broken-thread .....................................   Passed    0.18 sec
17:12:01           Start 1016: tesh-smpi-replay-ti-tracing-coll
17:12:01 1015/1072 Test #1015: tesh-smpi-replay-ti-tracing .................................   Passed    0.22 sec
17:12:01           Start 1017: tesh-smpi-gh-139-thread
17:12:01 1016/1072 Test #1017: tesh-smpi-gh-139-thread .....................................   Passed    0.08 sec
17:12:01           Start 1018: tesh-smpi-privatization-dlopen-thread
17:12:01 1017/1072 Test #1018: tesh-smpi-privatization-dlopen-thread .......................   Passed    0.10 sec
17:12:01           Start 1019: tesh-smpi-privatization-dlopen-boost
17:12:01 1018/1072 Test #1019: tesh-smpi-privatization-dlopen-boost ........................   Passed    0.08 sec
17:12:01           Start 1020: tesh-smpi-privatization-dlopen-raw
17:12:01 1019/1072 Test #1020: tesh-smpi-privatization-dlopen-raw ..........................   Passed    0.07 sec
17:12:01           Start 1021: tesh-smpi-privatization-dlopen-ucontext
17:12:01 1020/1072 Test #1016: tesh-smpi-replay-ti-tracing-coll ............................   Passed    0.45 sec
17:12:01           Start 1022: tesh-smpi-privatization-mmap-thread
17:12:01 1021/1072 Test #1021: tesh-smpi-privatization-dlopen-ucontext .....................   Passed    0.08 sec
17:12:01           Start 1023: tesh-smpi-privatization-mmap-boost
17:12:01 1022/1072 Test #1022: tesh-smpi-privatization-mmap-thread .........................   Passed    0.09 sec
17:12:01           Start 1024: tesh-smpi-privatization-mmap-raw
17:12:01 1023/1072 Test #1023: tesh-smpi-privatization-mmap-boost ..........................   Passed    0.08 sec
17:12:01           Start 1025: tesh-smpi-privatization-mmap-ucontext
17:12:01 1024/1072 Test #1024: tesh-smpi-privatization-mmap-raw ............................   Passed    0.08 sec
17:12:01           Start 1026: test-smpi-mpich3-thread-f77
17:12:01 1025/1072 Test #1025: tesh-smpi-privatization-mmap-ucontext .......................   Passed    0.08 sec
17:12:01           Start 1027: test-smpi-mpich3-thread-f90
17:12:04 1026/1072 Test #1027: test-smpi-mpich3-thread-f90 .................................   Passed    2.67 sec
17:12:04           Start 1028: test-smpi-mpich3-attr-raw
17:12:05 1027/1072 Test #1026: test-smpi-mpich3-thread-f77 .................................   Passed    3.31 sec
17:12:05           Start 1029: test-smpi-mpich3-coll-default
17:12:05 1028/1072 Test #1028: test-smpi-mpich3-attr-raw ...................................   Passed    0.91 sec
17:12:05           Start 1030: test-smpi-mpich3-coll-ompi-dlopen
17:12:17 1029/1072 Test #1029: test-smpi-mpich3-coll-default ...............................   Passed   12.46 sec
17:12:17           Start 1031: test-smpi-mpich3-coll-mpich-dlopen-boost
17:12:17 1030/1072 Test #1030: test-smpi-mpich3-coll-ompi-dlopen ...........................   Passed   12.15 sec
17:12:17           Start 1032: test-smpi-mpich3-coll-mvapich2-mmap-ucontext
17:12:29 1031/1072 Test #1031: test-smpi-mpich3-coll-mpich-dlopen-boost ....................   Passed   11.58 sec
17:12:29           Start 1033: test-smpi-mpich3-coll-impi-mmap-raw
17:12:36 1032/1072 Test #1032: test-smpi-mpich3-coll-mvapich2-mmap-ucontext ................   Passed   18.63 sec
17:12:36           Start 1034: test-smpi-mpich3-comm-raw
17:12:38 1033/1072 Test #1034: test-smpi-mpich3-comm-raw ...................................   Passed    2.03 sec
17:12:38           Start 1035: test-smpi-mpich3-datatype-raw
17:12:40 1034/1072 Test #1035: test-smpi-mpich3-datatype-raw ...............................   Passed    1.91 sec
17:12:40           Start 1036: test-smpi-mpich3-errhan-raw
17:12:40 1035/1072 Test #1036: test-smpi-mpich3-errhan-raw .................................   Passed    0.41 sec
17:12:40           Start 1037: test-smpi-mpich3-group-raw
17:12:41 1036/1072 Test #1037: test-smpi-mpich3-group-raw ..................................   Passed    1.06 sec
17:12:41           Start 1038: test-smpi-mpich3-info-raw
17:12:42 1037/1072 Test #1038: test-smpi-mpich3-info-raw ...................................   Passed    0.43 sec
17:12:42           Start 1039: test-smpi-mpich3-init-raw
17:12:42 1038/1072 Test #1039: test-smpi-mpich3-init-raw ...................................   Passed    0.36 sec
17:12:42           Start 1040: test-smpi-mpich3-io-raw
17:12:43 1039/1072 Test #1040: test-smpi-mpich3-io-raw .....................................   Passed    0.85 sec
17:12:43           Start 1041: test-smpi-mpich3-perf-raw
17:12:44 1040/1072 Test #1033: test-smpi-mpich3-coll-impi-mmap-raw .........................   Passed   15.64 sec
17:12:44           Start 1042: test-smpi-mpich3-pt2pt-raw
17:12:45 1041/1072 Test #1041: test-smpi-mpich3-perf-raw ...................................   Passed    2.15 sec
17:12:45           Start 1043: test-smpi-mpich3-rma-raw
17:12:52 1042/1072 Test #1042: test-smpi-mpich3-pt2pt-raw ..................................   Passed    7.09 sec
17:12:52           Start 1044: test-smpi-mpich3-topo-raw
17:12:52 1043/1072 Test #1044: test-smpi-mpich3-topo-raw ...................................   Passed    0.26 sec
17:12:52           Start 1045: tesh-xbt-cmdline
17:12:52 1044/1072 Test #1045: tesh-xbt-cmdline ............................................   Passed    0.06 sec
17:12:52           Start 1046: tesh-xbt-log_large
17:12:52 1045/1072 Test #1046: tesh-xbt-log_large ..........................................   Passed    0.08 sec
17:12:52           Start 1047: tesh-xbt-parallel_log_crashtest
17:12:52 1046/1072 Test #1047: tesh-xbt-parallel_log_crashtest .............................   Passed    0.15 sec
17:12:52           Start 1048: tesh-xbt-parmap_test
17:12:53 1047/1072 Test #1048: tesh-xbt-parmap_test ........................................   Passed    0.57 sec
17:12:53           Start 1049: tesh-xbt-signals
17:12:53 1048/1072 Test #1049: tesh-xbt-signals ............................................   Passed    0.07 sec
17:12:53           Start 1050: tesh-xbt-log
17:12:53 1049/1072 Test #1050: tesh-xbt-log ................................................   Passed    0.14 sec
17:12:53           Start 1051: graphicator
17:12:53 1050/1072 Test #1051: graphicator .................................................   Passed    0.10 sec
17:12:53           Start 1052: tesh-self-setenv
17:12:53 1051/1072 Test #1052: tesh-self-setenv ............................................   Passed    0.09 sec
17:12:53           Start 1053: tesh-self-set-output-ignore
17:12:53 1052/1072 Test #1053: tesh-self-set-output-ignore .................................   Passed    0.10 sec
17:12:53           Start 1054: tesh-self-set-output-sort
17:12:53 1053/1072 Test #1054: tesh-self-set-output-sort ...................................   Passed    0.27 sec
17:12:53           Start 1055: tesh-self-set-return
17:12:53 1054/1072 Test #1055: tesh-self-set-return ........................................   Passed    0.06 sec
17:12:53           Start 1056: tesh-self-set-timeout
17:13:01 1055/1072 Test #1056: tesh-self-set-timeout .......................................   Passed    7.06 sec
17:13:01           Start 1057: tesh-self-background
17:13:03 1056/1072 Test #1057: tesh-self-background ........................................   Passed    2.09 sec
17:13:03           Start 1058: tesh-self-basic
17:13:03 1057/1072 Test #1058: tesh-self-basic .............................................   Passed    0.56 sec
17:13:03           Start 1059: tesh-self-bg-basic
17:13:03 1058/1072 Test #1059: tesh-self-bg-basic ..........................................   Passed    0.06 sec
17:13:03           Start 1060: tesh-self-bg-set-signal
17:13:03 1059/1072 Test #1060: tesh-self-bg-set-signal .....................................   Passed    0.17 sec
17:13:03           Start 1061: tesh-self-catch-all-bg-output
17:13:06 1060/1072 Test #1061: tesh-self-catch-all-bg-output ...............................   Passed    2.11 sec
17:13:06           Start 1062: tesh-self-catch-return
17:13:06 1061/1072 Test #1062: tesh-self-catch-return ......................................   Passed    0.11 sec
17:13:06           Start 1063: tesh-self-catch-signal
17:13:06 1062/1072 Test #1063: tesh-self-catch-signal ......................................   Passed    0.27 sec
17:13:06           Start 1064: tesh-self-catch-timeout
17:13:07 1063/1072 Test #1064: tesh-self-catch-timeout .....................................   Passed    1.30 sec
17:13:07           Start 1065: tesh-self-catch-timeout-output
17:13:09 1064/1072 Test #1065: tesh-self-catch-timeout-output ..............................   Passed    1.33 sec
17:13:09           Start 1066: tesh-self-catch-wrong-output
17:13:09 1065/1072 Test #1066: tesh-self-catch-wrong-output ................................   Passed    0.10 sec
17:13:09           Start 1067: tesh-self-cd
17:13:09 1066/1072 Test #1067: tesh-self-cd ................................................   Passed    0.15 sec
17:13:09           Start 1068: tesh-self-color
17:13:09 1067/1072 Test #1068: tesh-self-color .............................................   Passed    0.06 sec
17:13:09           Start 1069: tesh-self-ignore-regexp
17:13:09 1068/1072 Test #1069: tesh-self-ignore-regexp .....................................   Passed    0.05 sec
17:13:09           Start 1070: tesh-self-IO-bigsize
17:13:09 1069/1072 Test #1070: tesh-self-IO-bigsize ........................................   Passed    0.07 sec
17:13:09           Start 1071: tesh-self-IO-broken-pipe
17:13:09 1070/1072 Test #1071: tesh-self-IO-broken-pipe ....................................   Passed    0.34 sec
17:13:09           Start 1072: tesh-self-IO-orders
17:13:10 1071/1072 Test #1072: tesh-self-IO-orders .........................................   Passed    0.32 sec
17:13:10 1072/1072 Test #1043: test-smpi-mpich3-rma-raw ....................................   Passed   25.24 sec
17:13:10 
17:13:10 99% tests passed, 15 tests failed out of 1072
17:13:10 
17:13:10 Total Test time (real) = 131.12 sec
17:13:10 
17:13:10 The following tests FAILED:
17:13:10 	554 - pthread-mc-mutex-simple-boost (Failed)
17:13:10 	555 - pthread-mc-mutex-simple-raw (Failed)
17:13:10 	556 - pthread-mc-mutex-simple-ucontext (Failed)
17:13:10 	560 - pthread-mc-mutex-recursive-boost (Failed)
17:13:10 	561 - pthread-mc-mutex-recursive-raw (Failed)
17:13:10 	562 - pthread-mc-mutex-recursive-ucontext (Failed)
17:13:10 	566 - pthread-mc-producer-consumer-boost (Failed)
17:13:10 	567 - pthread-mc-producer-consumer-raw (Failed)
17:13:10 	568 - pthread-mc-producer-consumer-ucontext (Failed)
17:13:10 	569 - pthread-mc-mutex-simpledeadlock-boost (Failed)
17:13:10 	570 - pthread-mc-mutex-simpledeadlock-raw (Failed)
17:13:10 	571 - pthread-mc-mutex-simpledeadlock-ucontext (Failed)
17:13:10 	602 - mc-mini-simple_mutex_with_threads_ok (Failed)
17:13:10 	613 - mc-mini-philosophers_semaphores_deadlock (Failed)
17:13:10 	615 - mc-mini-philosophers_mutex_deadlock (Failed)
17:13:11 Create notes file
17:13:11 	Add file: /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/Testing/Notes/Build
17:13:11 Errors while running CTest
17:13:11 + true
17:13:11 + test -n /home/ci/simgrid_install
17:13:11 + '[' origin/master = origin/master ']'
17:13:11 + echo XX
17:13:11 XX
17:13:11 + echo 'XX Test done. Install everything since it'\''s a regular build, not on a Windows.'
17:13:11 XX Test done. Install everything since it's a regular build, not on a Windows.
17:13:11 + echo XX
17:13:11 XX
17:13:11 + rm -rf /home/ci/simgrid_install
17:13:11 + make install
17:13:12 [  0%] Install /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/bin/simgrid_update_xml
17:13:12 [  0%] Built target simgrid_update_xml
17:13:12 [  0%] Install /builds/workspace/SimGrid/build_mode/Debug/node/centos/build/simgrid-3.35.1/build/bin/simgrid_convert_TI_traces
17:13:12 [  0%] Built target simgrid_convert_TI_traces
17:13:12 [  0%] Built target maintainer_files
17:13:14 Consolidate compiler generated dependencies of target simgrid
17:13:15 [ 94%] Built target simgrid
17:13:15 Consolidate compiler generated dependencies of target smpireplaymain
17:13:15 [ 94%] Built target smpireplaymain
17:13:15 Consolidate compiler generated dependencies of target simgrid-mc
17:13:15 [ 94%] Built target simgrid-mc
17:13:15 [ 94%] Built target mpi
17:13:15 Consolidate compiler generated dependencies of target smpimain
17:13:15 [ 94%] Built target smpimain
17:13:15 Consolidate compiler generated dependencies of target sthread
17:13:15 [ 94%] Built target sthread
17:13:15 Consolidate compiler generated dependencies of target supernode
17:13:15 [ 94%] Built target supernode
17:13:15 Consolidate compiler generated dependencies of target routing_cluster
17:13:15 [ 94%] Built target routing_cluster
17:13:15 Consolidate compiler generated dependencies of target griffon
17:13:15 [ 94%] Built target griffon
17:13:15 Consolidate compiler generated dependencies of target smpi_simple-execute
17:13:15 [ 94%] Built target smpi_simple-execute
17:13:16 Consolidate compiler generated dependencies of target smpi_comm-dynamic-cost
17:13:16 [ 94%] Built target smpi_comm-dynamic-cost
17:13:16 Consolidate compiler generated dependencies of target mtest_c
17:13:16 [100%] Built target mtest_c
17:13:16 [100%] Built target mtest_f77
17:13:16 [100%] Built target mtest_f90
17:13:16 Consolidate compiler generated dependencies of target graphicator
17:13:16 [100%] Built target graphicator
17:13:16 Install the project...
17:13:16 -- Install configuration: ""
17:13:16 -- Installing: /home/ci/simgrid_install/bin/simgrid-mc
17:13:16 -- Set runtime path of "/home/ci/simgrid_install/bin/simgrid-mc" to ""
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/simgrid/smpimain
17:13:16 -- Set runtime path of "/home/ci/simgrid_install/lib64/simgrid/smpimain" to ""
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/simgrid/smpireplaymain
17:13:16 -- Set runtime path of "/home/ci/simgrid_install/lib64/simgrid/smpireplaymain" to ""
17:13:16 -- Installing: /home/ci/simgrid_install/bin/smpicc
17:13:16 -- Installing: /home/ci/simgrid_install/bin/smpicxx
17:13:16 -- Installing: /home/ci/simgrid_install/bin/smpirun
17:13:16 -- Installing: /home/ci/simgrid_install/bin/smpif90
17:13:16 -- Installing: /home/ci/simgrid_install/bin/smpiff
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/mpi.mod
17:13:16 -- Installing: /home/ci/simgrid_install/bin/tesh
17:13:16 -- Installing: /home/ci/simgrid_install/bin/simgrid_update_xml
17:13:16 -- Installing: /home/ci/simgrid_install/bin/simgrid_convert_TI_traces
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/libsimgrid.so.3.35.1
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/libsimgrid.so
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/libsthread.so.3.35.1
17:13:16 -- Set runtime path of "/home/ci/simgrid_install/lib64/libsthread.so.3.35.1" to ""
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/libsthread.so
17:13:16 -- Installing: /home/ci/simgrid_install/lib64/pkgconfig/simgrid.pc
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/actor.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/activity_set.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/barrier.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/comm.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/engine.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/exec.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/Exception.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/chrono.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/battery.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/chiller.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/dvfs.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/energy.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/file_system.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/jbod.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/live_migration.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/load.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/solar_panel.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/plugins/ProducerConsumer.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/instr.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/mailbox.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/modelchecker.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/forward.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/simcall.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/simix.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/ProfileBuilder.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/Timer.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/disk.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/host.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/link.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/cond.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/mutex.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/semaphore.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/vm.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/zone.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Activity.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/ActivitySet.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Actor.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Barrier.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Comm.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/ConditionVariable.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Disk.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Engine.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Exec.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Host.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Io.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Link.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Mailbox.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/MessageQueue.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Mess.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Mutex.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/NetZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Semaphore.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/Task.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u/VirtualMachine.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/s4u.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/resource/Action.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/resource/Model.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/ClusterZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/DijkstraZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/DragonflyZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/EmptyZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/FatTreeZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/FloydZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/FullZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/NetPoint.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/NetZoneImpl.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/RoutedZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/StarZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/TorusZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/VivaldiZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/kernel/routing/WifiZone.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/mpi.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/sampi.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/smpi.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/smpi_helpers.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/smpi_helpers_internal.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/smpi_extended_traces.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/smpi_extended_traces_fortran.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/forward.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/asserts.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/asserts.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/backtrace.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/base.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/config.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/config.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/dict.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/dynar.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/ex.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/Extendable.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/file.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/functional.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/function_types.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/graph.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/log.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/log.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/mallocator.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/misc.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/module.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/PropertyHolder.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/parmap.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/parse_units.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/range.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/random.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/replay.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/signal.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/str.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/string.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/sysdep.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/system_error.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/utility.hpp
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/virtu.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/xbt/xbt_os_time.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/smpi/mpif.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/config.h
17:13:16 -- Installing: /home/ci/simgrid_install/include/simgrid/version.h
17:13:16 -- Installing: /home/ci/simgrid_install/bin/graphicator
17:13:16 -- Set runtime path of "/home/ci/simgrid_install/bin/graphicator" to ""
17:13:16 + echo XX
17:13:16 XX
17:13:16 + echo 'XX Done. Return the results to cmake'
17:13:16 XX Done. Return the results to cmake
17:13:16 + echo XX
17:13:16 XX
17:13:18 INFO: Processing CTest-Version 3.x (default)
17:13:20 INFO: [CTest-Version 3.x (default)] - 1 test report file(s) were found with the pattern 'build/simgrid*/build/Testing/*/Test.xml' relative to '/builds/workspace/SimGrid/build_mode/Debug/node/centos' for the testing framework 'CTest-Version 3.x (default)'.
17:13:31 INFO: Check 'Failed Tests' threshold.
17:13:31 INFO: The total number of tests for the threshold 'Failed Tests' exceeds the specified "unstable threshold" value.
17:13:31 [Checks API] No suitable checks publisher found.
17:13:31 INFO: Setting the build status to UNSTABLE
17:13:31 Build step 'Publish xUnit test result report' changed build result to UNSTABLE
17:13:31 [Text Finder] Searching console output...
17:13:31 [Text Finder] Finished searching for pattern 'Build\sskipped' in console output.
17:13:31 An attempt to send an e-mail to empty list of recipients, ignored.
17:13:31 [PostBuildScript] - [INFO] Executing post build scripts.
17:13:31 [PostBuildScript] - [INFO] Node does not have the role MASTER. Did not execute build step #0.
17:13:31 Started calculate disk usage of build
17:13:31 Finished Calculation of disk usage of build in 0 seconds
17:13:31 Started calculate disk usage of workspace
17:13:37 Finished Calculation of disk usage of workspace in  5 second
17:13:37 [WS-CLEANUP] Deleting project workspace...
17:13:37 [WS-CLEANUP] Skipped based on build state UNSTABLE
17:13:37 Finished: UNSTABLE