fond
Model Checking Contest 2020
10th edition, Paris, France, June 23, 2020
Execution of r178-tajo-158987882900819
Last Updated
Jun 28, 2020

About the Execution of ITS-LoLa for DrinkVendingMachine-COL-10

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
15746.600 3600000.00 4712337.00 41882.50 FF??TF?T??TTFFTF normal

Execution Chart

We display below the execution chart for this examination (boot time has been removed).

Trace from the execution

Formatting '/mnt/tpsp/fkordon/mcc2020-input.r178-tajo-158987882900819.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/fkordon/mcc2020-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
.....................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itslola
Input is DrinkVendingMachine-COL-10, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r178-tajo-158987882900819
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 204K
-rw-r--r-- 1 mcc users 3.8K Mar 31 07:48 CTLCardinality.txt
-rw-r--r-- 1 mcc users 19K Mar 31 07:46 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.1K Mar 30 00:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 19K Mar 30 00:56 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.1K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.8K Apr 8 14:52 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Apr 28 14:01 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.5K Apr 8 14:52 LTLFireability.txt
-rw-r--r-- 1 mcc users 19K Apr 28 14:01 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 28 14:48 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 18K Mar 28 14:47 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Mar 27 08:12 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 15K Mar 27 08:10 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Mar 28 14:50 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K Mar 28 14:50 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 equiv_pt
-rw-r--r-- 1 mcc users 3 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 24K Mar 24 05:37 model.pnml

--------------------
content from stdout:

=== Data for post analysis generated by BenchKit (invocation template)

The expected result is a vector of booleans
BOOL_VECTOR

here is the order used to build the result vector(from text file)
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-00
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-01
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-02
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-03
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-04
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-05
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-06
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-07
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-08
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-09
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-10
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-11
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-12
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-13
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-14
FORMULA_NAME DrinkVendingMachine-COL-10-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1591243861006

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 04:11:02] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2020-06-04 04:11:02] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 04:11:02] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2020-06-04 04:11:03] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 613 ms
[2020-06-04 04:11:03] [INFO ] sort/places :
Options->optionSlots,theOptions,
Products->productSlots,theProducts,
Quality->wait,ready,

[2020-06-04 04:11:03] [INFO ] o1 symmetric to o2 in transition elaborate2
[2020-06-04 04:11:03] [INFO ] o1 symmetric to o3 in transition elaborate3
[2020-06-04 04:11:03] [INFO ] o3 symmetric to o2 in transition elaborate3
[2020-06-04 04:11:03] [INFO ] Imported 6 HL places and 7 HL transitions for a total of 120 PT places and 444460.0 transition bindings in 100 ms.
[2020-06-04 04:11:03] [INFO ] Computed order based on color domains.
[2020-06-04 04:11:03] [INFO ] Unfolded HLPN to a Petri net with 120 places and 28660 transitions in 195 ms.
[2020-06-04 04:11:03] [INFO ] Unfolded HLPN properties in 1 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 315 ms.
Incomplete random walk after 100000 steps, including 0 resets, run finished after 10896 ms. (steps per millisecond=9 ) properties seen :[0, 1, 1, 1, 1, 0, 1, 0, 1, 1, 1, 1, 1, 1, 1, 1, 0, 1]
// Phase 1: matrix 28660 rows 120 cols
[2020-06-04 04:11:15] [INFO ] Computed 60 place invariants in 314 ms
[2020-06-04 04:11:15] [INFO ] [Real]Absence check using 60 positive place invariants in 75 ms returned unsat
[2020-06-04 04:11:15] [INFO ] [Real]Absence check using 60 positive place invariants in 22 ms returned sat
[2020-06-04 04:11:15] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 04:11:29] [INFO ] [Real]Absence check using state equation in 13840 ms returned sat
[2020-06-04 04:11:32] [INFO ] Computed and/alt/rep : 11060/134200/11060 causal constraints in 1908 ms.
[2020-06-04 04:11:35] [INFO ] Added : 5 causal constraints over 1 iterations in 4842 ms. Result :(error "Solver has unexpectedly terminated")
[2020-06-04 04:11:35] [INFO ] [Real]Absence check using 60 positive place invariants in 17 ms returned sat
[2020-06-04 04:11:35] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 04:11:50] [INFO ] [Real]Absence check using state equation in 14363 ms returned sat
[2020-06-04 04:11:52] [INFO ] Computed and/alt/rep : 11060/134200/11060 causal constraints in 2065 ms.
[2020-06-04 04:11:55] [INFO ] Added : 5 causal constraints over 1 iterations in 4689 ms. Result :(error "Solver has unexpectedly terminated")
[2020-06-04 04:11:55] [INFO ] [Real]Absence check using 60 positive place invariants in 29 ms returned sat
[2020-06-04 04:11:55] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 04:12:12] [INFO ] [Real]Absence check using state equation in 16861 ms returned sat
[2020-06-04 04:12:12] [INFO ] Solution in real domain found non-integer solution.
[2020-06-04 04:12:12] [INFO ] [Nat]Absence check using 60 positive place invariants in 40 ms returned sat
[2020-06-04 04:12:12] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-04 04:12:28] [INFO ] [Nat]Absence check using state equation in 15470 ms returned sat
[2020-06-04 04:12:30] [INFO ] Computed and/alt/rep : 11060/134200/11060 causal constraints in 1701 ms.
[2020-06-04 04:12:32] [INFO ] Added : 5 causal constraints over 1 iterations in 4020 ms. Result :unknown
Successfully simplified 1 atomic propositions for a total of 1 simplifications.
[2020-06-04 04:12:35] [INFO ] Flatten gal took : 1951 ms
[2020-06-04 04:12:36] [INFO ] Flatten gal took : 1370 ms
[2020-06-04 04:12:36] [INFO ] Export to MCC properties in file /home/mcc/execution/CTLCardinality.sr.xml took 5 ms.
[2020-06-04 04:12:36] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 180 ms.
info: Time: 3600 - MCC
vrfy: Checking CTLCardinality @ DrinkVendingMachine-COL-10 @ 3570 seconds
check_solution: Constraint R31 = 0 is above its equality of -1
check_solution: Constraint R32 = 0 is above its equality of -1
check_solution: Constraint R33 = 0 is above its equality of -1
check_solution: Constraint R34 = 0 is above its equality of -1
check_solution: Constraint R35 = 0 is above its equality of -1
check_solution: Constraint R36 = 0 is above its equality of -1
check_solution: Constraint R37 = 0 is above its equality of -1
check_solution: Constraint R38 = 0 is above its equality of -1
check_solution: Constraint R39 = 0 is above its equality of -1
check_solution: Constraint R40 = 0 is above its equality of -1

Seriously low accuracy found ||*|| = 1 (rel. error 1)

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-00 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-01 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-07 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-10 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-14 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-11 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-04 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-05 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-12 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-13 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA DrinkVendingMachine-COL-10-CTLCardinality-15 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16427456 kB
MemFree: 11569008 kB
After kill :
MemTotal: 16427456 kB
MemFree: 15812552 kB

--------------------
content from stderr:

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="CTLCardinality"
export BK_TOOL="itslola"
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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itslola"
echo " Input is DrinkVendingMachine-COL-10, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r178-tajo-158987882900819"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/DrinkVendingMachine-COL-10.tgz
mv DrinkVendingMachine-COL-10 execution
cd execution
if [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "UpperBounds" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] || [ "CTLCardinality" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "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 "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.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 '' CTLCardinality.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLCardinality"
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 ;