Execution Chart

We display below the execution chart for this examination (boot time has been removed).

Trace from the execution

Formatting '/data/fkordon/mcc2024-input.r490-tall-171631144300047.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2024-input.qcow2 backing_fmt=qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
................
=====================================================================
Generated by BenchKit 2-5568
Executing tool ltsminxred
Input is DatabaseWithMutex-PT-40, examination is QuasiLiveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r490-tall-171631144300047
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 62M
-rw-r--r-- 1 mcc users 2.1M Apr 11 22:28 CTLCardinality.txt
-rw-r--r-- 1 mcc users 8.6M Apr 11 22:28 CTLCardinality.xml
-rw-r--r-- 1 mcc users 821K Apr 11 20:27 CTLFireability.txt
-rw-r--r-- 1 mcc users 3.8M Apr 11 20:27 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 18 16:42 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 700K Apr 22 14:39 LTLCardinality.txt
-rw-r--r-- 1 mcc users 2.0M Apr 22 14:39 LTLCardinality.xml
-rw-r--r-- 1 mcc users 796K Apr 22 14:39 LTLFireability.txt
-rw-r--r-- 1 mcc users 2.8M Apr 22 14:39 LTLFireability.xml
-rw-r--r-- 1 mcc users 2.2M Apr 12 03:03 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 8.9M Apr 12 03:03 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.2M Apr 12 01:19 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 9.8M Apr 12 01:19 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 195K Apr 22 14:39 UpperBounds.txt
-rw-r--r-- 1 mcc users 427K Apr 22 14:39 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 18 16:42 equiv_col
-rw-r--r-- 1 mcc users 3 May 18 16:42 instance
-rw-r--r-- 1 mcc users 6 May 18 16:42 iscolored
-rw-r--r-- 1 mcc users 17M May 18 16:42 model.pnml

--------------------
content from stdout:

=== Data for post analysis generated by BenchKit (invocation template)

The expected result is a vector of booleans
BOOL_VECTOR

FORMULA_NAME QuasiLiveness

=== Now, execution of the tool begins

BK_START 1717181943493

