fond
Model Checking Contest 2018
8th edition, Bratislava, Slovakia, June 26, 2018
Execution of r082-blw3-152649949700377
Last Updated
June 26, 2018

About the Execution of M4M.full for DrinkVendingMachine-PT-10

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
7064.380 417624.00 1104183.00 1138.40 F normal

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 205M
-rw-r--r-- 1 mcc users 13K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 49K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 13M May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 34M 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 6.1K May 15 18:54 LTLCardinality.txt
-rw-r--r-- 1 mcc users 21K May 15 18:54 LTLCardinality.xml
-rw-r--r-- 1 mcc users 464K May 15 18:54 LTLFireability.txt
-rw-r--r-- 1 mcc users 1.2M May 15 18:54 LTLFireability.xml
-rw-r--r-- 1 mcc users 13K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 46K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 116 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 354 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 6.5M May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 18M May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 3.9K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 9.1K May 15 18:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 15 18:50 equiv_col
-rw-r--r-- 1 mcc users 3 May 15 18:50 instance
-rw-r--r-- 1 mcc users 6 May 15 18:50 iscolored
-rw-r--r-- 1 mcc users 134M May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool mcc4mcc-full
Input is DrinkVendingMachine-PT-10, examination is ReachabilityDeadlock
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r082-blw3-152649949700377
=====================================================================


--------------------
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-PT-10-ReachabilityDeadlock-0

=== Now, execution of the tool begins

BK_START 1527418518109


BK_STOP 1527418935733

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

Prefix is 65b80f64.
Reading known information in /usr/share/mcc4mcc/65b80f64-known.json.
Reading learned information in /usr/share/mcc4mcc/65b80f64-learned.json.
Reading value translations in /usr/share/mcc4mcc/65b80f64-values.json.
Using directory /home/mcc/execution for input, as it contains a model.pnml file.
Using DrinkVendingMachine-PT-10 as instance name.
Using DrinkVendingMachine as model name.
Using algorithm or tool bmdt.
Model characteristics are: {'Examination': 'ReachabilityDeadlock', 'Place/Transition': True, 'Colored': True, 'Relative-Time': 1, 'Relative-Memory': 1, 'Ordinary': False, 'Simple Free Choice': False, 'State Machine': False, 'Marked Graph': False, 'Extended Free Choice': False, 'Connected': True, 'Strongly Connected': True, 'Source Place': False, 'Sink Place': False, 'Source Transition': False, 'Sink Transition': False, 'Loop Free': True, 'Conservative': True, 'Sub-Conservative': True, 'Nested Units': False, 'Safe': True, 'Deadlock': False, 'Reversible': True, 'Quasi Live': None, 'Live': None}.
Known tools are: [{'Time': 104318, 'Memory': 8443.71, 'Tool': 'marcie'}, {'Time': 107239, 'Memory': 8443.84, 'Tool': 'marcie'}, {'Time': 146502, 'Memory': 7260.21, 'Tool': 'itstools'}, {'Time': 158890, 'Memory': 7331.07, 'Tool': 'itstools'}, {'Time': 418471, 'Memory': 6919.85, 'Tool': 'lola'}, {'Time': 425652, 'Memory': 7020.46, 'Tool': 'lola'}].
Learned tools are: [{'Tool': 'lola'}].
Learned tool lola is 4.011493701949807x far from the best tool marcie.
ReachabilityDeadlock lola DrinkVendingMachine-PT-10...

Time: 3600 - MCC
----- Start make prepare stdout -----
----- Start make prepare stderr -----
===========================================================================================
DrinkVendingMachine-PT-10: translating PT Petri net model.pnml into LoLA format
===========================================================================================
translating PT Petri net complete


