Execution Chart

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

Trace from the execution

Formatting '/data/fko/mcc2020-input.r182-oct2-158987914000518.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2020-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 itslola
Input is BusinessProcesses-PT-09, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r182-oct2-158987914000518
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 272K
-rw-r--r-- 1 mcc users 3.7K Mar 26 02:51 CTLCardinality.txt
-rw-r--r-- 1 mcc users 21K Mar 26 02:51 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.4K Mar 25 22:44 CTLFireability.txt
-rw-r--r-- 1 mcc users 15K Mar 25 22:44 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.3K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.2K Apr 8 14:43 LTLCardinality.txt
-rw-r--r-- 1 mcc users 24K Apr 28 14:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Apr 8 14:43 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 28 14:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.3K Mar 25 17:47 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 15K Mar 25 17:47 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.6K Mar 25 14:38 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 15K Mar 25 14:38 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Mar 25 17:55 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Mar 25 17:55 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 equiv_col
-rw-r--r-- 1 mcc users 3 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 104K Mar 24 05:37 model.pnml

--------------------
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 BusinessProcesses-PT-09-ReachabilityCardinality-00
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-01
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-02
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-03
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-04
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-05
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-06
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-07
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-08
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-09
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-10
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-11
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-12
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-13
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-14
FORMULA_NAME BusinessProcesses-PT-09-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591160633311

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-03 05:03:58] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityCardinality, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2020-06-03 05:03:58] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-03 05:03:58] [INFO ] Load time of PNML (sax parser for PT used): 144 ms
[2020-06-03 05:03:58] [INFO ] Transformed 403 places.
[2020-06-03 05:03:58] [INFO ] Transformed 374 transitions.
[2020-06-03 05:03:58] [INFO ] Found NUPN structural information;
[2020-06-03 05:03:58] [INFO ] Parsed PT model containing 403 places and 374 transitions in 221 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 78 ms.
Working with output stream class java.io.PrintStream
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-00 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-02 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-11 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-15 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 103 resets, run finished after 111 ms. (steps per millisecond=90 ) properties seen :[1, 1, 0, 0, 1, 1, 0, 1, 0]
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-08 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 17 resets, run finished after 59 ms. (steps per millisecond=169 ) properties seen :[0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 17 resets, run finished after 9 ms. (steps per millisecond=1111 ) properties seen :[0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 15 resets, run finished after 26 ms. (steps per millisecond=384 ) properties seen :[0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 20 resets, run finished after 24 ms. (steps per millisecond=416 ) properties seen :[0, 0, 0, 0]
// Phase 1: matrix 374 rows 403 cols
[2020-06-03 05:03:58] [INFO ] Computed 65 place invariants in 52 ms
[2020-06-03 05:03:59] [INFO ] [Real]Absence check using 36 positive place invariants in 33 ms returned sat
[2020-06-03 05:03:59] [INFO ] [Real]Absence check using 36 positive and 29 generalized place invariants in 2 ms returned unsat
[2020-06-03 05:03:59] [INFO ] [Real]Absence check using 36 positive place invariants in 193 ms returned sat
[2020-06-03 05:03:59] [INFO ] [Real]Absence check using 36 positive and 29 generalized place invariants in 99 ms returned sat
[2020-06-03 05:03:59] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 05:04:00] [INFO ] [Real]Absence check using state equation in 623 ms returned sat
[2020-06-03 05:04:00] [INFO ] Solution in real domain found non-integer solution.
[2020-06-03 05:04:00] [INFO ] [Nat]Absence check using 36 positive place invariants in 58 ms returned sat
[2020-06-03 05:04:00] [INFO ] [Nat]Absence check using 36 positive and 29 generalized place invariants in 25 ms returned sat
[2020-06-03 05:04:00] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-03 05:04:01] [INFO ] [Nat]Absence check using state equation in 884 ms returned sat
[2020-06-03 05:04:02] [INFO ] Deduced a trap composed of 18 places in 560 ms
[2020-06-03 05:04:02] [INFO ] Deduced a trap composed of 11 places in 409 ms
[2020-06-03 05:04:03] [INFO ] Deduced a trap composed of 23 places in 261 ms
[2020-06-03 05:04:03] [INFO ] Deduced a trap composed of 11 places in 260 ms
[2020-06-03 05:04:03] [INFO ] Deduced a trap composed of 16 places in 129 ms
[2020-06-03 05:04:03] [INFO ] Deduced a trap composed of 17 places in 69 ms
[2020-06-03 05:04:03] [INFO ] Trap strengthening (SAT) tested/added 7/6 trap constraints in 1901 ms
[2020-06-03 05:04:03] [INFO ] Computed and/alt/rep : 373/1354/373 causal constraints in 58 ms.
[2020-06-03 05:04:05] [INFO ] Added : 220 causal constraints over 44 iterations in 2083 ms. Result :(error "Solver has unexpectedly terminated")
[2020-06-03 05:04:05] [INFO ] [Real]Absence check using 36 positive place invariants in 58 ms returned sat
[2020-06-03 05:04:05] [INFO ] [Real]Absence check using 36 positive and 29 generalized place invariants in 5 ms returned unsat
[2020-06-03 05:04:05] [INFO ] [Real]Absence check using 36 positive place invariants in 42 ms returned sat
[2020-06-03 05:04:06] [INFO ] [Real]Absence check using 36 positive and 29 generalized place invariants in 54 ms returned sat
[2020-06-03 05:04:06] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 05:04:06] [INFO ] [Real]Absence check using state equation in 529 ms returned sat
[2020-06-03 05:04:06] [INFO ] Solution in real domain found non-integer solution.
[2020-06-03 05:04:06] [INFO ] [Nat]Absence check using 36 positive place invariants in 26 ms returned sat
[2020-06-03 05:04:06] [INFO ] [Nat]Absence check using 36 positive and 29 generalized place invariants in 16 ms returned sat
[2020-06-03 05:04:06] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-03 05:04:07] [INFO ] [Nat]Absence check using state equation in 486 ms returned sat
[2020-06-03 05:04:07] [INFO ] Deduced a trap composed of 11 places in 174 ms
[2020-06-03 05:04:07] [INFO ] Deduced a trap composed of 20 places in 129 ms
[2020-06-03 05:04:07] [INFO ] Deduced a trap composed of 90 places in 264 ms
[2020-06-03 05:04:08] [INFO ] Deduced a trap composed of 8 places in 150 ms
[2020-06-03 05:04:08] [INFO ] Deduced a trap composed of 20 places in 498 ms
[2020-06-03 05:04:08] [INFO ] Deduced a trap composed of 50 places in 198 ms
[2020-06-03 05:04:09] [INFO ] Deduced a trap composed of 30 places in 298 ms
[2020-06-03 05:04:09] [INFO ] Deduced a trap composed of 33 places in 238 ms
[2020-06-03 05:04:09] [INFO ] Deduced a trap composed of 91 places in 212 ms
[2020-06-03 05:04:09] [INFO ] Deduced a trap composed of 98 places in 239 ms
[2020-06-03 05:04:10] [INFO ] Deduced a trap composed of 98 places in 153 ms
[2020-06-03 05:04:10] [INFO ] Deduced a trap composed of 96 places in 474 ms
[2020-06-03 05:04:10] [INFO ] Deduced a trap composed of 96 places in 136 ms
[2020-06-03 05:04:11] [INFO ] Deduced a trap composed of 100 places in 255 ms
[2020-06-03 05:04:11] [INFO ] Deduced a trap composed of 96 places in 373 ms
[2020-06-03 05:04:11] [INFO ] Deduced a trap composed of 94 places in 138 ms
[2020-06-03 05:04:11] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream closed (> (+ s0 s1 s2 s3 s4 s5 s6 s24 s25 s28 s29 s39 s41 s42 s80 s82 s84 s86 s92 s96 s97 s98 s99 s111 s114 s120 s144 s188 s189 s190 s208 s209 s210 s228 s230 s239 s244 s259 s269 s274 s278 s281 s282 s283 s284 s287 s288 s289 s290 s295 s296 s299 s300 s310 s311 s312 s313 s314 s315 s316 s317 s318 s319 s320 s321 s322 s333 s337 s338 s339 s342 s343 s344 s345 s346 s347 s348 s349 s354 s355 s356 s357 s358 s359 s360 s361 s364 s365 s368 s369 s370 s371 s373 s374) 0)") while checking expression at index 3
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-12 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-04 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Support contains 8 out of 403 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 403/403 places, 374/374 transitions.
Graph (trivial) has 223 edges and 403 vertex of which 7 / 403 are part of one of the 1 SCC in 27 ms
Free SCC test removed 6 places
Discarding 2 places :
Also discarding 1 output transitions
Drop transitions removed 1 transitions
Graph (complete) has 837 edges and 397 vertex of which 395 are kept as prefixes of interest. Removing 2 places using SCC suffix rule.9 ms
Drop transitions removed 8 transitions
Reduce isomorphic transitions removed 8 transitions.
Performed 85 Post agglomeration using F-continuation condition.Transition count delta: 85
Iterating post reduction 0 with 93 rules applied. Total rules applied 95 place count 395 transition count 280
Reduce places removed 85 places and 0 transitions.
Iterating post reduction 1 with 85 rules applied. Total rules applied 180 place count 310 transition count 280
Performed 61 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 61 Pre rules applied. Total rules applied 180 place count 310 transition count 219
Deduced a syphon composed of 61 places in 1 ms
Ensure Unique test removed 10 places
Reduce places removed 71 places and 0 transitions.
Iterating global reduction 2 with 132 rules applied. Total rules applied 312 place count 239 transition count 219
Symmetric choice reduction at 2 with 44 rule applications. Total rules 356 place count 239 transition count 219
Deduced a syphon composed of 44 places in 1 ms
Reduce places removed 44 places and 44 transitions.
Iterating global reduction 2 with 88 rules applied. Total rules applied 444 place count 195 transition count 175
Performed 6 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 6 Pre rules applied. Total rules applied 444 place count 195 transition count 169
Deduced a syphon composed of 6 places in 1 ms
Ensure Unique test removed 1 places
Reduce places removed 7 places and 0 transitions.
Iterating global reduction 2 with 13 rules applied. Total rules applied 457 place count 188 transition count 169
Performed 59 Post agglomeration using F-continuation condition.Transition count delta: 59
Deduced a syphon composed of 59 places in 4 ms
Ensure Unique test removed 2 places
Reduce places removed 61 places and 0 transitions.
Iterating global reduction 2 with 120 rules applied. Total rules applied 577 place count 127 transition count 110
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: -3
Deduced a syphon composed of 1 places in 1 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 579 place count 126 transition count 113
Free-agglomeration rule applied 2 times.
Iterating global reduction 2 with 2 rules applied. Total rules applied 581 place count 126 transition count 111
Reduce places removed 2 places and 0 transitions.
Iterating post reduction 2 with 2 rules applied. Total rules applied 583 place count 124 transition count 111
Partial Free-agglomeration rule applied 1 times.
Drop transitions removed 1 transitions
Iterating global reduction 3 with 1 rules applied. Total rules applied 584 place count 124 transition count 111
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 3 with 1 rules applied. Total rules applied 585 place count 123 transition count 110
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 3 with 1 rules applied. Total rules applied 586 place count 122 transition count 110
Applied a total of 586 rules in 163 ms. Remains 122 /403 variables (removed 281) and now considering 110/374 (removed 264) transitions.
Finished structural reductions, in 1 iterations. Remains : 122/403 places, 110/374 transitions.
Finished random walk after 71087 steps, including 4488 resets, run visited all 2 properties in 204 ms. (steps per millisecond=348 )
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-14 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA BusinessProcesses-PT-09-ReachabilityCardinality-05 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
All properties solved without resorting to model-checking.

--------------------
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="BusinessProcesses-PT-09"
export BK_EXAMINATION="ReachabilityCardinality"
export BK_TOOL="itslola"
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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itslola"
echo " Input is BusinessProcesses-PT-09, examination is ReachabilityCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r182-oct2-158987914000518"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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