Invoking MCC driver with
BK_TOOL=ltsminxred
BK_EXAMINATION=QuasiLiveness
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=DatabaseWithMutex-PT-40
BK_MEMORY_CONFINEMENT=16384
Applying reductions before tool ltsmin
Invoking reducer
Running Version 202405141337
[2024-05-31 18:59:04] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, QuasiLiveness, -timeout, 180, -rebuildPNML]
[2024-05-31 18:59:04] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2024-05-31 18:59:05] [INFO ] Load time of PNML (sax parser for PT used): 833 ms
[2024-05-31 18:59:05] [INFO ] Transformed 12920 places.
[2024-05-31 18:59:05] [INFO ] Transformed 12800 transitions.
[2024-05-31 18:59:05] [INFO ] Found NUPN structural information;
[2024-05-31 18:59:05] [INFO ] Parsed PT model containing 12920 places and 12800 transitions and 156800 arcs in 1122 ms.
Starting structural reductions in LIVENESS mode, iteration 0 : 12920/12920 places, 12800/12800 transitions.
Drop transitions (Trivial Post-Agglo cleanup.) removed 3200 transitions
Trivial Post-agglo rules discarded 3200 transitions
Performed 3200 trivial Post agglomeration. Transition count delta: 3200
Iterating post reduction 0 with 3200 rules applied. Total rules applied 3200 place count 12920 transition count 9600
Reduce places removed 3240 places and 0 transitions.
Drop transitions (Trivial Post-Agglo cleanup.) removed 3200 transitions
Trivial Post-agglo rules discarded 3200 transitions
Performed 3200 trivial Post agglomeration. Transition count delta: 3200
Iterating post reduction 1 with 6440 rules applied. Total rules applied 9640 place count 9680 transition count 6400
Reduce places removed 3200 places and 0 transitions.
Iterating post reduction 2 with 3200 rules applied. Total rules applied 12840 place count 6480 transition count 6400
Performed 1600 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 1600 Pre rules applied. Total rules applied 12840 place count 6480 transition count 4800
Renaming transitions due to excessive name length > 1024 char.
Deduced a syphon composed of 1600 places in 14 ms
Reduce places removed 1600 places and 0 transitions.
Iterating global reduction 3 with 3200 rules applied. Total rules applied 16040 place count 4880 transition count 4800
Applied a total of 16040 rules in 2127 ms. Remains 4880 /12920 variables (removed 8040) and now considering 4800/12800 (removed 8000) transitions.
// Phase 1: matrix 4800 rows 4880 cols
[2024-05-31 18:59:08] [INFO ] Computed 1680 invariants in 543 ms
[2024-05-31 18:59:40] [INFO ] Performed 224/4880 implicitness test of which 165 returned IMPLICIT in 30 seconds.
[2024-05-31 19:00:20] [INFO ] Performed 295/4880 implicitness test of which 204 returned IMPLICIT in 70 seconds.
[2024-05-31 19:00:58] [INFO ] Performed 466/4880 implicitness test of which 314 returned IMPLICIT in 108 seconds.
[2024-05-31 19:01:42] [INFO ] Performed 587/4880 implicitness test of which 390 returned IMPLICIT in 151 seconds.
[2024-05-31 19:01:48] [INFO ] Implicit Places using invariants in 160618 ms returned [1, 2, 4, 6, 7, 8, 9, 10, 11, 15, 20, 21, 23, 25, 26, 27, 29, 30, 32, 33, 34, 35, 36, 37, 38, 39, 40, 41, 42, 44, 45, 46, 47, 49, 50, 51, 53, 54, 56, 58, 61, 64, 65, 66, 67, 68, 69, 70, 72, 74, 77, 78, 79, 81, 82, 84, 85, 86, 87, 88, 89, 90, 91, 93, 96, 97, 98, 99, 100, 101, 103, 104, 105, 106, 107, 108, 109, 110, 111, 112, 113, 114, 115, 117, 119, 120, 121, 123, 124, 125, 126, 127, 128, 130, 131, 132, 133, 134, 136, 137, 138, 140, 141, 143, 144, 145, 146, 147, 148, 150, 151, 152, 153, 154, 155, 157, 158, 159, 161, 162, 164, 165, 167, 169, 170, 171, 172, 174, 177, 178, 179, 180, 181, 182, 183, 184, 185, 186, 188, 190, 191, 192, 194, 195, 196, 197, 198, 199, 201, 203, 204, 206, 207, 208, 209, 211, 213, 214, 215, 217, 218, 219, 221, 222, 224, 226, 227, 230, 232, 233, 235, 237, 238, 239, 240, 241, 243, 244, 245, 246, 250, 251, 254, 255, 259, 261, 263, 264, 265, 266, 268, 269, 270, 278, 279, 281, 282, 283, 284, 285, 286, 289, 291, 292, 296, 298, 299, 300, 302, 303, 304, 305, 307, 308, 312, 315, 318, 319, 320, 322, 323, 324, 325, 326, 327, 328, 329, 331, 332, 333, 335, 336, 338, 339, 343, 344, 345, 346, 348, 350, 351, 353, 355, 356, 357, 358, 359, 360, 361, 362, 364, 367, 369, 373, 376, 377, 378, 382, 383, 385, 386, 387, 388, 389, 392, 395, 396, 398, 400, 401, 404, 405, 407, 408, 411, 412, 413, 414, 416, 417, 418, 419, 420, 421, 422, 423, 424, 425, 426, 427, 428, 431, 433, 434, 436, 439, 441, 442, 443, 444, 445, 446, 448, 449, 450, 451, 452, 453, 454, 455, 460, 461, 462, 465, 467, 469, 471, 472, 474, 476, 477, 478, 479, 481, 482, 485, 487, 488, 489, 490, 491, 493, 494, 495, 498, 499, 500, 501, 502, 503, 507, 509, 511, 513, 515, 519, 520, 521, 522, 523, 525, 531, 532, 533, 534, 535, 536, 538, 539, 540, 543, 544, 545, 548, 549, 550, 551, 553, 554, 555, 557, 558, 559, 560, 563, 564, 565, 566, 567, 568, 569, 570, 573, 574, 575, 576, 577, 584, 585, 586, 588, 589, 590, 591, 592, 593, 594, 596, 597, 598, 602, 604, 605, 607, 608, 610, 611, 612, 613, 618, 619, 621, 622, 625, 626, 627, 628, 630, 631, 633, 634, 635, 636, 638, 639, 641, 643, 644, 645, 647, 649, 650, 651, 653, 654, 655, 656]
[2024-05-31 19:01:48] [INFO ] Actually due to overlaps returned [2, 10, 11, 21, 23, 25, 27, 30, 35, 37, 42, 44, 65, 74, 78, 88, 90, 97, 98, 100, 109, 124, 130, 133, 144, 145, 152, 167, 183, 188, 201, 211, 215, 235, 238, 282, 303, 312, 343, 369, 300, 602]
Discarding 42 places :
Implicit Place search using SMT only with invariants took 160677 ms to find 42 implicit places.
Starting structural reductions in LIVENESS mode, iteration 1 : 4838/12920 places, 4800/12800 transitions.
Applied a total of 0 rules in 77 ms. Remains 4838 /4838 variables (removed 0) and now considering 4800/4800 (removed 0) transitions.
Finished structural reductions in LIVENESS mode , in 2 iterations and 162900 ms. Remains : 4838/12920 places, 4800/12800 transitions.
Discarding 1560 transitions out of 4800. Remains 3240
Initial state reduction rules removed 40 formulas.
RANDOM walk for 40000 steps (8 resets) in 19779 ms. (2 steps per ms) remains 1/3200 properties
BEST_FIRST walk for 40004 steps (8 resets) in 393 ms. (101 steps per ms) remains 1/1 properties
// Phase 1: matrix 4800 rows 4838 cols
[2024-05-31 19:01:54] [INFO ] Computed 1638 invariants in 335 ms
At refinement iteration 0 (INCLUDED_ONLY) 0/39 variables, 39/39 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/39 variables, 0/39 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 2 (OVERLAPS) 2/41 variables, 1/40 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 3 (INCLUDED_ONLY) 0/41 variables, 2/42 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 4 (INCLUDED_ONLY) 0/41 variables, 0/42 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 5 (OVERLAPS) 2682/2723 variables, 56/98 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 6 (INCLUDED_ONLY) 0/2723 variables, 2682/2780 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 7 (INCLUDED_ONLY) 0/2723 variables, 0/2780 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 8 (OVERLAPS) 179/2902 variables, 109/2889 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 9 (INCLUDED_ONLY) 0/2902 variables, 179/3068 constraints. Problems are: Problem set: 0 solved, 1 unsolved
[2024-05-31 19:01:56] [INFO ] Deduced a trap composed of 3 places in 131 ms of which 13 ms to minimize.
[2024-05-31 19:01:56] [INFO ] Deduced a trap composed of 3 places in 139 ms of which 1 ms to minimize.
[2024-05-31 19:01:56] [INFO ] Deduced a trap composed of 3 places in 105 ms of which 1 ms to minimize.
[2024-05-31 19:01:56] [INFO ] Deduced a trap composed of 3 places in 126 ms of which 1 ms to minimize.
[2024-05-31 19:01:56] [INFO ] Deduced a trap composed of 3 places in 105 ms of which 1 ms to minimize.
At refinement iteration 10 (INCLUDED_ONLY) 0/2902 variables, 5/3073 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 11 (INCLUDED_ONLY) 0/2902 variables, 0/3073 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 12 (OVERLAPS) 12/2914 variables, 6/3079 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 13 (INCLUDED_ONLY) 0/2914 variables, 12/3091 constraints. Problems are: Problem set: 0 solved, 1 unsolved
[2024-05-31 19:01:57] [INFO ] Deduced a trap composed of 3 places in 132 ms of which 1 ms to minimize.
[2024-05-31 19:01:57] [INFO ] Deduced a trap composed of 3 places in 108 ms of which 1 ms to minimize.
[2024-05-31 19:01:57] [INFO ] Deduced a trap composed of 3 places in 119 ms of which 1 ms to minimize.
[2024-05-31 19:01:57] [INFO ] Deduced a trap composed of 3 places in 101 ms of which 1 ms to minimize.
[2024-05-31 19:01:57] [INFO ] Deduced a trap composed of 3 places in 97 ms of which 1 ms to minimize.
At refinement iteration 14 (INCLUDED_ONLY) 0/2914 variables, 5/3096 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 15 (INCLUDED_ONLY) 0/2914 variables, 0/3096 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 16 (OVERLAPS) 1924/4838 variables, 1466/4562 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 17 (INCLUDED_ONLY) 0/4838 variables, 1924/6486 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 18 (INCLUDED_ONLY) 0/4838 variables, 0/6486 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SMT process timed out in 5481ms, After SMT, problems are : Problem set: 0 solved, 1 unsolved
Skipping Parikh replay, no witness traces provided.
Support contains 39 out of 4838 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 4838/4838 places, 4800/4800 transitions.
Free-agglomeration rule applied 1600 times.
Iterating global reduction 0 with 1600 rules applied. Total rules applied 1600 place count 4838 transition count 3200
Reduce places removed 1600 places and 0 transitions.
Iterating post reduction 0 with 1600 rules applied. Total rules applied 3200 place count 3238 transition count 3200
Applied a total of 3200 rules in 218997 ms. Remains 3238 /4838 variables (removed 1600) and now considering 3200/4800 (removed 1600) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 219001 ms. Remains : 3238/4838 places, 3200/4800 transitions.
RANDOM walk for 11415 steps (0 resets) in 3778 ms. (3 steps per ms) remains 0/1 properties
Able to resolve query QuasiLiveness after proving 3240 properties.
FORMULA QuasiLiveness TRUE TECHNIQUES RANDOM_WALK TOPOLOGICAL INITIAL_STATE
Total runtime 396350 ms.
ITS solved all properties within timeout

