About the Execution of Tapaal for DrinkVendingMachine-COL-10
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Waiting for the VM to be ready (probing ssh)
................
/home/mcc/execution
total 192K
-rw-r--r-- 1 mcc users 4.2K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 21K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.8K May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 16K May 15 18:54 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K May 15 18:50 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.1K May 15 18:50 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 2.6K May 26 09:26 LTLCardinality.txt
-rw-r--r-- 1 mcc users 11K May 26 09:26 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.1K May 26 09:26 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.4K May 26 09:26 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.7K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 17K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 117 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 355 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 2.8K May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 13K May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.9K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K May 15 18:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 15 18:50 equiv_pt
-rw-r--r-- 1 mcc users 3 May 15 18:50 instance
-rw-r--r-- 1 mcc users 5 May 15 18:50 iscolored
-rw-r--r-- 1 mcc users 24K May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool tapaal
Input is DrinkVendingMachine-COL-10, examination is UpperBounds
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r084-blw3-152649951600324
=====================================================================
--------------------
content from stdout:
=== Data for post analysis generated by BenchKit (invocation template)
The expected result is a vector of positive values
NUM_VECTOR
here is the order used to build the result vector(from text file)
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-00
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-01
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-02
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-03
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-04
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-05
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-06
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-07
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-08
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-09
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-10
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-11
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-12
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-13
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-14
FORMULA_NAME DrinkVendingMachine-COL-10-UpperBounds-15
=== Now, execution of the tool begins
BK_START 1527775683910
tapaal
---> tapaal --- TAPAAL
Total timeout: 3590
Time left: 3590
*****************************************
* TAPAAL CLASSIC verifying UpperBounds *
*****************************************
/home/mcc/tmp
/home/mcc/tmp/tmp.8YReUHps3v
/home/mcc/tmp/tmp.Yu6OPG3BUI
Time left: 3590
---------------------------------------------------
Step -1: Stripping Colors
---------------------------------------------------
Verifying stripped models (16 in total)
Time left: 3590
---------------------------------------------------
Step 0: Parallel Simplification
---------------------------------------------------
Doing parallel simplification (16 in total)
Total simplification timout is 718 -- reduction timeout is 299
/home/mcc/BenchKit/bin/verifypn -n -q 718 -l 29 -d 299 -z 4 -s OverApprox --write-simplified /home/mcc/tmp/tmp.8YReUHps3v --write-reduced /home/mcc/tmp/tmp.Yu6OPG3BUI -x 1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16 ./model.pnml ./UpperBounds.xml
Time left: 3463
---------------------------------------------------
Step 1: Parallel processing
---------------------------------------------------
Doing parallel verification of individual queries (16 in total)
Each query is verified by 2 parallel strategies for 138 seconds
------------------- QUERY 1 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@1.31,157200@@@
Query index 0 was solved
Query is NOT satisfied.
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 1 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-01 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3461
------------------- QUERY 2 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@1.31,157284@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -s\ BFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 2 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-03 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION STUBBORN_SETS
Time left: 3460
------------------- QUERY 3 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
FORMULA DrinkVendingMachine-COL-10-UpperBounds-04 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Query index 0 was solved
Query is NOT satisfied.
@@@1.30,157196@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 3 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-04 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION STUBBORN_SETS
Time left: 3458
------------------- QUERY 4 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@3.04,157200@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 4 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-05 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3455
------------------- QUERY 5 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@3.06,157248@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 5 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-07 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3452
------------------- QUERY 6 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
Query index 0 was solved
Query is NOT satisfied.
@@@1.32,157280@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -s\ BFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 6 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-08 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3451
------------------- QUERY 7 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@3.08,157212@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 7 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-09 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3447
------------------- QUERY 8 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@3.05,157100@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 8 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-10 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3444
------------------- QUERY 9 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@3.05,157196@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 9 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-11 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3441
------------------- QUERY 10 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@1.31,157196@@@
FORMULA DrinkVendingMachine-COL-10-UpperBounds-12 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Query index 0 was solved
Query is NOT satisfied.
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -s\ BFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 10 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-12 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION STUBBORN_SETS
Time left: 3439
------------------- QUERY 11 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@3.04,157084@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 11 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-13 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Time left: 3436
------------------- QUERY 12 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
FORMULA DrinkVendingMachine-COL-10-UpperBounds-14 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION
Query index 0 was solved
Query is NOT satisfied.
@@@1.30,157184@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -p\ -s\ DFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 12 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-14 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION STUBBORN_SETS
Time left: 3435
------------------- QUERY 13 ----------------------
Solution found by parallel processing (step 1)
Query index 0 was solved
Query is NOT satisfied.
@@@1.29,157188@@@
parallel: This job succeeded:
eval /usr/bin/time -f "@@@%e,%M@@@" /home/mcc/BenchKit/bin/verifypn -n -n\ -s\ BFS\ -q\ 0\ -l\ 0\ -d\ 119 /home/mcc/tmp/tmp.Yu6OPG3BUI /home/mcc/tmp/tmp.8YReUHps3v --binary-query-io 1 -x 13 -n
FORMULA DrinkVendingMachine-COL-10-UpperBounds-15 10 TECHNIQUES COLLATERAL_PROCESSING STRUCTURAL_REDUCTION QUERY_REDUCTION SAT_SMT EXPLICIT STATE_COMPRESSION STUBBORN_SETS
Time left: 3433
------------------- QUERY 14 ----------------------
No solution found
Time left: 3293
------------------- QUERY 15 ----------------------
No solution found
Time left: 3153
------------------- QUERY 16 ----------------------
No solution found
Time left: 3013
---------------------------------------------------
Step 2: Sequential processing
---------------------------------------------------
Remaining 3 queries are verified sequentially.
Each query is verified for a dynamic timeout (at least 0 seconds)
Time left: 3013
Time left: 3013
---------------------------------------------------
Step 3: Multiquery processing
---------------------------------------------------
Remaining 3 queries are solved using multiquery
Time remaining: 3013 seconds of the initial 3590 seconds
Running multiquery on -x 14,15,16 for 2259 seconds
Time left: 753
---------------------------------------------------
Step 4: Random Parallel processing
---------------------------------------------------
Doing random parallel verification of individual queries (3 in total)
Each query is verified by 4 parallel strategies for 251 seconds
------------------- QUERY 14 ----------------------
No solution found
Time left: 500
------------------- QUERY 15 ----------------------
No solution found
Time left: 247
------------------- QUERY 16 ----------------------
No solution found
Time left: -2
Out of time, terminating!
BK_STOP 1527779275535
--------------------
content from stderr:
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-15
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-14
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-13
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-12
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-11
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-10
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-09
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-08
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-07
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-06
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-05
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-04
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-03
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-02
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-01
Warning: CPN OverApproximation is only available for Reachability queries without deadlock, negated fireability and UpperBounds, skipping DrinkVendingMachine-COL-10-UpperBounds-00
Could not analyze the queries
Command exited with non-zero status 124
"@@@2259.01,461864@@@"
Sequence of Actions to be Executed by the VM
This is useful if one wants to reexecute the tool in the VM from the submitted image disk.
set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="DrinkVendingMachine-COL-10"
export BK_EXAMINATION="UpperBounds"
export BK_TOOL="tapaal"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
# this is specific to your benchmark or test
export BIN_DIR="$HOME/BenchKit/bin"
# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi
tar xzf /home/mcc/BenchKit/INPUTS/DrinkVendingMachine-COL-10.tgz
mv DrinkVendingMachine-COL-10 execution
cd execution
pwd
ls -lh
# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3637"
echo " Executing tool tapaal"
echo " Input is DrinkVendingMachine-COL-10, examination is UpperBounds"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r084-blw3-152649951600324"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "UpperBounds" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "UpperBounds" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "UpperBounds.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property UpperBounds.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "UpperBounds.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '
echo "FORMULA_NAME $x"
done
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;