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)
...........
=====================================================================
Generated by BenchKit 2-3254
Executing tool lola
Input is Philosophers-COL-005000, examination is ReachabilityDeadlock
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r048-smll-149440869700170
=====================================================================

--------------------
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 Philosophers-COL-005000-ReachabilityDeadlock-0

=== Now, execution of the tool begins

BK_START 1494550415863


Time: 3600 - MCC
----- Start make prepare stdout -----
checking for too many tokens
----- Start make result stdout -----
ReachabilityDeadlock @ Philosophers-COL-005000 @ 3539 seconds
----- Start make result stdout -----
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 50000/65536 symbol table entries, 23863 collisions
lola: preprocessing...
lola: finding significant places
lola: 25000 places, 25000 transitions, 15000 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 35000 transition conflict sets
lola: TASK
lola: reading formula from Philosophers-COL-005000-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 1876 bytes per marking, with 8 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: 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: formula with 600002 variables and 1815004 clauses shipped to Minisat
lola: STP running || 1 tries, 12667 fired transitions, 0 secs
lola: 0 generators;312472500 candidates remain ( 0%), 0 secs
lola: STP running || 1 tries, 28514 fired transitions, 5 secs
lola: 0 generators;312472500 candidates remain ( 0%), 5 secs
lola: stp: The siphon/trap property does not hold
lola: STP completed || 1 tries, 45175 fired transitions, 10 secs
lola: 0 generators; 9999 candidates remain ( 0%), 10 secs
lola: STP completed || 1 tries, 60853 fired transitions, 15 secs
lola: 4999 generators; 5000 candidates remain (49%), 15 secs
lola: STP completed || 1 tries, 77336 fired transitions, 20 secs
lola: 4999 generators; 5000 candidates remain (49%), 20 secs
lola: STP completed || 1 tries, 93999 fired transitions, 25 secs
lola: 4999 generators; 5000 candidates remain (49%), 25 secs
lola: STP completed || 1 tries, 110948 fired transitions, 30 secs
lola: 4999 generators; 5000 candidates remain (49%), 30 secs
lola: STP completed || 1 tries, 129428 fired transitions, 35 secs
lola: 4999 generators; 5000 candidates remain (49%), 35 secs
lola: STP completed || 1 tries, 150215 fired transitions, 40 secs
lola: 4999 generators; 5000 candidates remain (49%), 40 secs
lola: STP completed || 1 tries, 173703 fired transitions, 45 secs
lola: 4999 generators; 5000 candidates remain (49%), 45 secs
lola: STP completed || 1 tries, 194685 fired transitions, 50 secs
lola: 4999 generators; 5000 candidates remain (49%), 50 secs
lola: STP completed || 1 tries, 216683 fired transitions, 55 secs
lola: 9999 generators; 0 candidates remain (100%), 55 secs
lola: computed 9999 generators (2 in search tree, 9997 by composition)
lola: representing 10000 symmetries
lola: 0 dead branches visited in search tree
lola: STP completed || 1 tries, 239901 fired transitions, 60 secs || 92 markings, 91 edges, 18 markings/sec, 60 secs
lola: STP completed || 1 tries, 263380 fired transitions, 65 secs || 730 markings, 730 edges, 128 markings/sec, 65 secs
lola: STP completed || 1 tries, 288035 fired transitions, 70 secs || 2146 markings, 2150 edges, 283 markings/sec, 70 secs
lola: STP completed || 1 tries, 312348 fired transitions, 75 secs || 2960 markings, 2964 edges, 163 markings/sec, 75 secs
lola: STP completed || 1 tries, 340397 fired transitions, 80 secs || 3684 markings, 3688 edges, 145 markings/sec, 80 secs
lola: STP completed || 1 tries, 369912 fired transitions, 85 secs || 4323 markings, 4326 edges, 128 markings/sec, 85 secs
lola: STP completed || 1 tries, 415938 fired transitions, 90 secs || 4897 markings, 4901 edges, 115 markings/sec, 90 secs
lola: STP completed || 1 tries, 457284 fired transitions, 95 secs || 5385 markings, 5389 edges, 98 markings/sec, 95 secs
lola: STP completed || 1 tries, 488359 fired transitions, 100 secs || 5857 markings, 5861 edges, 94 markings/sec, 100 secs
lola: STP completed || 1 tries, 519513 fired transitions, 105 secs || 6321 markings, 6324 edges, 93 markings/sec, 105 secs
lola: STP completed || 1 tries, 551338 fired transitions, 110 secs || 6759 markings, 6763 edges, 88 markings/sec, 110 secs
lola: STP completed || 1 tries, 582849 fired transitions, 115 secs || 7152 markings, 7156 edges, 79 markings/sec, 115 secs
lola: STP completed || 1 tries, 612675 fired transitions, 120 secs || 7542 markings, 7546 edges, 78 markings/sec, 120 secs
lola: STP completed || 1 tries, 641236 fired transitions, 125 secs || 7972 markings, 7976 edges, 86 markings/sec, 125 secs
lola: STP completed || 1 tries, 668411 fired transitions, 130 secs || 8492 markings, 8496 edges, 104 markings/sec, 130 secs
lola: STP completed || 1 tries, 696609 fired transitions, 135 secs || 9153 markings, 9157 edges, 132 markings/sec, 135 secs
lola: STP completed || 1 tries, 727126 fired transitions, 140 secs || 9986 markings, 9990 edges, 167 markings/sec, 140 secs
lola: STP completed || 1 tries, 757502 fired transitions, 145 secs || 10835 markings, 10839 edges, 170 markings/sec, 145 secs
lola: STP completed || 1 tries, 786529 fired transitions, 150 secs || 11673 markings, 11677 edges, 168 markings/sec, 150 secs
lola: STP completed || 1 tries, 818532 fired transitions, 155 secs || 12392 markings, 12396 edges, 144 markings/sec, 155 secs
lola: STP completed || 1 tries, 853551 fired transitions, 160 secs || 13014 markings, 13018 edges, 124 markings/sec, 160 secs
lola: STP completed || 1 tries, 896386 fired transitions, 165 secs || 13580 markings, 13584 edges, 113 markings/sec, 165 secs
lola: STP completed || 1 tries, 938134 fired transitions, 170 secs || 14196 markings, 14200 edges, 123 markings/sec, 170 secs
lola: STP completed || 1 tries, 975047 fired transitions, 175 secs || 14945 markings, 14948 edges, 150 markings/sec, 175 secs
lola: STP completed || 2 tries, 1005192 fired transitions, 180 secs || 15537 markings, 15541 edges, 118 markings/sec, 180 secs
lola: STP completed || 2 tries, 1128509 fired transitions, 185 secs || 16013 markings, 16017 edges, 95 markings/sec, 185 secs
lola: STP completed || 2 tries, 1348571 fired transitions, 190 secs || 16551 markings, 16555 edges, 108 markings/sec, 190 secs
lola: STP completed || 2 tries, 1427848 fired transitions, 195 secs || 17089 markings, 17093 edges, 108 markings/sec, 195 secs
lola: STP completed || 2 tries, 1461437 fired transitions, 200 secs || 17550 markings, 17554 edges, 92 markings/sec, 200 secs
lola: STP completed || 2 tries, 1473118 fired transitions, 205 secs || 17940 markings, 17944 edges, 78 markings/sec, 205 secs
lola: STP completed || 2 tries, 1509943 fired transitions, 210 secs || 18372 markings, 18376 edges, 86 markings/sec, 210 secs
lola: STP completed || 2 tries, 1570614 fired transitions, 215 secs || 18722 markings, 18726 edges, 70 markings/sec, 215 secs
lola: STP completed || 2 tries, 1659240 fired transitions, 220 secs || 19078 markings, 19082 edges, 71 markings/sec, 220 secs
lola: STP completed || 2 tries, 1755623 fired transitions, 225 secs || 19395 markings, 19513 edges, 63 markings/sec, 225 secs
lola: STP completed || 2 tries, 1790245 fired transitions, 230 secs || 19716 markings, 19993 edges, 64 markings/sec, 230 secs
lola: STP completed || 2 tries, 1865134 fired transitions, 235 secs || 20037 markings, 20476 edges, 64 markings/sec, 235 secs
lola: STP completed || 2 tries, 1936714 fired transitions, 240 secs || 20267 markings, 20820 edges, 46 markings/sec, 240 secs
lola: STP completed || 2 tries, 1994029 fired transitions, 245 secs || 20410 markings, 21030 edges, 29 markings/sec, 245 secs
lola: STP completed || 3 tries, 2013941 fired transitions, 250 secs || 20548 markings, 21168 edges, 28 markings/sec, 250 secs
lola: STP completed || 3 tries, 2032060 fired transitions, 255 secs || 20696 markings, 21316 edges, 30 markings/sec, 255 secs
lola: STP completed || 3 tries, 2045153 fired transitions, 260 secs || 20914 markings, 21534 edges, 44 markings/sec, 260 secs
lola: STP completed || 3 tries, 2058247 fired transitions, 265 secs || 21218 markings, 21838 edges, 61 markings/sec, 265 secs
lola: STP completed || 3 tries, 2071522 fired transitions, 270 secs || 21544 markings, 22164 edges, 65 markings/sec, 270 secs
lola: STP completed || 3 tries, 2084428 fired transitions, 275 secs || 21972 markings, 22592 edges, 86 markings/sec, 275 secs
lola: STP completed || 3 tries, 2096510 fired transitions, 280 secs || 22397 markings, 23017 edges, 85 markings/sec, 280 secs
lola: STP completed || 3 tries, 2109030 fired transitions, 285 secs || 22802 markings, 23422 edges, 81 markings/sec, 285 secs
lola: STP completed || 3 tries, 2127344 fired transitions, 290 secs || 23142 markings, 23762 edges, 68 markings/sec, 290 secs
lola: STP completed || 3 tries, 2150068 fired transitions, 295 secs || 23532 markings, 24152 edges, 78 markings/sec, 295 secs
lola: STP completed || 3 tries, 2171189 fired transitions, 300 secs || 24004 markings, 24624 edges, 94 markings/sec, 300 secs
lola: STP completed || 3 tries, 2192102 fired transitions, 305 secs || 24578 markings, 25197 edges, 115 markings/sec, 305 secs
lola: STP completed || 3 tries, 2212589 fired transitions, 310 secs || 25231 markings, 25851 edges, 131 markings/sec, 310 secs
lola: STP completed || 3 tries, 2234077 fired transitions, 315 secs || 25603 markings, 26222 edges, 74 markings/sec, 315 secs
lola: STP completed || 3 tries, 2255682 fired transitions, 320 secs || 25887 markings, 26561 edges, 57 markings/sec, 320 secs
lola: STP completed || 3 tries, 2277008 fired transitions, 325 secs || 26109 markings, 26917 edges, 44 markings/sec, 325 secs
lola: STP completed || 3 tries, 2299157 fired transitions, 330 secs || 26344 markings, 27292 edges, 47 markings/sec, 330 secs
lola: STP completed || 3 tries, 2321821 fired transitions, 335 secs || 26607 markings, 27711 edges, 53 markings/sec, 335 secs
lola: STP completed || 3 tries, 2345168 fired transitions, 340 secs || 26897 markings, 28121 edges, 58 markings/sec, 340 secs
lola: STP completed || 3 tries, 2366017 fired transitions, 345 secs || 27169 markings, 28555 edges, 54 markings/sec, 345 secs
lola: STP completed || 3 tries, 2385900 fired transitions, 350 secs || 27461 markings, 28986 edges, 58 markings/sec, 350 secs
lola: STP completed || 3 tries, 2404480 fired transitions, 355 secs || 27835 markings, 29407 edges, 75 markings/sec, 355 secs
lola: STP completed || 3 tries, 2422158 fired transitions, 360 secs || 28178 markings, 29864 edges, 69 markings/sec, 360 secs
lola: STP completed || 3 tries, 2438752 fired transitions, 365 secs || 28516 markings, 30315 edges, 68 markings/sec, 365 secs
lola: STP completed || 3 tries, 2471049 fired transitions, 370 secs || 28820 markings, 30778 edges, 61 markings/sec, 370 secs
lola: STP completed || 3 tries, 2538362 fired transitions, 375 secs || 29114 markings, 31249 edges, 59 markings/sec, 375 secs
lola: STP completed || 3 tries, 2603205 fired transitions, 380 secs || 29415 markings, 31730 edges, 60 markings/sec, 380 secs
lola: STP completed || 3 tries, 2696596 fired transitions, 385 secs || 29713 markings, 32206 edges, 60 markings/sec, 385 secs
lola: STP completed || 3 tries, 2799091 fired transitions, 390 secs || 30019 markings, 32697 edges, 61 markings/sec, 390 secs
lola: STP completed || 3 tries, 2861190 fired transitions, 395 secs || 30332 markings, 33197 edges, 63 markings/sec, 395 secs
lola: STP completed || 3 tries, 2908296 fired transitions, 400 secs || 30630 markings, 33674 edges, 60 markings/sec, 400 secs
lola: STP completed || 3 tries, 2938227 fired transitions, 405 secs || 30923 markings, 34141 edges, 59 markings/sec, 405 secs
lola: RESULT
lola: result: yes
lola: produced by: state space
lola: The net has deadlock(s).
lola: 31097 markings, 34419 edges
FORMULA Philosophers-COL-005000-ReachabilityDeadlock-0 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT SAT_SMT STATE_COMPRESSION STUBBORN_SETS SYMMETRIES TOPOLOGICAL USE_NUPN
----- Kill lola and sara stdout -----
----- Finished stdout -----

BK_STOP 1494550829664

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

----- Start make prepare stderr -----
----- Start make result stderr -----
----- Start make result stderr -----
----- Kill lola and sara stderr -----
----- 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="Philosophers-COL-005000"
export BK_EXAMINATION="ReachabilityDeadlock"
export BK_TOOL="lola"
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/Philosophers-COL-005000.tgz
mv Philosophers-COL-005000 execution

# this is for BenchKit: explicit launching of the test

cd execution
echo "====================================================================="
echo " Generated by BenchKit 2-3254"
echo " Executing tool lola"
echo " Input is Philosophers-COL-005000, 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 r048-smll-149440869700170"
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 ;