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 808K
-rw-r--r-- 1 mcc users 6.2K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 28K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 16K May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 62K 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.0K May 15 18:50 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.1K May 15 18:54 LTLCardinality.txt
-rw-r--r-- 1 mcc users 13K May 15 18:54 LTLCardinality.xml
-rw-r--r-- 1 mcc users 5.6K May 15 18:54 LTLFireability.txt
-rw-r--r-- 1 mcc users 24K May 15 18:54 LTLFireability.xml
-rw-r--r-- 1 mcc users 7.7K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 32K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 104 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 342 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 22K May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 83K May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.5K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 5.7K 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 448K May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool lola
Input is SafeBus-PT-06, examination is ReachabilityDeadlock
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r148-smll-152685547200237
=====================================================================

--------------------
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 SafeBus-PT-06-ReachabilityDeadlock-0

=== Now, execution of the tool begins

BK_START 1527027431497

info: Time: 3600 - MCC
===========================================================================================
prep: translating SafeBus-PT-06 Petri net model.pnml into LoLA format
===========================================================================================
prep: translating PT Petri net complete
prep: check for too many tokens
===========================================================================================
prep: translating SafeBus-PT-06 formula ReachabilityDeadlock into LoLA format
===========================================================================================
prep: translating PT formula complete
vrfy: Checking ReachabilityDeadlock @ SafeBus-PT-06 @ 3570 seconds
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 595/65536 symbol table entries, 15 collisions
lola: preprocessing...
lola: Size of bit vector: 4608
lola: finding significant places
lola: 144 places, 451 transitions, 109 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 375 transition conflict sets
lola: TASK
lola: reading formula from SafeBus-PT-06-ReachabilityDeadlock.task
lola: E (F (DEADLOCK))
lola: rewrite Frontend/Parser/formula_rewrite.k:106
lola: checking reachability of deadlocks
lola: Planning: workflow for deadlock check: siphon||findpath||search) (--findpath=par,--siphontrap=par)
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
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: computed 35 generators (7 in search tree, 28 by composition)
lola: representing 720 symmetries
lola: 0 dead branches visited in search tree
lola: STP: formula with 7449 variables and 43216 clauses shipped to Minisat
lola: stp: The siphon/trap property does not hold
lola: STP completed || 1 tries, 48636 fired transitions, 0 secs || 46730 markings, 78135 edges, 9346 markings/sec, 0 secs
lola: STP completed || 1 tries, 100454 fired transitions, 5 secs || 94802 markings, 172357 edges, 9614 markings/sec, 5 secs
lola: STP completed || 1 tries, 152337 fired transitions, 10 secs || 142654 markings, 272833 edges, 9570 markings/sec, 10 secs
lola: STP completed || 1 tries, 204128 fired transitions, 15 secs || 190276 markings, 377894 edges, 9524 markings/sec, 15 secs
lola: STP completed || 1 tries, 256207 fired transitions, 20 secs || 238678 markings, 489563 edges, 9680 markings/sec, 20 secs
lola: STP completed || 1 tries, 308226 fired transitions, 25 secs || 286005 markings, 598473 edges, 9465 markings/sec, 25 secs
lola: STP completed || 1 tries, 360211 fired transitions, 30 secs || 333698 markings, 709067 edges, 9539 markings/sec, 30 secs
lola: STP completed || 1 tries, 412050 fired transitions, 35 secs || 380493 markings, 819492 edges, 9359 markings/sec, 35 secs
lola: STP completed || 1 tries, 463831 fired transitions, 40 secs || 427644 markings, 932324 edges, 9430 markings/sec, 40 secs
lola: STP completed || 1 tries, 515823 fired transitions, 45 secs || 474261 markings, 1046084 edges, 9323 markings/sec, 45 secs
lola: STP completed || 1 tries, 567681 fired transitions, 50 secs || 520813 markings, 1160677 edges, 9310 markings/sec, 50 secs
lola: STP completed || 1 tries, 619648 fired transitions, 55 secs || 567434 markings, 1278438 edges, 9324 markings/sec, 55 secs
lola: STP completed || 1 tries, 671207 fired transitions, 60 secs || 613712 markings, 1394042 edges, 9256 markings/sec, 60 secs
lola: STP completed || 1 tries, 723181 fired transitions, 65 secs || 660663 markings, 1513897 edges, 9390 markings/sec, 65 secs
lola: STP completed || 1 tries, 775088 fired transitions, 70 secs || 706749 markings, 1634428 edges, 9217 markings/sec, 70 secs
lola: STP completed || 1 tries, 827020 fired transitions, 75 secs || 753441 markings, 1758049 edges, 9338 markings/sec, 75 secs
lola: STP completed || 1 tries, 878810 fired transitions, 80 secs || 800295 markings, 1883142 edges, 9371 markings/sec, 80 secs
lola: STP completed || 1 tries, 930627 fired transitions, 85 secs || 846681 markings, 2009662 edges, 9277 markings/sec, 85 secs
lola: STP completed || 1 tries, 982606 fired transitions, 90 secs || 892773 markings, 2136608 edges, 9218 markings/sec, 90 secs
lola: STP completed || 2 tries, 1034948 fired transitions, 95 secs || 939174 markings, 2266702 edges, 9280 markings/sec, 95 secs
lola: STP completed || 2 tries, 1087042 fired transitions, 100 secs || 985619 markings, 2397688 edges, 9289 markings/sec, 100 secs
lola: STP completed || 2 tries, 1139286 fired transitions, 105 secs || 1032600 markings, 2530747 edges, 9396 markings/sec, 105 secs
lola: STP completed || 2 tries, 1191396 fired transitions, 110 secs || 1078829 markings, 2665477 edges, 9246 markings/sec, 110 secs
lola: STP completed || 2 tries, 1243418 fired transitions, 115 secs || 1125024 markings, 2801916 edges, 9239 markings/sec, 115 secs
lola: STP completed || 2 tries, 1295721 fired transitions, 120 secs || 1171037 markings, 2936984 edges, 9203 markings/sec, 120 secs
lola: STP completed || 2 tries, 1347746 fired transitions, 125 secs || 1216837 markings, 3073079 edges, 9160 markings/sec, 125 secs
lola: STP completed || 2 tries, 1394816 fired transitions, 130 secs || 1262871 markings, 3208146 edges, 9207 markings/sec, 130 secs
lola: STP completed || 2 tries, 1444471 fired transitions, 135 secs || 1308606 markings, 3343272 edges, 9147 markings/sec, 135 secs
lola: STP completed || 2 tries, 1496654 fired transitions, 140 secs || 1354291 markings, 3481147 edges, 9137 markings/sec, 140 secs
lola: STP completed || 2 tries, 1548632 fired transitions, 145 secs || 1399654 markings, 3619669 edges, 9073 markings/sec, 145 secs
lola: STP completed || 2 tries, 1600502 fired transitions, 150 secs || 1445667 markings, 3760416 edges, 9203 markings/sec, 150 secs
lola: STP completed || 2 tries, 1652272 fired transitions, 155 secs || 1491279 markings, 3902310 edges, 9122 markings/sec, 155 secs
lola: STP completed || 2 tries, 1705450 fired transitions, 160 secs || 1537865 markings, 4049076 edges, 9317 markings/sec, 160 secs
lola: STP completed || 2 tries, 1758671 fired transitions, 165 secs || 1584137 markings, 4195358 edges, 9254 markings/sec, 165 secs
lola: STP completed || 2 tries, 1811954 fired transitions, 170 secs || 1630979 markings, 4344881 edges, 9368 markings/sec, 170 secs
lola: STP completed || 2 tries, 1865429 fired transitions, 175 secs || 1677255 markings, 4494755 edges, 9255 markings/sec, 175 secs
lola: STP completed || 2 tries, 1919081 fired transitions, 180 secs || 1724046 markings, 4648308 edges, 9358 markings/sec, 180 secs
lola: STP completed || 2 tries, 1972473 fired transitions, 185 secs || 1770735 markings, 4804429 edges, 9338 markings/sec, 185 secs
lola: STP completed || 3 tries, 2021866 fired transitions, 190 secs || 1816245 markings, 4957384 edges, 9102 markings/sec, 190 secs
lola: STP completed || 3 tries, 2073516 fired transitions, 195 secs || 1860763 markings, 5107929 edges, 8904 markings/sec, 195 secs
lola: STP completed || 3 tries, 2125669 fired transitions, 200 secs || 1905707 markings, 5260673 edges, 8989 markings/sec, 200 secs
lola: STP completed || 3 tries, 2177573 fired transitions, 205 secs || 1950060 markings, 5412092 edges, 8871 markings/sec, 205 secs
lola: STP completed || 3 tries, 2231177 fired transitions, 210 secs || 1996701 markings, 5574803 edges, 9328 markings/sec, 210 secs
lola: STP completed || 3 tries, 2283921 fired transitions, 215 secs || 2039201 markings, 5722242 edges, 8500 markings/sec, 215 secs
lola: STP completed || 3 tries, 2336700 fired transitions, 220 secs || 2084076 markings, 5880073 edges, 8975 markings/sec, 220 secs
lola: STP completed || 3 tries, 2389641 fired transitions, 225 secs || 2129668 markings, 6043604 edges, 9118 markings/sec, 225 secs
lola: STP completed || 3 tries, 2442283 fired transitions, 230 secs || 2174481 markings, 6204734 edges, 8963 markings/sec, 230 secs
lola: STP completed || 3 tries, 2495117 fired transitions, 235 secs || 2218888 markings, 6367685 edges, 8881 markings/sec, 235 secs
lola: STP completed || 3 tries, 2548124 fired transitions, 240 secs || 2263593 markings, 6532496 edges, 8941 markings/sec, 240 secs
lola: STP completed || 3 tries, 2600785 fired transitions, 245 secs || 2307987 markings, 6697608 edges, 8879 markings/sec, 245 secs
lola: STP completed || 3 tries, 2653740 fired transitions, 250 secs || 2353661 markings, 6873168 edges, 9135 markings/sec, 250 secs
lola: STP completed || 3 tries, 2706215 fired transitions, 255 secs || 2398548 markings, 7045616 edges, 8977 markings/sec, 255 secs
lola: STP completed || 3 tries, 2759406 fired transitions, 260 secs || 2445548 markings, 7228856 edges, 9400 markings/sec, 260 secs
lola: STP completed || 3 tries, 2809516 fired transitions, 265 secs || 2492180 markings, 7413028 edges, 9326 markings/sec, 265 secs
lola: STP completed || 3 tries, 2862478 fired transitions, 270 secs || 2538129 markings, 7595654 edges, 9190 markings/sec, 270 secs
lola: STP completed || 3 tries, 2915039 fired transitions, 275 secs || 2583431 markings, 7776485 edges, 9060 markings/sec, 275 secs
lola: STP completed || 3 tries, 2967785 fired transitions, 280 secs || 2629273 markings, 7962768 edges, 9168 markings/sec, 280 secs
lola: STP completed || 4 tries, 3020593 fired transitions, 285 secs || 2674487 markings, 8145580 edges, 9043 markings/sec, 285 secs
lola: STP completed || 4 tries, 3073211 fired transitions, 290 secs || 2720089 markings, 8332512 edges, 9120 markings/sec, 290 secs
lola: STP completed || 4 tries, 3126311 fired transitions, 295 secs || 2766819 markings, 8525115 edges, 9346 markings/sec, 295 secs
lola: STP completed || 4 tries, 3179356 fired transitions, 300 secs || 2813716 markings, 8718990 edges, 9379 markings/sec, 300 secs
lola: STP completed || 4 tries, 3232949 fired transitions, 305 secs || 2861979 markings, 8925460 edges, 9653 markings/sec, 305 secs
lola: STP completed || 4 tries, 3286239 fired transitions, 310 secs || 2909862 markings, 9130738 edges, 9577 markings/sec, 310 secs
lola: STP completed || 4 tries, 3339636 fired transitions, 315 secs || 2957949 markings, 9340125 edges, 9617 markings/sec, 315 secs
lola: STP completed || 4 tries, 3392673 fired transitions, 320 secs || 3004234 markings, 9544351 edges, 9257 markings/sec, 320 secs
lola: STP completed || 4 tries, 3445794 fired transitions, 325 secs || 3050594 markings, 9750860 edges, 9272 markings/sec, 325 secs
lola: STP completed || 4 tries, 3499887 fired transitions, 330 secs || 3101144 markings, 9988571 edges, 10110 markings/sec, 330 secs
lola: STP completed || 4 tries, 3550690 fired transitions, 335 secs || 3147370 markings, 10210628 edges, 9245 markings/sec, 335 secs
lola: STP completed || 4 tries, 3605356 fired transitions, 340 secs || 3198781 markings, 10469905 edges, 10282 markings/sec, 340 secs
lola: STP completed || 4 tries, 3659140 fired transitions, 345 secs || 3248664 markings, 10731753 edges, 9977 markings/sec, 345 secs
lola: STP completed || 4 tries, 3712039 fired transitions, 350 secs || 3294764 markings, 10985934 edges, 9220 markings/sec, 350 secs
lola: STP completed || 4 tries, 3765123 fired transitions, 355 secs || 3341260 markings, 11256689 edges, 9299 markings/sec, 355 secs
lola: STP completed || 4 tries, 3816500 fired transitions, 360 secs || 3379503 markings, 11511577 edges, 7649 markings/sec, 360 secs
lola: STP completed || 4 tries, 3865591 fired transitions, 365 secs || 3406639 markings, 11767264 edges, 5427 markings/sec, 365 secs
lola: STP completed || 4 tries, 3913705 fired transitions, 370 secs || 3428330 markings, 12059276 edges, 4338 markings/sec, 370 secs
lola: STP completed || 4 tries, 3960103 fired transitions, 375 secs || 3447547 markings, 12373706 edges, 3843 markings/sec, 375 secs
lola: STP completed || 5 tries, 4008072 fired transitions, 380 secs || 3465967 markings, 12739175 edges, 3684 markings/sec, 380 secs
lola: STP completed || 5 tries, 4054177 fired transitions, 385 secs || 3482898 markings, 13139696 edges, 3386 markings/sec, 385 secs
lola: STP completed || 5 tries, 4102008 fired transitions, 390 secs || 3499751 markings, 13606579 edges, 3371 markings/sec, 390 secs

FORMULA SafeBus-PT-06-ReachabilityDeadlock-0 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT SAT_SMT STATE_COMPRESSION STUBBORN_SETS SYMMETRIES TOPOLOGICAL USE_NUPN UNFOLDING_TO_PT
lola: RESULT
lola: result: no
lola: produced by: state space
lola: The net does not have deadlocks.
lola: 3507782 markings, 13879047 edges
lola: memory consumption: 200692 KB
lola: time consumption: 398 seconds

BK_STOP 1527027829274

--------------------
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="SafeBus-PT-06"
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/SafeBus-PT-06.tgz
mv SafeBus-PT-06 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 lola"
echo " Input is SafeBus-PT-06, 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 r148-smll-152685547200237"
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 ;