checking for too many tokens
===========================================================================================
DrinkVendingMachine-PT-10: translating PT formula ReachabilityDeadlock into LoLA format
===========================================================================================
translating formula complete
touch formulae;
----- Start make result stderr -----
----- Start make result stdout -----
ReachabilityDeadlock @ DrinkVendingMachine-PT-10 @ 3538 seconds
----- Start make result stdout -----
----- Start make result stderr -----
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 111280/65536 symbol table entries, 66439 collisions
lola: preprocessing...
lola: finding significant places
lola: 120 places, 111160 transitions, 60 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 48320 transition conflict sets
lola: TASK
lola: reading formula from DrinkVendingMachine-PT-10-ReachabilityDeadlock.task
lola: E (F (DEADLOCK))
lola: E (F (DEADLOCK))
lola: checking reachability of deadlocks
lola: Planning: workflow for deadlock check: siphon||findpath||search) (--findpath=par,--siphontrap=par)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using deadlock preserving stubborn set method with insertion algorithm(--stubborn=tarjan)
lola: SEARCH (findpath)
lola: findpath: using deadlock preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: stp: The siphon/trap property is not applicable since the net is inhomogeneous
lola: findpath: starting randomized, memory-less exploration (--search=findpath)
lola: findpath: searching for paths with maximal depth 1000000 (--depthlimit)
lola: findpath: no retry limit given (--retrylimit)
lola: findpath: transitions are chosen randomly
lola: computing symmetries (--symmetry)
lola: time limit for symmetry computation of 300 seconds given (--symmtimelimit)
lola: STP completed || 1 tries, 0 fired transitions, 0 secs
lola: 0 generators; 6812 candidates remain ( 0%), 0 secs
lola: STP completed || 1 tries, 0 fired transitions, 5 secs
lola: 0 generators; 6812 candidates remain ( 0%), 5 secs
lola: STP completed || 1 tries, 0 fired transitions, 10 secs
lola: 0 generators; 6812 candidates remain ( 0%), 10 secs
lola: STP completed || 1 tries, 6 fired transitions, 15 secs
lola: 0 generators; 6812 candidates remain ( 0%), 15 secs
lola: STP completed || 1 tries, 6 fired transitions, 20 secs
lola: 0 generators; 6812 candidates remain ( 0%), 20 secs
lola: STP completed || 1 tries, 6 fired transitions, 25 secs
lola: 0 generators; 6812 candidates remain ( 0%), 25 secs
lola: STP completed || 1 tries, 12 fired transitions, 30 secs
lola: 0 generators; 6812 candidates remain ( 0%), 30 secs
lola: STP completed || 1 tries, 12 fired transitions, 35 secs
lola: 0 generators; 6812 candidates remain ( 0%), 35 secs
lola: STP completed || 1 tries, 12 fired transitions, 40 secs
lola: 0 generators; 6812 candidates remain ( 0%), 40 secs
lola: STP completed || 1 tries, 18 fired transitions, 45 secs
lola: 0 generators; 6812 candidates remain ( 0%), 45 secs
lola: STP completed || 1 tries, 18 fired transitions, 50 secs
lola: 0 generators; 6812 candidates remain ( 0%), 50 secs
lola: STP completed || 1 tries, 18 fired transitions, 55 secs
lola: 0 generators; 6812 candidates remain ( 0%), 55 secs
lola: STP completed || 1 tries, 23 fired transitions, 60 secs
lola: 0 generators; 6812 candidates remain ( 0%), 60 secs
lola: STP completed || 1 tries, 23 fired transitions, 65 secs
lola: 0 generators; 6812 candidates remain ( 0%), 65 secs
lola: STP completed || 1 tries, 23 fired transitions, 70 secs
lola: 0 generators; 6812 candidates remain ( 0%), 70 secs
lola: STP completed || 1 tries, 29 fired transitions, 75 secs
lola: 0 generators; 6812 candidates remain ( 0%), 75 secs
lola: STP completed || 1 tries, 29 fired transitions, 80 secs
lola: 0 generators; 6812 candidates remain ( 0%), 80 secs
lola: STP completed || 1 tries, 29 fired transitions, 85 secs
lola: 0 generators; 6812 candidates remain ( 0%), 85 secs
lola: STP completed || 1 tries, 35 fired transitions, 90 secs
lola: 0 generators; 6812 candidates remain ( 0%), 90 secs
lola: STP completed || 1 tries, 35 fired transitions, 95 secs
lola: 0 generators; 6812 candidates remain ( 0%), 95 secs
lola: STP completed || 1 tries, 35 fired transitions, 100 secs
lola: 0 generators; 6812 candidates remain ( 0%), 100 secs
lola: 0 generators; 6812 candidates remain ( 0%), 105 secs
lola: STP completed || 1 tries, 41 fired transitions, 105 secs
lola: 0 generators; 6812 candidates remain ( 0%), 110 secs
lola: STP completed || 1 tries, 41 fired transitions, 110 secs
lola: 0 generators; 6812 candidates remain ( 0%), 115 secs
lola: STP completed || 1 tries, 41 fired transitions, 115 secs
lola: 0 generators; 6812 candidates remain ( 0%), 120 secs
lola: STP completed || 1 tries, 47 fired transitions, 120 secs
lola: 0 generators; 6812 candidates remain ( 0%), 125 secs
lola: STP completed || 1 tries, 47 fired transitions, 125 secs
lola: 0 generators; 6812 candidates remain ( 0%), 130 secs
lola: STP completed || 1 tries, 47 fired transitions, 130 secs
lola: 0 generators; 6812 candidates remain ( 0%), 135 secs
lola: STP completed || 1 tries, 51 fired transitions, 135 secs
lola: STP completed || 1 tries, 51 fired transitions, 140 secs
lola: 0 generators; 6812 candidates remain ( 0%), 140 secs
lola: STP completed || 1 tries, 51 fired transitions, 145 secs
lola: 0 generators; 6812 candidates remain ( 0%), 145 secs
lola: STP completed || 1 tries, 57 fired transitions, 150 secs
lola: 0 generators; 6812 candidates remain ( 0%), 150 secs
lola: STP completed || 1 tries, 57 fired transitions, 155 secs
lola: 0 generators; 6812 candidates remain ( 0%), 155 secs
lola: STP completed || 1 tries, 57 fired transitions, 160 secs
lola: 0 generators; 6812 candidates remain ( 0%), 160 secs
lola: STP completed || 1 tries, 57 fired transitions, 165 secs
lola: 0 generators; 6812 candidates remain ( 0%), 165 secs
lola: STP completed || 1 tries, 63 fired transitions, 170 secs
lola: 0 generators; 6812 candidates remain ( 0%), 170 secs
lola: STP completed || 1 tries, 63 fired transitions, 175 secs
lola: 0 generators; 6812 candidates remain ( 0%), 175 secs
lola: 0 generators; 6812 candidates remain ( 0%), 180 secs
lola: STP completed || 1 tries, 63 fired transitions, 180 secs
lola: 0 generators; 6812 candidates remain ( 0%), 185 secs
lola: STP completed || 1 tries, 69 fired transitions, 185 secs
lola: 0 generators; 6812 candidates remain ( 0%), 190 secs
lola: STP completed || 1 tries, 69 fired transitions, 190 secs
lola: 0 generators; 6812 candidates remain ( 0%), 195 secs
lola: STP completed || 1 tries, 69 fired transitions, 195 secs
lola: 0 generators; 6812 candidates remain ( 0%), 200 secs
lola: STP completed || 1 tries, 75 fired transitions, 200 secs
lola: 0 generators; 6812 candidates remain ( 0%), 205 secs
lola: STP completed || 1 tries, 75 fired transitions, 205 secs
lola: 0 generators; 6812 candidates remain ( 0%), 210 secs
lola: STP completed || 1 tries, 75 fired transitions, 210 secs
lola: 0 generators; 6812 candidates remain ( 0%), 215 secs
lola: STP completed || 1 tries, 81 fired transitions, 215 secs
lola: STP completed || 1 tries, 81 fired transitions, 220 secs
lola: 0 generators; 6812 candidates remain ( 0%), 220 secs
lola: STP completed || 1 tries, 81 fired transitions, 225 secs
lola: 0 generators; 6812 candidates remain ( 0%), 225 secs
lola: STP completed || 1 tries, 87 fired transitions, 230 secs
lola: 0 generators; 6812 candidates remain ( 0%), 230 secs
lola: STP completed || 1 tries, 87 fired transitions, 235 secs
lola: 0 generators; 6812 candidates remain ( 0%), 235 secs
lola: STP completed || 1 tries, 87 fired transitions, 240 secs
lola: 0 generators; 6812 candidates remain ( 0%), 240 secs
lola: STP completed || 1 tries, 93 fired transitions, 245 secs
lola: 0 generators; 6812 candidates remain ( 0%), 245 secs
lola: STP completed || 1 tries, 93 fired transitions, 250 secs
lola: 0 generators; 6812 candidates remain ( 0%), 250 secs
lola: STP completed || 1 tries, 93 fired transitions, 255 secs
lola: 0 generators; 6812 candidates remain ( 0%), 255 secs
lola: STP completed || 1 tries, 99 fired transitions, 260 secs
lola: 0 generators; 6812 candidates remain ( 0%), 260 secs
lola: 0 generators; 6812 candidates remain ( 0%), 265 secs
lola: STP completed || 1 tries, 99 fired transitions, 265 secs
lola: 0 generators; 6812 candidates remain ( 0%), 270 secs
lola: STP completed || 1 tries, 99 fired transitions, 270 secs
lola: 0 generators; 6812 candidates remain ( 0%), 275 secs
lola: STP completed || 1 tries, 105 fired transitions, 275 secs
lola: 0 generators; 6812 candidates remain ( 0%), 280 secs
lola: STP completed || 1 tries, 105 fired transitions, 280 secs
lola: 0 generators; 6812 candidates remain ( 0%), 285 secs
lola: STP completed || 1 tries, 105 fired transitions, 285 secs
lola: 0 generators; 6812 candidates remain ( 0%), 290 secs
lola: STP completed || 1 tries, 111 fired transitions, 290 secs
lola: 0 generators; 6812 candidates remain ( 0%), 295 secs
lola: STP completed || 1 tries, 111 fired transitions, 295 secs
lola: 0 generators; 6812 candidates remain ( 0%), 300 secs
lola: STP completed || 1 tries, 111 fired transitions, 300 secs
lola: 0 generators; 6812 candidates remain ( 0%), 305 secs
lola: time limit for symmetry computation exceeded - aborting
lola: STP completed || 1 tries, 117 fired transitions, 305 secs
lola: symmetry computation interrupted: continue with partial generating set
lola: computed 0 generators (0 in search tree, 0 by composition)
lola: representing 1 symmetries
lola: 2 dead branches visited in search tree
lola: STP completed || 1 tries, 117 fired transitions, 310 secs || 1 markings, 0 edges, 0 markings/sec, 310 secs
lola: STP completed || 1 tries, 117 fired transitions, 315 secs || 1 markings, 0 edges, 0 markings/sec, 315 secs
lola: STP completed || 1 tries, 117 fired transitions, 320 secs || 1 markings, 0 edges, 0 markings/sec, 320 secs
lola: STP completed || 1 tries, 123 fired transitions, 325 secs || 2998 markings, 5622 edges, 599 markings/sec, 325 secs
lola: STP completed || 1 tries, 123 fired transitions, 330 secs || 6407 markings, 12670 edges, 682 markings/sec, 330 secs
lola: STP completed || 1 tries, 123 fired transitions, 335 secs || 9792 markings, 20624 edges, 677 markings/sec, 335 secs
lola: STP completed || 1 tries, 128 fired transitions, 340 secs || 12785 markings, 29277 edges, 599 markings/sec, 340 secs
lola: STP completed || 1 tries, 128 fired transitions, 345 secs || 16078 markings, 44236 edges, 659 markings/sec, 345 secs
lola: RESULT
lola: result: no
lola: produced by: state space
lola: The net does not have deadlocks.
lola: 19362 markings, 101461 edges
FORMULA DrinkVendingMachine-PT-10-ReachabilityDeadlock-0 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT SAT_SMT STATE_COMPRESSION STUBBORN_SETS SYMMETRIES TOPOLOGICAL USE_NUPN
----- Kill lola and sara stderr -----
----- Kill lola and sara stdout -----
----- Finished stdout -----
----- Finished 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-PT-10"
export BK_EXAMINATION="ReachabilityDeadlock"
export BK_TOOL="mcc4mcc-full"
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-PT-10.tgz
mv DrinkVendingMachine-PT-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 mcc4mcc-full"
echo " Input is DrinkVendingMachine-PT-10, examination is ReachabilityDeadlock"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r082-blw3-152649949700377"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "ReachabilityDeadlock" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityDeadlock" != "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 "ReachabilityDeadlock.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityDeadlock.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityDeadlock.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 '' ReachabilityDeadlock.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
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 ;