Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2022-input.r067-tall-165254777900057.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2022-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.............................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is DLCflexbar-PT-7b, examination is QuasiLiveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r067-tall-165254777900057
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 14M
-rw-r--r-- 1 mcc users 6.0K Apr 29 19:16 CTLCardinality.txt
-rw-r--r-- 1 mcc users 59K Apr 29 19:16 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.7K Apr 29 19:16 CTLFireability.txt
-rw-r--r-- 1 mcc users 65K Apr 29 19:16 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 10 09:33 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 3.8K May 9 07:26 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K May 9 07:26 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K May 9 07:26 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K May 9 07:26 LTLFireability.xml
-rw-r--r-- 1 mcc users 1.6K May 9 07:26 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K May 9 07:26 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 10 09:33 equiv_col
-rw-r--r-- 1 mcc users 3 May 10 09:33 instance
-rw-r--r-- 1 mcc users 6 May 10 09:33 iscolored
-rw-r--r-- 1 mcc users 14M May 10 09:33 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 1652565667740

Running Version 202205111006
[2022-05-14 22:01:08] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, QuasiLiveness, -spotpath, /home/mcc/BenchKit/bin//..//ltlfilt, -z3path, /home/mcc/BenchKit/bin//..//z3/bin/z3, -yices2path, /home/mcc/BenchKit/bin//..//yices/bin/yices, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2022-05-14 22:01:08] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-14 22:01:09] [INFO ] Load time of PNML (sax parser for PT used): 962 ms
[2022-05-14 22:01:10] [INFO ] Transformed 35101 places.
[2022-05-14 22:01:10] [INFO ] Transformed 55507 transitions.
[2022-05-14 22:01:10] [INFO ] Found NUPN structural information;
[2022-05-14 22:01:12] [INFO ] Parsed PT model containing 35101 places and 55507 transitions in 3865 ms.
Starting structural reductions in LIVENESS mode, iteration 0 : 35101/35101 places, 55507/55507 transitions.
Graph (trivial) has 31611 edges and 35101 vertex of which 2264 / 35101 are part of one of the 146 SCC in 85 ms
Free SCC test removed 2118 places
Ensure Unique test removed 2246 transitions
Reduce isomorphic transitions removed 2246 transitions.
Drop transitions removed 15436 transitions
Trivial Post-agglo rules discarded 15436 transitions
Performed 15436 trivial Post agglomeration. Transition count delta: 15436
Iterating post reduction 0 with 15436 rules applied. Total rules applied 15437 place count 32983 transition count 37825
Reduce places removed 15436 places and 0 transitions.
Ensure Unique test removed 357 transitions
Reduce isomorphic transitions removed 357 transitions.
Drop transitions removed 348 transitions
Trivial Post-agglo rules discarded 348 transitions
Performed 348 trivial Post agglomeration. Transition count delta: 348
Iterating post reduction 1 with 16141 rules applied. Total rules applied 31578 place count 17547 transition count 37120
Reduce places removed 348 places and 0 transitions.
Ensure Unique test removed 110 transitions
Reduce isomorphic transitions removed 110 transitions.
Drop transitions removed 110 transitions
Trivial Post-agglo rules discarded 110 transitions
Performed 110 trivial Post agglomeration. Transition count delta: 110
Iterating post reduction 2 with 568 rules applied. Total rules applied 32146 place count 17199 transition count 36900
Reduce places removed 110 places and 0 transitions.
Iterating post reduction 3 with 110 rules applied. Total rules applied 32256 place count 17089 transition count 36900
Performed 110 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 110 Pre rules applied. Total rules applied 32256 place count 17089 transition count 36790
Deduced a syphon composed of 110 places in 2152 ms
Reduce places removed 110 places and 0 transitions.
Iterating global reduction 4 with 220 rules applied. Total rules applied 32476 place count 16979 transition count 36790
Discarding 4854 places :
Symmetric choice reduction at 4 with 4854 rule applications. Total rules 37330 place count 12125 transition count 31936
Iterating global reduction 4 with 4854 rules applied. Total rules applied 42184 place count 12125 transition count 31936
Performed 2052 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 2052 Pre rules applied. Total rules applied 42184 place count 12125 transition count 29884
Deduced a syphon composed of 2052 places in 1618 ms
Reduce places removed 2052 places and 0 transitions.
Iterating global reduction 4 with 4104 rules applied. Total rules applied 46288 place count 10073 transition count 29884
Discarding 283 places :
Symmetric choice reduction at 4 with 283 rule applications. Total rules 46571 place count 9790 transition count 20470
Iterating global reduction 4 with 283 rules applied. Total rules applied 46854 place count 9790 transition count 20470
Ensure Unique test removed 238 transitions
Reduce isomorphic transitions removed 238 transitions.
Iterating post reduction 4 with 238 rules applied. Total rules applied 47092 place count 9790 transition count 20232
Performed 2562 Post agglomeration using F-continuation condition with reduction of 9 identical transitions.
Deduced a syphon composed of 2562 places in 7 ms
Reduce places removed 2562 places and 0 transitions.
Iterating global reduction 5 with 5124 rules applied. Total rules applied 52216 place count 7228 transition count 17661
Ensure Unique test removed 9 transitions
Reduce isomorphic transitions removed 9 transitions.
Iterating post reduction 5 with 9 rules applied. Total rules applied 52225 place count 7228 transition count 17652
Renaming transitions due to excessive name length > 1024 char.
Performed 101 Post agglomeration using F-continuation condition.Transition count delta: -808
Deduced a syphon composed of 101 places in 17 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 6 with 202 rules applied. Total rules applied 52427 place count 7127 transition count 18460
Ensure Unique test removed 50 transitions
Reduce isomorphic transitions removed 50 transitions.
Iterating post reduction 6 with 50 rules applied. Total rules applied 52477 place count 7127 transition count 18410
Performed 101 Post agglomeration using F-continuation condition.Transition count delta: -1158
Deduced a syphon composed of 101 places in 4 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 7 with 202 rules applied. Total rules applied 52679 place count 7026 transition count 19568
Ensure Unique test removed 26 transitions
Reduce isomorphic transitions removed 26 transitions.
Iterating post reduction 7 with 26 rules applied. Total rules applied 52705 place count 7026 transition count 19542
Performed 98 Post agglomeration using F-continuation condition.Transition count delta: -971
Deduced a syphon composed of 98 places in 4 ms
Reduce places removed 98 places and 0 transitions.
Iterating global reduction 8 with 196 rules applied. Total rules applied 52901 place count 6928 transition count 20513
Ensure Unique test removed 34 transitions
Reduce isomorphic transitions removed 34 transitions.
Iterating post reduction 8 with 34 rules applied. Total rules applied 52935 place count 6928 transition count 20479
Performed 34 Post agglomeration using F-continuation condition.Transition count delta: -510
Deduced a syphon composed of 34 places in 4 ms
Reduce places removed 34 places and 0 transitions.
Iterating global reduction 9 with 68 rules applied. Total rules applied 53003 place count 6894 transition count 20989
Applied a total of 53003 rules in 18429 ms. Remains 6894 /35101 variables (removed 28207) and now considering 20989/55507 (removed 34518) transitions.
[2022-05-14 22:01:31] [INFO ] Flow matrix only has 19842 transitions (discarded 1147 similar events)
// Phase 1: matrix 19842 rows 6894 cols
[2022-05-14 22:01:31] [INFO ] Computed 2171 place invariants in 110 ms
[2022-05-14 22:01:32] [INFO ] Implicit Places using invariants in 933 ms returned []
Implicit Place search using SMT only with invariants took 966 ms to find 0 implicit places.
[2022-05-14 22:01:32] [INFO ] Flow matrix only has 19842 transitions (discarded 1147 similar events)
// Phase 1: matrix 19842 rows 6894 cols
[2022-05-14 22:01:32] [INFO ] Computed 2171 place invariants in 68 ms
[2022-05-14 22:01:45] [INFO ] Dead Transitions using invariants and state equation in 13429 ms found 0 transitions.
Starting structural reductions in LIVENESS mode, iteration 1 : 6894/35101 places, 20989/55507 transitions.
Finished structural reductions, in 1 iterations. Remains : 6894/35101 places, 20989/55507 transitions.
Discarding 6601 transitions out of 20989. Remains 14388
Initial state reduction rules removed 1 formulas.
Incomplete random walk after 10000 steps, including 2 resets, run finished after 3079 ms. (steps per millisecond=3 ) properties (out of 14387) seen :6762
Running SMT prover for 7625 properties.
[2022-05-14 22:01:49] [INFO ] Flow matrix only has 19842 transitions (discarded 1147 similar events)
// Phase 1: matrix 19842 rows 6894 cols
[2022-05-14 22:01:49] [INFO ] Computed 2171 place invariants in 54 ms
[2022-05-14 22:02:47] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2022-05-14 22:02:47] [INFO ] After 25031ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0
Fused 7625 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 3 ms.
Support contains 4464 out of 6894 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 6894/6894 places, 20989/20989 transitions.
Drop transitions removed 156 transitions
Reduce isomorphic transitions removed 156 transitions.
Iterating post reduction 0 with 156 rules applied. Total rules applied 156 place count 6894 transition count 20833
Free-agglomeration rule applied 333 times with reduction of 2 identical transitions.
Iterating global reduction 1 with 333 rules applied. Total rules applied 489 place count 6894 transition count 20498
Reduce places removed 333 places and 0 transitions.
Drop transitions removed 368 transitions
Ensure Unique test removed 16 transitions
Reduce isomorphic transitions removed 384 transitions.
Iterating post reduction 1 with 717 rules applied. Total rules applied 1206 place count 6561 transition count 20114
Applied a total of 1206 rules in 2468 ms. Remains 6561 /6894 variables (removed 333) and now considering 20114/20989 (removed 875) transitions.
Finished structural reductions, in 1 iterations. Remains : 6561/6894 places, 20114/20989 transitions.
Interrupted random walk after 145270 steps, including 0 resets, run timeout after 30001 ms. (steps per millisecond=4 ) properties seen 7596
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3071 ms. (steps per millisecond=32 ) properties (out of 29) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2983 ms. (steps per millisecond=33 ) properties (out of 28) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3016 ms. (steps per millisecond=33 ) properties (out of 27) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2989 ms. (steps per millisecond=33 ) properties (out of 26) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3016 ms. (steps per millisecond=33 ) properties (out of 25) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3010 ms. (steps per millisecond=33 ) properties (out of 24) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2979 ms. (steps per millisecond=33 ) properties (out of 23) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2987 ms. (steps per millisecond=33 ) properties (out of 22) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3013 ms. (steps per millisecond=33 ) properties (out of 21) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2996 ms. (steps per millisecond=33 ) properties (out of 20) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2992 ms. (steps per millisecond=33 ) properties (out of 19) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3011 ms. (steps per millisecond=33 ) properties (out of 18) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2985 ms. (steps per millisecond=33 ) properties (out of 17) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3014 ms. (steps per millisecond=33 ) properties (out of 16) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2980 ms. (steps per millisecond=33 ) properties (out of 15) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2983 ms. (steps per millisecond=33 ) properties (out of 14) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3007 ms. (steps per millisecond=33 ) properties (out of 13) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2980 ms. (steps per millisecond=33 ) properties (out of 12) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2987 ms. (steps per millisecond=33 ) properties (out of 11) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3001 ms. (steps per millisecond=33 ) properties (out of 10) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2988 ms. (steps per millisecond=33 ) properties (out of 9) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2995 ms. (steps per millisecond=33 ) properties (out of 8) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3026 ms. (steps per millisecond=33 ) properties (out of 7) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2987 ms. (steps per millisecond=33 ) properties (out of 6) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2993 ms. (steps per millisecond=33 ) properties (out of 5) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3013 ms. (steps per millisecond=33 ) properties (out of 4) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 2993 ms. (steps per millisecond=33 ) properties (out of 3) seen :1
Incomplete Best-First random walk after 100001 steps, including 2 resets, run finished after 3038 ms. (steps per millisecond=32 ) properties (out of 2) seen :1
Finished Best-First random walk after 8300 steps, including 0 resets, run visited all 1 properties in 250 ms. (steps per millisecond=33 )
Able to resolve query QuasiLiveness after proving 14388 properties.
FORMULA QuasiLiveness TRUE TECHNIQUES RANDOM_WALK BESTFIRST_WALK TOPOLOGICAL INITIAL_STATE
Total runtime 215663 ms.

