Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2023-input.r499-tall-167912722400281.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
...............
=====================================================================
Generated by BenchKit 2-5348
Executing tool itstools
Input is Szymanski-PT-b02, examination is ReachabilityDeadlock
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r499-tall-167912722400281
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 4.1M
-rw-r--r-- 1 mcc users 7.6K Feb 26 16:50 CTLCardinality.txt
-rw-r--r-- 1 mcc users 83K Feb 26 16:50 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.3K Feb 26 16:49 CTLFireability.txt
-rw-r--r-- 1 mcc users 46K Feb 26 16:49 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.6K Feb 25 17:19 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Feb 25 17:19 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Feb 25 17:19 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Feb 25 17:19 LTLFireability.xml
-rw-r--r-- 1 mcc users 14K Feb 26 16:53 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 153K Feb 26 16:53 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 7.0K Feb 26 16:51 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 57K Feb 26 16:51 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 25 17:19 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.6K Feb 25 17:19 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 equiv_col
-rw-r--r-- 1 mcc users 4 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 3.7M Mar 5 18:23 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 ReachabilityDeadlock

=== Now, execution of the tool begins

BK_START 1679502362592

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=ReachabilityDeadlock
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=Szymanski-PT-b02
Not applying reductions.
Model is PT
ReachabilityDeadlock PT
Running Version 202303021504
[2023-03-22 16:26:04] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityDeadlock, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2023-03-22 16:26:04] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-22 16:26:04] [INFO ] Load time of PNML (sax parser for PT used): 293 ms
[2023-03-22 16:26:04] [INFO ] Transformed 568 places.
[2023-03-22 16:26:04] [INFO ] Transformed 8320 transitions.
[2023-03-22 16:26:04] [INFO ] Parsed PT model containing 568 places and 8320 transitions and 33408 arcs in 392 ms.
Parsed 1 properties from file /home/mcc/execution/ReachabilityDeadlock.xml in 2 ms.
Working with output stream class java.io.PrintStream
Deduced a syphon composed of 260 places in 19 ms
Reduce places removed 260 places and 256 transitions.
Built sparse matrix representations for Structural reductions in 10 ms.32437KB memory used
Starting structural reductions in DEADLOCK mode, iteration 0 : 308/308 places, 8064/8064 transitions.
Computed a total of 12 stabilizing places and 2432 stable transitions
Graph (complete) has 12652 edges and 308 vertex of which 306 are kept as prefixes of interest. Removing 2 places using SCC suffix rule.65 ms
Discarding 2 places :
Also discarding 0 output transitions
Computed a total of 12 stabilizing places and 2432 stable transitions
Discarding 1 places :
Symmetric choice reduction at 0 with 1 rule applications. Total rules 2 place count 305 transition count 7936
Iterating global reduction 0 with 1 rules applied. Total rules applied 3 place count 305 transition count 7936
Computed a total of 11 stabilizing places and 2304 stable transitions
Computed a total of 11 stabilizing places and 2304 stable transitions
Applied a total of 3 rules in 682 ms. Remains 305 /308 variables (removed 3) and now considering 7936/8064 (removed 128) transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 683 ms. Remains : 305/308 places, 7936/8064 transitions.
Random walk for 1250001 steps, including 0 resets, run took 3413 ms (no deadlock found). (steps per millisecond=366 )
Random directed walk for 1250000 steps, including 0 resets, run took 4511 ms (no deadlock found). (steps per millisecond=277 )
[2023-03-22 16:26:13] [INFO ] Flow matrix only has 2732 transitions (discarded 5204 similar events)
// Phase 1: matrix 2732 rows 305 cols
[2023-03-22 16:26:13] [INFO ] Computed 1 place invariants in 44 ms
[2023-03-22 16:26:14] [INFO ] [Real]Absence check using 0 positive and 1 generalized place invariants in 8 ms returned sat
[2023-03-22 16:26:14] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2023-03-22 16:26:14] [INFO ] [Real]Absence check using state equation in 558 ms returned sat
[2023-03-22 16:26:15] [INFO ] Solution in real domain found non-integer solution.
[2023-03-22 16:26:15] [INFO ] [Nat]Absence check using 0 positive and 1 generalized place invariants in 12 ms returned sat
[2023-03-22 16:26:15] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2023-03-22 16:26:16] [INFO ] [Nat]Absence check using state equation in 682 ms returned sat
[2023-03-22 16:26:16] [INFO ] State equation strengthened by 147 read => feed constraints.
[2023-03-22 16:26:19] [INFO ] SMT solver returned unknown. Retrying;
[2023-03-22 16:26:22] [INFO ] [Nat]Added 147 Read/Feed constraints in 6050 ms returned unknown
Random directed walk for 500000 steps, including 0 resets, run took 2136 ms (no deadlock found). (steps per millisecond=234 )
Random walk for 500000 steps, including 0 resets, run took 1287 ms (no deadlock found). (steps per millisecond=388 )
Random directed walk for 500001 steps, including 0 resets, run took 1833 ms (no deadlock found). (steps per millisecond=272 )
Random walk for 500001 steps, including 0 resets, run took 1229 ms (no deadlock found). (steps per millisecond=406 )
Starting structural reductions in DEADLOCK mode, iteration 0 : 305/305 places, 7936/7936 transitions.
Computed a total of 11 stabilizing places and 2304 stable transitions
Computed a total of 11 stabilizing places and 2304 stable transitions
Computed a total of 11 stabilizing places and 2304 stable transitions
Applied a total of 0 rules in 226 ms. Remains 305 /305 variables (removed 0) and now considering 7936/7936 (removed 0) transitions.
[2023-03-22 16:26:29] [INFO ] Flow matrix only has 2732 transitions (discarded 5204 similar events)
[2023-03-22 16:26:29] [INFO ] Invariant cache hit.
[2023-03-22 16:26:29] [INFO ] Implicit Places using invariants in 536 ms returned []
[2023-03-22 16:26:29] [INFO ] Flow matrix only has 2732 transitions (discarded 5204 similar events)
[2023-03-22 16:26:29] [INFO ] Invariant cache hit.
[2023-03-22 16:26:30] [INFO ] State equation strengthened by 147 read => feed constraints.
[2023-03-22 16:26:36] [INFO ] Implicit Places using invariants and state equation in 6663 ms returned []
Implicit Place search using SMT with State Equation took 7212 ms to find 0 implicit places.
[2023-03-22 16:26:37] [INFO ] Redundant transitions in 1003 ms returned []
[2023-03-22 16:26:37] [INFO ] Flow matrix only has 2732 transitions (discarded 5204 similar events)
[2023-03-22 16:26:37] [INFO ] Invariant cache hit.
[2023-03-22 16:26:39] [INFO ] Dead Transitions using invariants and state equation in 2228 ms found 0 transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 10678 ms. Remains : 305/305 places, 7936/7936 transitions.
Random walk for 1250000 steps, including 0 resets, run took 3041 ms (no deadlock found). (steps per millisecond=411 )
Random directed walk for 1250001 steps, including 0 resets, run took 4317 ms (no deadlock found). (steps per millisecond=289 )
[2023-03-22 16:26:47] [INFO ] Flow matrix only has 2732 transitions (discarded 5204 similar events)
[2023-03-22 16:26:47] [INFO ] Invariant cache hit.
[2023-03-22 16:26:47] [INFO ] [Real]Absence check using 0 positive and 1 generalized place invariants in 6 ms returned sat
[2023-03-22 16:26:47] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2023-03-22 16:26:48] [INFO ] [Real]Absence check using state equation in 532 ms returned sat
[2023-03-22 16:26:48] [INFO ] Solution in real domain found non-integer solution.
[2023-03-22 16:26:48] [INFO ] [Nat]Absence check using 0 positive and 1 generalized place invariants in 4 ms returned sat
[2023-03-22 16:26:48] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2023-03-22 16:26:49] [INFO ] [Nat]Absence check using state equation in 672 ms returned sat
[2023-03-22 16:26:49] [INFO ] State equation strengthened by 147 read => feed constraints.
[2023-03-22 16:26:52] [INFO ] SMT solver returned unknown. Retrying;
[2023-03-22 16:26:55] [INFO ] [Nat]Added 147 Read/Feed constraints in 6045 ms returned unknown
Random directed walk for 500002 steps, including 0 resets, run took 1714 ms (no deadlock found). (steps per millisecond=291 )
Random walk for 500000 steps, including 0 resets, run took 1235 ms (no deadlock found). (steps per millisecond=404 )
Random directed walk for 500002 steps, including 0 resets, run took 1679 ms (no deadlock found). (steps per millisecond=297 )
Random walk for 500001 steps, including 0 resets, run took 1213 ms (no deadlock found). (steps per millisecond=412 )
[2023-03-22 16:27:02] [INFO ] Flatten gal took : 486 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin14557063462521769756
[2023-03-22 16:27:02] [INFO ] Too many transitions (8064) to apply POR reductions. Disabling POR matrices.
[2023-03-22 16:27:02] [INFO ] Applying decomposition
[2023-03-22 16:27:02] [INFO ] Built C files in 219ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin14557063462521769756
Running compilation step : cd /tmp/ltsmin14557063462521769756;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '360' 'gcc' '-c' '-I/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/include/' '-I.' '-std=c99' '-fPIC' '-O0' 'model.c'
[2023-03-22 16:27:02] [INFO ] Flatten gal took : 309 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph11202107487103285202.txt' '-o' '/tmp/graph11202107487103285202.bin' '-w' '/tmp/graph11202107487103285202.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph11202107487103285202.bin' '-l' '-1' '-v' '-w' '/tmp/graph11202107487103285202.weights' '-q' '0' '-e' '0.001'
[2023-03-22 16:27:03] [INFO ] Decomposing Gal with order
[2023-03-22 16:27:03] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-22 16:27:04] [INFO ] Removed a total of 18743 redundant transitions.
[2023-03-22 16:27:04] [INFO ] Flatten gal took : 756 ms
[2023-03-22 16:27:04] [INFO ] Fuse similar labels procedure discarded/fused a total of 1008 labels/synchronizations in 360 ms.
[2023-03-22 16:27:04] [INFO ] Time to serialize gal into /tmp/ReachabilityDeadlock5028224375550826998.gal : 43 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.202303021504/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityDeadlock5028224375550826998.gal' '-t' 'CGAL' '-ctl' 'DEADLOCK'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...234
No direction supplied, using forward translation only.
Compilation finished in 33149 ms.
Running link step : cd /tmp/ltsmin14557063462521769756;'gcc' '-shared' '-o' 'gal.so' 'model.o'
Link finished in 83 ms.
Running LTSmin : cd /tmp/ltsmin14557063462521769756;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/pins2lts-mc-linux64' './gal.so' '--threads=8' '-p' '--pins-guards' '--when' '-d'
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,277943,46.3981,921808,2908,1875,1.10837e+06,237396,8334,3.58573e+06,423,1.47427e+06,0


Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
dead,7125,48.5882,921808,338,182,1.10837e+06,237396,30148,3.58573e+06,1871,1.47427e+06,447439