BK_STOP 1717182340970

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

+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202405141337.jar
+ VERSION=202405141337
+ echo 'Running Version 202405141337'
+ /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/its-tools -pnfolder /home/mcc/execution -examination QuasiLiveness -timeout 180 -rebuildPNML

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-PT-40"
export BK_EXAMINATION="QuasiLiveness"
export BK_TOOL="ltsminxred"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# 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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-5568"
echo " Executing tool ltsminxred"
echo " Input is DatabaseWithMutex-PT-40, examination is QuasiLiveness"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r490-tall-171631144300047"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/DatabaseWithMutex-PT-40.tgz
mv DatabaseWithMutex-PT-40 execution
cd execution
if [ "QuasiLiveness" = "ReachabilityDeadlock" ] || [ "QuasiLiveness" = "UpperBounds" ] || [ "QuasiLiveness" = "QuasiLiveness" ] || [ "QuasiLiveness" = "StableMarking" ] || [ "QuasiLiveness" = "Liveness" ] || [ "QuasiLiveness" = "OneSafe" ] || [ "QuasiLiveness" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "QuasiLiveness" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "QuasiLiveness" != "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 "QuasiLiveness.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property QuasiLiveness.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "QuasiLiveness.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 '' QuasiLiveness.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "QuasiLiveness" = "ReachabilityDeadlock" ] || [ "QuasiLiveness" = "QuasiLiveness" ] || [ "QuasiLiveness" = "StableMarking" ] || [ "QuasiLiveness" = "Liveness" ] || [ "QuasiLiveness" = "OneSafe" ] ; then
echo "FORMULA_NAME QuasiLiveness"
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 ;