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.r639-smll-171774449600048.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 itstools
Input is ResIsolation-PT-N09P5, examination is StableMarking
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r639-smll-171774449600048
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 211M
-rw-r--r-- 1 mcc users 5.7K Jun 7 06:38 CTLCardinality.txt
-rw-r--r-- 1 mcc users 59K Jun 7 06:38 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.3K Jun 7 06:38 CTLFireability.txt
-rw-r--r-- 1 mcc users 57K Jun 7 06:38 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.7K Jun 7 06:44 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Jun 7 06:44 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Jun 7 06:44 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Jun 7 06:44 LTLFireability.xml
-rw-r--r-- 1 mcc users 1 Jun 7 06:26 NewModel
-rw-r--r-- 1 mcc users 12K Jun 7 06:39 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 127K Jun 7 06:39 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 7.9K Jun 7 06:39 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 62K Jun 7 06:39 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Jun 7 06:43 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Jun 7 06:43 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Jun 7 06:26 equiv_col
-rw-r--r-- 1 mcc users 6 Jun 7 06:26 instance
-rw-r--r-- 1 mcc users 6 Jun 7 06:26 iscolored
-rw-r--r-- 1 mcc users 211M Jun 7 06:26 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 StableMarking

=== Now, execution of the tool begins

BK_START 1717748588827

Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=StableMarking
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=ResIsolation-PT-N09P5
BK_MEMORY_CONFINEMENT=16384
Not applying reductions.
Model is PT
StableMarking PT
Running Version 202405141337
[2024-06-07 08:23:10] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, StableMarking, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2024-06-07 08:23:10] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2024-06-07 08:23:20] [INFO ] Load time of PNML (sax parser for PT used): 9629 ms
[2024-06-07 08:23:21] [INFO ] Transformed 455 places.
[2024-06-07 08:23:21] [INFO ] Transformed 147864 transitions.
[2024-06-07 08:23:21] [INFO ] Found NUPN structural information;
[2024-06-07 08:23:21] [INFO ] Parsed PT model containing 455 places and 147864 transitions and 4129597 arcs in 11102 ms.
Graph (trivial) has 395 edges and 455 vertex of which 27 / 455 are part of one of the 9 SCC in 31 ms
Free SCC test removed 18 places
Structural test allowed to assert that 158 places are NOT stable. Took 648 ms.
Ensure Unique test removed 18 transitions
Reduce redundant transitions removed 18 transitions.
RANDOM walk for 40000 steps (516 resets) in 51642 ms. (0 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 53 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 51 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 40 ms. (9 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 56 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 36 ms. (10 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 56 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 24 ms. (16 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 71 ms. (5 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 52 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 27 ms. (14 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 51 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 78 ms. (5 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 78 ms. (5 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 27 ms. (14 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 54 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 54 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 58 ms. (6 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 34 ms. (11 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 47 ms. (8 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 23 ms. (16 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 55 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 47 ms. (8 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 40 ms. (9 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 40 ms. (9 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 34 ms. (11 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 42 ms. (9 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 54 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 57 ms. (6 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 30 ms. (13 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 36 ms. (10 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 37 ms. (10 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 66 ms. (6 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 25 ms. (15 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 21 ms. (18 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 32 ms. (12 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 30 ms. (13 steps per ms) remains 297/297 properties
BEST_FIRST walk for 402 steps (8 resets) in 56 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 18 ms. (21 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 27 ms. (14 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 47 ms. (8 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 25 ms. (15 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 47 ms. (8 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 28 ms. (13 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 24 ms. (16 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 24 ms. (16 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 36 ms. (10 steps per ms) remains 297/297 properties
BEST_FIRST walk for 403 steps (8 resets) in 38 ms. (10 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 44 ms. (8 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 52 ms. (7 steps per ms) remains 297/297 properties
BEST_FIRST walk for 404 steps (8 resets) in 47 ms. (8 steps per ms) remains 297/297 properties
[2024-06-07 08:24:13] [INFO ] Flatten gal took : 42656 ms
Interrupted probabilistic random walk after 66872 steps, run timeout after 42001 ms. (steps per millisecond=1 ) properties seen :168 out of 297
Probabilistic random walk after 66872 steps, saw 53357 distinct states, run finished after 42012 ms. (steps per millisecond=1 ) properties seen :168
[2024-06-07 08:24:22] [INFO ] Flow matrix only has 147838 transitions (discarded 8 similar events)
// Phase 1: matrix 147838 rows 437 cols
[2024-06-07 08:24:28] [INFO ] Computed 14 invariants in 6222 ms
[2024-06-07 08:24:29] [INFO ] State equation strengthened by 1 read => feed constraints.
All remaining problems are real, not stopping.
At refinement iteration 0 (INCLUDED_ONLY) 0/129 variables, 129/129 constraints. Problems are: Problem set: 0 solved, 129 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/129 variables, 0/129 constraints. Problems are: Problem set: 0 solved, 129 unsolved
At refinement iteration 2 (OVERLAPS) 308/437 variables, 14/143 constraints. Problems are: Problem set: 0 solved, 129 unsolved
At refinement iteration 3 (INCLUDED_ONLY) 0/437 variables, 308/451 constraints. Problems are: Problem set: 0 solved, 129 unsolved
At refinement iteration 4 (INCLUDED_ONLY) 0/437 variables, 0/451 constraints. Problems are: Problem set: 0 solved, 129 unsolved
SMT process timed out in 18432ms, After SMT, problems are : Problem set: 0 solved, 129 unsolved
Skipping Parikh replay, no witness traces provided.
Support contains 129 out of 437 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 437/437 places, 147846/147846 transitions.
Graph (complete) has 6106 edges and 437 vertex of which 395 are kept as prefixes of interest. Removing 42 places using SCC suffix rule.1351 ms
Discarding 42 places :
Also discarding 28 output transitions
Drop transitions (Output transitions of discarded places.) removed 28 transitions
Drop transitions (Empty/Sink Transition effects.) removed 23 transitions
Reduce isomorphic transitions removed 23 transitions.
Drop transitions (Trivial Post-Agglo cleanup.) removed 57 transitions
Trivial Post-agglo rules discarded 57 transitions
Performed 57 trivial Post agglomeration. Transition count delta: 57
Iterating post reduction 0 with 80 rules applied. Total rules applied 81 place count 395 transition count 147738
Reduce places removed 57 places and 0 transitions.
Iterating post reduction 1 with 57 rules applied. Total rules applied 138 place count 338 transition count 147738
Discarding 126 places :
Symmetric choice reduction at 2 with 126 rule applications. Total rules 264 place count 212 transition count 147612
Iterating global reduction 2 with 126 rules applied. Total rules applied 390 place count 212 transition count 147612
Ensure Unique test removed 8 transitions
Reduce isomorphic transitions removed 8 transitions.
Iterating post reduction 2 with 8 rules applied. Total rules applied 398 place count 212 transition count 147604
[2024-06-07 08:24:54] [INFO ] Flatten gal took : 41046 ms
[2024-06-07 08:24:58] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality1019923073103528487.gal : 4015 ms
[2024-06-07 08:24:58] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality3207326022188198915.prop : 2 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality1019923073103528487.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality3207326022188198915.prop' '--nowitness' '--gen-order' 'FOLLOW'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...328
ITS-tools command line returned an error code 137
Performed 14 Post agglomeration using F-continuation condition.
[2024-06-07 08:25:57] [INFO ] Flatten gal took : 40115 ms
[2024-06-07 08:25:57] [INFO ] Applying decomposition
[2024-06-07 08:26:31] [INFO ] Flatten gal took : 34544 ms
Performed 16 Post agglomeration using F-continuation condition.
Performed 17 Post agglomeration using F-continuation condition.

BK_STOP 1717748981757

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

+ export BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ StableMarking = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution StableMarking -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ 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:
++ perl -pe 's/.*\.//g'
++ sed s/.jar//
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202405141337.jar
+ VERSION=202405141337
+ echo 'Running Version 202405141337'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination StableMarking -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800

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="ResIsolation-PT-N09P5"
export BK_EXAMINATION="StableMarking"
export BK_TOOL="itstools"
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 itstools"
echo " Input is ResIsolation-PT-N09P5, examination is StableMarking"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r639-smll-171774449600048"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/ResIsolation-PT-N09P5.tgz
mv ResIsolation-PT-N09P5 execution
cd execution
if [ "StableMarking" = "ReachabilityDeadlock" ] || [ "StableMarking" = "UpperBounds" ] || [ "StableMarking" = "QuasiLiveness" ] || [ "StableMarking" = "StableMarking" ] || [ "StableMarking" = "Liveness" ] || [ "StableMarking" = "OneSafe" ] || [ "StableMarking" = "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 [ "StableMarking" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "StableMarking" != "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 "StableMarking.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property StableMarking.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "StableMarking.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 '' StableMarking.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "StableMarking" = "ReachabilityDeadlock" ] || [ "StableMarking" = "QuasiLiveness" ] || [ "StableMarking" = "StableMarking" ] || [ "StableMarking" = "Liveness" ] || [ "StableMarking" = "OneSafe" ] ; then
echo "FORMULA_NAME StableMarking"
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 ;