System contains 7125 deadlocks (shown below if less than --print-limit option) !
FORMULA ReachabilityDeadlock TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
[ 7125 states ] showing 10 first states
[ u50={[ ]
} i8={[ u63={[ ]
} u42={[ ]
} u32={[ ]
} u20={[ ]
} u9={[ ]
} ]
} i7={[ u41={[ ]
} u39={[ ]
} u61={[ ]
} u60={[ ]
} u59={[ ]
} u30={[ ]
} u28={[ ]
} u19={[ ]
} u17={[ ]
} u8={[ ]
} u6={[ ]
} ]
} i6={[ u38={[ ]
} u37={[ ]
} u58={[ ]
} u57={[ ]
} u27={[ ]
} u26={[ ]
} u16={[ ]
} u15={[ ]
} u5={[ ]
} u4={[ ]
} ]
} i5={[ u29={[ ]
} u62={[ l54=1 ]
} u55={[ p512=1 ]
} u54={[ ]
} u22={[ ]
} u18={[ ]
} u11={[ ]
} u7={[ ]
} u0={[ ]
} ]
} i4={[ u53={[ ]
} u52={[ ]
} u51={[ ]
} ]
} i2={[ u49={[ ]
} u48={[ ]
} u36={[ ]
} u25={[ ]
} u14={[ ]
} u3={[ ]
} ]
} i1={[ i2={[ u47={[ ]
} u46={[ ]
} u34={[ ]
} u23={[ ]
} u13={[ ]
} u2={[ ]
} ]
} i1={[ u45={[ l3=1 ]
} u44={[ ]
} u40={[ ]
} u33={[ ]
} ]
} i0={[ u35={[ ]
} u24={[ ]
} u12={[ ]
} u1={[ ]
} ]
} ]
[ i2={[ u47={[ l6=1 ]
[ l7=1 ]
} u46={[ ]
} u34={[ ]
} u23={[ ]
} u13={[ ]
} u2={[ ]
} ]
[ u47={[ ]
} u46={[ l4=1 ]
[ l5=1 ]
} u34={[ ]
} u23={[ ]
} u13={[ ]
} u2={[ ]
} ]
} i1={[ u45={[ ]
} u44={[ ]
} u40={[ ]
} u33={[ ]
} ]
} i0={[ u35={[ ]
} u24={[ ]
} u12={[ ]
} u1={[ ]
} ]
} ]
} i0={[ u56={[ l25=1 ]
[ l27=1 ]
[ l26=1 ]
[ l28=1 ]
} u43={[ ]
} u31={[ ]
} u21={[ ]
} u10={[ ]
} ]
} ]
WARNING : LTS min runner thread was asked to interrupt. Dying gracefully.
Total runtime 130545 ms.

