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-3253
Executing tool lola
Input is DatabaseWithMutex-COL-20, examination is ReachabilityDeadlock
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r018-ebro-149436308900161
=====================================================================

--------------------
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 DatabaseWithMutex-COL-20-ReachabilityDeadlock-0

=== Now, execution of the tool begins

BK_START 1494622535382


Time: 3600 - MCC
----- Start make prepare stdout -----
checking for too many tokens
----- Start make result stdout -----
ReachabilityDeadlock @ DatabaseWithMutex-COL-20 @ 3540 seconds
Makefile:224: recipe for target 'verify' failed
----- Start make result stdout -----
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 6460/65536 symbol table entries, 909 collisions
lola: preprocessing...
lola: finding significant places
lola: 3260 places, 3200 transitions, 2800 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 4080 transition conflict sets
lola: TASK
lola: reading formula from DatabaseWithMutex-COL-20-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 11200 bytes per marking, with 0 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: computing symmetries (--symmetry)
lola: time limit for symmetry computation of 300 seconds given (--symmtimelimit)
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: STP: formula with 77462 variables and 374864 clauses shipped to Minisat
lola: computed 741 generators (44 in search tree, 697 by composition)
lola: representing 5.91901E+36 symmetries
lola: 0 dead branches visited in search tree
lola: stp: The siphon/trap property is inconclusive since the generated formula is too short
lola: STP completed || 1 tries, 62828 fired transitions, 0 secs || 34916 markings, 35194 edges, 6983 markings/sec, 0 secs
lola: STP completed || 1 tries, 124801 fired transitions, 5 secs || 76630 markings, 77210 edges, 8343 markings/sec, 5 secs
lola: STP completed || 1 tries, 187170 fired transitions, 10 secs || 118408 markings, 119316 edges, 8356 markings/sec, 10 secs
lola: STP completed || 1 tries, 249009 fired transitions, 15 secs || 159824 markings, 161062 edges, 8283 markings/sec, 15 secs
lola: STP completed || 1 tries, 311017 fired transitions, 20 secs || 201198 markings, 202735 edges, 8275 markings/sec, 20 secs
lola: STP completed || 1 tries, 373303 fired transitions, 25 secs || 242460 markings, 244290 edges, 8252 markings/sec, 25 secs
lola: STP completed || 1 tries, 435429 fired transitions, 30 secs || 284197 markings, 286336 edges, 8347 markings/sec, 30 secs
lola: STP completed || 1 tries, 497685 fired transitions, 35 secs || 325739 markings, 328174 edges, 8308 markings/sec, 35 secs
lola: STP completed || 1 tries, 560859 fired transitions, 40 secs || 368053 markings, 370778 edges, 8463 markings/sec, 40 secs
lola: STP completed || 1 tries, 625143 fired transitions, 45 secs || 410845 markings, 413880 edges, 8558 markings/sec, 45 secs
lola: STP completed || 1 tries, 689557 fired transitions, 50 secs || 453565 markings, 456899 edges, 8544 markings/sec, 50 secs
lola: STP completed || 1 tries, 753870 fired transitions, 55 secs || 496545 markings, 500162 edges, 8596 markings/sec, 55 secs
lola: STP completed || 1 tries, 816699 fired transitions, 60 secs || 537708 markings, 541616 edges, 8233 markings/sec, 60 secs
lola: STP completed || 1 tries, 878105 fired transitions, 65 secs || 578795 markings, 582980 edges, 8217 markings/sec, 65 secs
lola: STP completed || 1 tries, 940143 fired transitions, 70 secs || 620227 markings, 624713 edges, 8286 markings/sec, 70 secs
lola: STP completed || 2 tries, 1004335 fired transitions, 75 secs || 663345 markings, 668111 edges, 8624 markings/sec, 75 secs
lola: STP completed || 2 tries, 1068312 fired transitions, 80 secs || 706421 markings, 711484 edges, 8615 markings/sec, 80 secs
lola: STP completed || 2 tries, 1131491 fired transitions, 85 secs || 749348 markings, 754702 edges, 8585 markings/sec, 85 secs
lola: STP completed || 2 tries, 1194710 fired transitions, 90 secs || 791776 markings, 797416 edges, 8486 markings/sec, 90 secs
lola: STP completed || 2 tries, 1259099 fired transitions, 95 secs || 834593 markings, 840534 edges, 8563 markings/sec, 95 secs
lola: STP completed || 2 tries, 1323056 fired transitions, 100 secs || 877449 markings, 883704 edges, 8571 markings/sec, 100 secs
lola: STP completed || 2 tries, 1387440 fired transitions, 105 secs || 920060 markings, 926611 edges, 8522 markings/sec, 105 secs
lola: STP completed || 2 tries, 1451499 fired transitions, 110 secs || 963397 markings, 970268 edges, 8667 markings/sec, 110 secs
lola: STP completed || 2 tries, 1515538 fired transitions, 115 secs || 1005804 markings, 1012952 edges, 8481 markings/sec, 115 secs
lola: STP completed || 2 tries, 1580010 fired transitions, 120 secs || 1048864 markings, 1056305 edges, 8612 markings/sec, 120 secs
lola: STP completed || 2 tries, 1644413 fired transitions, 125 secs || 1091425 markings, 1099183 edges, 8512 markings/sec, 125 secs
lola: STP completed || 2 tries, 1708349 fired transitions, 130 secs || 1134107 markings, 1142140 edges, 8536 markings/sec, 130 secs
lola: STP completed || 2 tries, 1772281 fired transitions, 135 secs || 1176632 markings, 1184977 edges, 8505 markings/sec, 135 secs
lola: STP completed || 2 tries, 1836166 fired transitions, 140 secs || 1218060 markings, 1226694 edges, 8286 markings/sec, 140 secs
lola: STP completed || 2 tries, 1899583 fired transitions, 145 secs || 1260117 markings, 1269029 edges, 8411 markings/sec, 145 secs
lola: STP completed || 2 tries, 1962520 fired transitions, 150 secs || 1301873 markings, 1311047 edges, 8351 markings/sec, 150 secs
lola: STP completed || 3 tries, 2025545 fired transitions, 155 secs || 1343761 markings, 1353231 edges, 8378 markings/sec, 155 secs
lola: STP completed || 3 tries, 2088094 fired transitions, 160 secs || 1387561 markings, 1397307 edges, 8760 markings/sec, 160 secs
lola: STP completed || 3 tries, 2151387 fired transitions, 165 secs || 1429697 markings, 1439700 edges, 8427 markings/sec, 165 secs
lola: STP completed || 3 tries, 2214264 fired transitions, 170 secs || 1472312 markings, 1482578 edges, 8523 markings/sec, 170 secs
lola: STP completed || 3 tries, 2277397 fired transitions, 175 secs || 1515328 markings, 1525850 edges, 8603 markings/sec, 175 secs
lola: STP completed || 3 tries, 2340326 fired transitions, 180 secs || 1557644 markings, 1568453 edges, 8463 markings/sec, 180 secs
lola: STP completed || 3 tries, 2403496 fired transitions, 185 secs || 1599834 markings, 1610939 edges, 8438 markings/sec, 185 secs
lola: STP completed || 3 tries, 2466593 fired transitions, 190 secs || 1642732 markings, 1654141 edges, 8580 markings/sec, 190 secs
lola: STP completed || 3 tries, 2529813 fired transitions, 195 secs || 1684964 markings, 1696695 edges, 8446 markings/sec, 195 secs
lola: STP completed || 3 tries, 2593303 fired transitions, 200 secs || 1726866 markings, 1738892 edges, 8380 markings/sec, 200 secs
lola: STP completed || 3 tries, 2657356 fired transitions, 205 secs || 1767118 markings, 1779424 edges, 8050 markings/sec, 205 secs
lola: STP completed || 3 tries, 2722335 fired transitions, 210 secs || 1800644 markings, 1813171 edges, 6705 markings/sec, 210 secs
lola: STP completed || 3 tries, 2787148 fired transitions, 215 secs || 1834771 markings, 1847524 edges, 6825 markings/sec, 215 secs
lola: STP completed || 3 tries, 2851639 fired transitions, 220 secs || 1868903 markings, 1881907 edges, 6826 markings/sec, 220 secs
lola: STP completed || 3 tries, 2916109 fired transitions, 225 secs || 1903594 markings, 1916857 edges, 6938 markings/sec, 225 secs
lola: STP completed || 3 tries, 2980605 fired transitions, 230 secs || 1938002 markings, 1951495 edges, 6882 markings/sec, 230 secs
lola: STP completed || 4 tries, 3045202 fired transitions, 235 secs || 1972971 markings, 1986729 edges, 6994 markings/sec, 235 secs
lola: STP completed || 4 tries, 3109906 fired transitions, 240 secs || 2006523 markings, 2020544 edges, 6710 markings/sec, 240 secs
lola: STP completed || 4 tries, 3174772 fired transitions, 245 secs || 2041161 markings, 2055433 edges, 6928 markings/sec, 245 secs
lola: STP completed || 4 tries, 3239549 fired transitions, 250 secs || 2075459 markings, 2089953 edges, 6860 markings/sec, 250 secs
lola: STP completed || 4 tries, 3305021 fired transitions, 255 secs || 2108604 markings, 2123305 edges, 6629 markings/sec, 255 secs
lola: STP completed || 4 tries, 3370581 fired transitions, 260 secs || 2142185 markings, 2157107 edges, 6716 markings/sec, 260 secs
lola: STP completed || 4 tries, 3436220 fired transitions, 265 secs || 2175883 markings, 2191058 edges, 6740 markings/sec, 265 secs
lola: STP completed || 4 tries, 3501654 fired transitions, 270 secs || 2210152 markings, 2225547 edges, 6854 markings/sec, 270 secs
lola: STP completed || 4 tries, 3566670 fired transitions, 275 secs || 2245337 markings, 2261006 edges, 7037 markings/sec, 275 secs
lola: STP completed || 4 tries, 3632308 fired transitions, 280 secs || 2279268 markings, 2295201 edges, 6786 markings/sec, 280 secs
lola: STP completed || 4 tries, 3697819 fired transitions, 285 secs || 2313802 markings, 2329961 edges, 6907 markings/sec, 285 secs
lola: STP completed || 4 tries, 3762831 fired transitions, 290 secs || 2350763 markings, 2367156 edges, 7392 markings/sec, 290 secs
lola: STP completed || 4 tries, 3824237 fired transitions, 295 secs || 2383263 markings, 2399895 edges, 6500 markings/sec, 295 secs
Killed
FORMULA DatabaseWithMutex-COL-20-ReachabilityDeadlock-0 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT SAT_SMT STATE_COMPRESSION STUBBORN_SETS SYMMETRIES TOPOLOGICAL USE_NUPN
----- Kill lola and sara stdout -----
----- Finished stdout -----

BK_STOP 1494622837987

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

----- Start make prepare stderr -----
----- Start make result stderr -----
make: [verify] Error 137 (ignored)
----- 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="DatabaseWithMutex-COL-20"
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/DatabaseWithMutex-COL-20.tgz
mv DatabaseWithMutex-COL-20 execution

# this is for BenchKit: explicit launching of the test

cd execution
echo "====================================================================="
echo " Generated by BenchKit 2-3253"
echo " Executing tool lola"
echo " Input is DatabaseWithMutex-COL-20, 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 r018-ebro-149436308900161"
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 ;