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 S_Philosophers-PT-005000, examination is ReachabilityDeadlock
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r128-smll-149441681300215
=====================================================================

--------------------
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 1496339338269


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


checking for too many tokens
===========================================================================================
S_Philosophers-PT-005000: translating PT formula ReachabilityDeadlock into LoLA format
===========================================================================================
translating formula complete
touch formulae;
----- Start make result stdout -----
ReachabilityDeadlock @ S_Philosophers-PT-005000 @ 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: 50000/65536 symbol table entries, 20553 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 60000 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: 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, 41264 fired transitions, 0 secs
lola: 0 generators;312467500 candidates remain ( 0%), 0 secs
lola: STP running || 1 tries, 72874 fired transitions, 5 secs
lola: 0 generators;312467500 candidates remain ( 0%), 5 secs
lola: stp: The siphon/trap property does not hold
lola: STP completed || 1 tries, 104113 fired transitions, 10 secs
lola: 1 generators; 4999 candidates remain ( 0%), 10 secs
lola: STP completed || 1 tries, 141215 fired transitions, 15 secs
lola: 5000 generators; 0 candidates remain (100%), 15 secs
lola: computed 5000 generators (2 in search tree, 4998 by composition)
lola: representing 10000 symmetries
lola: 0 dead branches visited in search tree
lola: STP completed || 1 tries, 178338 fired transitions, 20 secs || 2986 markings, 5759 edges, 597 markings/sec, 20 secs
lola: STP completed || 1 tries, 211284 fired transitions, 25 secs || 7507 markings, 15629 edges, 904 markings/sec, 25 secs
lola: STP completed || 1 tries, 242095 fired transitions, 30 secs || 12007 markings, 25825 edges, 900 markings/sec, 30 secs
lola: STP completed || 1 tries, 272593 fired transitions, 35 secs || 16177 markings, 36054 edges, 834 markings/sec, 35 secs
lola: STP completed || 1 tries, 301803 fired transitions, 40 secs || 20834 markings, 46170 edges, 931 markings/sec, 40 secs
lola: STP completed || 1 tries, 331128 fired transitions, 45 secs || 25136 markings, 56230 edges, 860 markings/sec, 45 secs
lola: STP completed || 1 tries, 359296 fired transitions, 50 secs || 29446 markings, 66572 edges, 862 markings/sec, 50 secs
lola: STP completed || 1 tries, 387594 fired transitions, 55 secs || 34130 markings, 76556 edges, 937 markings/sec, 55 secs
lola: STP completed || 1 tries, 416865 fired transitions, 60 secs || 38340 markings, 86703 edges, 842 markings/sec, 60 secs
lola: STP completed || 1 tries, 442713 fired transitions, 65 secs || 42753 markings, 96906 edges, 883 markings/sec, 65 secs
lola: STP completed || 1 tries, 464183 fired transitions, 70 secs || 47635 markings, 107008 edges, 976 markings/sec, 70 secs
lola: STP completed || 1 tries, 485253 fired transitions, 75 secs || 52315 markings, 117140 edges, 936 markings/sec, 75 secs
lola: STP completed || 1 tries, 508392 fired transitions, 80 secs || 56472 markings, 127488 edges, 831 markings/sec, 80 secs
lola: STP completed || 1 tries, 531201 fired transitions, 85 secs || 61736 markings, 137433 edges, 1053 markings/sec, 85 secs
lola: STP completed || 1 tries, 553979 fired transitions, 90 secs || 66159 markings, 147812 edges, 885 markings/sec, 90 secs
lola: STP completed || 1 tries, 578338 fired transitions, 95 secs || 71005 markings, 157863 edges, 969 markings/sec, 95 secs
lola: STP completed || 1 tries, 603837 fired transitions, 100 secs || 75301 markings, 168396 edges, 859 markings/sec, 100 secs
lola: STP completed || 1 tries, 627194 fired transitions, 105 secs || 80015 markings, 178717 edges, 943 markings/sec, 105 secs
lola: STP completed || 1 tries, 648694 fired transitions, 110 secs || 84578 markings, 188849 edges, 913 markings/sec, 110 secs
lola: STP completed || 1 tries, 670330 fired transitions, 115 secs || 89221 markings, 199017 edges, 929 markings/sec, 115 secs
lola: STP completed || 1 tries, 692709 fired transitions, 120 secs || 93856 markings, 209147 edges, 927 markings/sec, 120 secs
lola: STP completed || 1 tries, 713305 fired transitions, 125 secs || 98345 markings, 219102 edges, 898 markings/sec, 125 secs
lola: STP completed || 1 tries, 733773 fired transitions, 130 secs || 102469 markings, 229473 edges, 825 markings/sec, 130 secs
lola: STP completed || 1 tries, 751408 fired transitions, 135 secs || 106551 markings, 240107 edges, 816 markings/sec, 135 secs
lola: STP completed || 1 tries, 767140 fired transitions, 140 secs || 110780 markings, 250474 edges, 846 markings/sec, 140 secs
lola: STP completed || 1 tries, 783142 fired transitions, 145 secs || 115169 markings, 260686 edges, 878 markings/sec, 145 secs
lola: STP completed || 1 tries, 801037 fired transitions, 150 secs || 120099 markings, 270765 edges, 986 markings/sec, 150 secs
lola: STP completed || 1 tries, 819279 fired transitions, 155 secs || 124737 markings, 280932 edges, 928 markings/sec, 155 secs
lola: STP completed || 1 tries, 837476 fired transitions, 160 secs || 129022 markings, 290794 edges, 857 markings/sec, 160 secs
lola: STP completed || 1 tries, 855615 fired transitions, 165 secs || 133156 markings, 300987 edges, 827 markings/sec, 165 secs
lola: STP completed || 1 tries, 873874 fired transitions, 170 secs || 137541 markings, 311013 edges, 877 markings/sec, 170 secs
lola: STP completed || 1 tries, 892008 fired transitions, 175 secs || 141600 markings, 321360 edges, 812 markings/sec, 175 secs
lola: STP completed || 1 tries, 909814 fired transitions, 180 secs || 146170 markings, 331611 edges, 914 markings/sec, 180 secs
lola: STP completed || 1 tries, 928291 fired transitions, 185 secs || 150621 markings, 341946 edges, 890 markings/sec, 185 secs
lola: STP completed || 1 tries, 946597 fired transitions, 190 secs || 154869 markings, 352033 edges, 850 markings/sec, 190 secs
lola: STP completed || 1 tries, 964460 fired transitions, 195 secs || 158876 markings, 362598 edges, 801 markings/sec, 195 secs
lola: STP completed || 1 tries, 981949 fired transitions, 200 secs || 163082 markings, 372881 edges, 841 markings/sec, 200 secs
lola: STP completed || 1 tries, 999228 fired transitions, 205 secs || 167098 markings, 383468 edges, 803 markings/sec, 205 secs
lola: STP completed || 2 tries, 1043215 fired transitions, 210 secs || 171192 markings, 393784 edges, 819 markings/sec, 210 secs
lola: STP completed || 2 tries, 1086652 fired transitions, 215 secs || 175531 markings, 404744 edges, 868 markings/sec, 215 secs
lola: STP completed || 2 tries, 1144971 fired transitions, 220 secs || 179890 markings, 415199 edges, 872 markings/sec, 220 secs
lola: STP completed || 2 tries, 1200407 fired transitions, 225 secs || 184918 markings, 425183 edges, 1006 markings/sec, 225 secs
lola: STP completed || 2 tries, 1239713 fired transitions, 230 secs || 189809 markings, 435281 edges, 978 markings/sec, 230 secs
lola: STP completed || 2 tries, 1287275 fired transitions, 235 secs || 195070 markings, 445269 edges, 1052 markings/sec, 235 secs
lola: STP completed || 2 tries, 1329299 fired transitions, 240 secs || 199865 markings, 455581 edges, 959 markings/sec, 240 secs
lola: STP completed || 2 tries, 1362169 fired transitions, 245 secs || 204130 markings, 465404 edges, 853 markings/sec, 245 secs
lola: STP completed || 2 tries, 1393615 fired transitions, 250 secs || 208466 markings, 475564 edges, 867 markings/sec, 250 secs
lola: STP completed || 2 tries, 1423344 fired transitions, 255 secs || 212947 markings, 485751 edges, 896 markings/sec, 255 secs
lola: STP completed || 2 tries, 1446647 fired transitions, 260 secs || 217268 markings, 495675 edges, 864 markings/sec, 260 secs
lola: STP completed || 2 tries, 1465322 fired transitions, 265 secs || 221234 markings, 506011 edges, 793 markings/sec, 265 secs
lola: STP completed || 2 tries, 1487286 fired transitions, 270 secs || 225729 markings, 516061 edges, 899 markings/sec, 270 secs
lola: STP completed || 2 tries, 1512650 fired transitions, 275 secs || 230109 markings, 526207 edges, 876 markings/sec, 275 secs
lola: STP completed || 2 tries, 1536262 fired transitions, 280 secs || 234147 markings, 536762 edges, 808 markings/sec, 280 secs
lola: STP completed || 2 tries, 1558643 fired transitions, 285 secs || 238284 markings, 547422 edges, 827 markings/sec, 285 secs
lola: STP completed || 2 tries, 1580468 fired transitions, 290 secs || 242927 markings, 557762 edges, 929 markings/sec, 290 secs
lola: STP completed || 2 tries, 1604129 fired transitions, 295 secs || 247188 markings, 569543 edges, 852 markings/sec, 295 secs
lola: STP completed || 2 tries, 1629441 fired transitions, 300 secs || 251395 markings, 580134 edges, 841 markings/sec, 300 secs
lola: STP completed || 2 tries, 1655102 fired transitions, 305 secs || 255504 markings, 590562 edges, 822 markings/sec, 305 secs
lola: STP completed || 2 tries, 1679393 fired transitions, 310 secs || 259610 markings, 601071 edges, 821 markings/sec, 310 secs
lola: STP completed || 2 tries, 1704064 fired transitions, 315 secs || 263837 markings, 611653 edges, 845 markings/sec, 315 secs
lola: STP completed || 2 tries, 1728491 fired transitions, 320 secs || 268453 markings, 621969 edges, 923 markings/sec, 320 secs
lola: STP completed || 2 tries, 1755422 fired transitions, 325 secs || 272917 markings, 632302 edges, 893 markings/sec, 325 secs
lola: STP completed || 2 tries, 1785360 fired transitions, 330 secs || 277598 markings, 642657 edges, 936 markings/sec, 330 secs
lola: STP completed || 2 tries, 1812829 fired transitions, 335 secs || 281506 markings, 653376 edges, 782 markings/sec, 335 secs
lola: STP completed || 2 tries, 1835390 fired transitions, 340 secs || 285727 markings, 663021 edges, 844 markings/sec, 340 secs
lola: STP completed || 2 tries, 1857580 fired transitions, 345 secs || 289856 markings, 672173 edges, 826 markings/sec, 345 secs
lola: STP completed || 2 tries, 1880500 fired transitions, 350 secs || 293851 markings, 681412 edges, 799 markings/sec, 350 secs
lola: STP completed || 2 tries, 1904811 fired transitions, 355 secs || 298712 markings, 690984 edges, 972 markings/sec, 355 secs
lola: STP completed || 2 tries, 1928970 fired transitions, 360 secs || 303542 markings, 700825 edges, 966 markings/sec, 360 secs
lola: STP completed || 2 tries, 1953368 fired transitions, 365 secs || 307323 markings, 710744 edges, 756 markings/sec, 365 secs
lola: STP completed || 2 tries, 1978450 fired transitions, 370 secs || 311437 markings, 720278 edges, 823 markings/sec, 370 secs
lola: STP completed || 3 tries, 2001094 fired transitions, 375 secs || 316681 markings, 730174 edges, 1049 markings/sec, 375 secs
Killed
FORMULA Philosophers-COL-005000-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 1496339724204

--------------------
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="S_Philosophers-PT-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/S_Philosophers-PT-005000.tgz
mv S_Philosophers-PT-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 S_Philosophers-PT-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 r128-smll-149441681300215"
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 ;