BK_STOP 1679502498524

--------------------
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
+ [[ ReachabilityDeadlock = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution ReachabilityDeadlock -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:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
+ VERSION=202303021504
+ echo 'Running Version 202303021504'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination ReachabilityDeadlock -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="Szymanski-PT-b02"
export BK_EXAMINATION="ReachabilityDeadlock"
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-5348"
echo " Executing tool itstools"
echo " Input is Szymanski-PT-b02, 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 r499-tall-167912722400281"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/Szymanski-PT-b02.tgz
mv Szymanski-PT-b02 execution
cd execution
if [ "ReachabilityDeadlock" = "ReachabilityDeadlock" ] || [ "ReachabilityDeadlock" = "UpperBounds" ] || [ "ReachabilityDeadlock" = "QuasiLiveness" ] || [ "ReachabilityDeadlock" = "StableMarking" ] || [ "ReachabilityDeadlock" = "Liveness" ] || [ "ReachabilityDeadlock" = "OneSafe" ] || [ "ReachabilityDeadlock" = "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 [ "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
elif [ "ReachabilityDeadlock" = "ReachabilityDeadlock" ] || [ "ReachabilityDeadlock" = "QuasiLiveness" ] || [ "ReachabilityDeadlock" = "StableMarking" ] || [ "ReachabilityDeadlock" = "Liveness" ] || [ "ReachabilityDeadlock" = "OneSafe" ] ; then
echo "FORMULA_NAME ReachabilityDeadlock"
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 ;