BK_STOP 1652565884667

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

+ export LANG=C
+ LANG=C
+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ QuasiLiveness = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution QuasiLiveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ ulimit -s 65536
+ export PYTHONPATH=/usr/lib/python3.9/site-packages/
+ PYTHONPATH=/usr/lib/python3.9/site-packages/
+ export LD_LIBRARY_PATH=/usr/local/lib:
+ LD_LIBRARY_PATH=/usr/local/lib:
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202205111006.jar
+ VERSION=202205111006
+ echo 'Running Version 202205111006'
+ /home/mcc/BenchKit/bin//..//itstools/its-tools -data @none -pnfolder /home/mcc/execution -examination QuasiLiveness -spotpath /home/mcc/BenchKit/bin//..//ltlfilt -z3path /home/mcc/BenchKit/bin//..//z3/bin/z3 -yices2path /home/mcc/BenchKit/bin//..//yices/bin/yices -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=@none -Xss128m -Xms40m -Xmx8192m

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="DLCflexbar-PT-7b"
export BK_EXAMINATION="QuasiLiveness"
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-4028"
echo " Executing tool itstools"
echo " Input is DLCflexbar-PT-7b, 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 r067-tall-165254777900057"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/DLCflexbar-PT-7b.tgz
mv DLCflexbar-PT-7b 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 ;