Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2020-input.r168-smll-158987806600326.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/fkordon/mcc2020-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
...........................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itslola
Input is CloudDeployment-PT-5b, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r168-smll-158987806600326
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 1.6M
-rw-r--r-- 1 mcc users 3.9K Mar 30 01:22 CTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Mar 30 01:22 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.7K Mar 28 15:43 CTLFireability.txt
-rw-r--r-- 1 mcc users 18K Mar 28 15:43 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.4K Apr 8 14:45 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Apr 28 14:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.9K Apr 8 14:45 LTLFireability.txt
-rw-r--r-- 1 mcc users 14K Apr 28 14:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.9K Mar 27 08:29 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 20K Mar 27 08:29 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Mar 26 07:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 11K Mar 26 07:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Mar 28 14:49 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Mar 28 14:49 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 1.5M 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 CloudDeployment-PT-5b-ReachabilityCardinality-00
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-01
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-02
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-03
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-04
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-05
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-06
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-07
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-08
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-09
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-10
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-11
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-12
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-13
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-14
FORMULA_NAME CloudDeployment-PT-5b-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591296250707

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 18:44:13] [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-04 18:44:13] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 18:44:14] [INFO ] Load time of PNML (sax parser for PT used): 670 ms
[2020-06-04 18:44:14] [INFO ] Transformed 1525 places.
[2020-06-04 18:44:14] [INFO ] Transformed 3132 transitions.
[2020-06-04 18:44:14] [INFO ] Found NUPN structural information;
[2020-06-04 18:44:14] [INFO ] Parsed PT model containing 1525 places and 3132 transitions in 796 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 112 ms.
Working with output stream class java.io.PrintStream
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-03 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-08 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 64 resets, run finished after 116 ms. (steps per millisecond=86 ) properties seen :[1, 1, 0, 1, 1, 1, 1, 0, 1, 0]
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-13 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-11 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-07 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-00 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 7 resets, run finished after 21 ms. (steps per millisecond=476 ) properties seen :[0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 9 resets, run finished after 26 ms. (steps per millisecond=384 ) properties seen :[0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 7 resets, run finished after 26 ms. (steps per millisecond=384 ) properties seen :[0, 0, 0]
// Phase 1: matrix 3132 rows 1525 cols
[2020-06-04 18:44:15] [INFO ] Computed 21 place invariants in 147 ms
[2020-06-04 18:44:16] [INFO ] [Real]Absence check using 0 positive and 21 generalized place invariants in 400 ms returned sat
[2020-06-04 18:44:16] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 18:44:20] [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: Broken pipe (= s573 (- t957 (+ t2590 t2650 t2710 t2770 t2830 t2963)))") while checking expression at index 0
[2020-06-04 18:44:20] [INFO ] [Real]Absence check using 0 positive and 21 generalized place invariants in 142 ms returned sat
[2020-06-04 18:44:20] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 18:44:25] [INFO ] [Real]Absence check using state equation in 4451 ms returned (error "Solver has unexpectedly terminated")
[2020-06-04 18:44:25] [INFO ] [Real]Absence check using 0 positive and 21 generalized place invariants in 154 ms returned sat
[2020-06-04 18:44:25] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 18:44:30] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 18:44:30] [INFO ] [Real]Absence check using state equation in 4423 ms returned (error "Failed to check-sat")
Support contains 11 out of 1525 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 1525/1525 places, 3132/3132 transitions.
Graph (trivial) has 1528 edges and 1525 vertex of which 397 / 1525 are part of one of the 38 SCC in 21 ms
Free SCC test removed 359 places
Discarding 37 places :
Also discarding 1029 output transitions
Drop transitions removed 1029 transitions
Graph (complete) has 3288 edges and 1166 vertex of which 1129 are kept as prefixes of interest. Removing 37 places using SCC suffix rule.37 ms
Drop transitions removed 459 transitions
Reduce isomorphic transitions removed 459 transitions.
Performed 555 Post agglomeration using F-continuation condition.Transition count delta: 555
Iterating post reduction 0 with 1014 rules applied. Total rules applied 1016 place count 1129 transition count 1089
Reduce places removed 555 places and 0 transitions.
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 1 with 556 rules applied. Total rules applied 1572 place count 574 transition count 1088
Performed 20 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 20 Pre rules applied. Total rules applied 1572 place count 574 transition count 1068
Deduced a syphon composed of 20 places in 4 ms
Reduce places removed 20 places and 0 transitions.
Iterating global reduction 2 with 40 rules applied. Total rules applied 1612 place count 554 transition count 1068
Symmetric choice reduction at 2 with 235 rule applications. Total rules 1847 place count 554 transition count 1068
Deduced a syphon composed of 235 places in 4 ms
Reduce places removed 235 places and 235 transitions.
Iterating global reduction 2 with 470 rules applied. Total rules applied 2317 place count 319 transition count 833
Ensure Unique test removed 20 transitions
Reduce isomorphic transitions removed 20 transitions.
Iterating post reduction 2 with 20 rules applied. Total rules applied 2337 place count 319 transition count 813
Performed 21 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 21 Pre rules applied. Total rules applied 2337 place count 319 transition count 792
Deduced a syphon composed of 21 places in 3 ms
Reduce places removed 21 places and 0 transitions.
Iterating global reduction 3 with 42 rules applied. Total rules applied 2379 place count 298 transition count 792
Symmetric choice reduction at 3 with 3 rule applications. Total rules 2382 place count 298 transition count 792
Deduced a syphon composed of 3 places in 3 ms
Reduce places removed 3 places and 3 transitions.
Iterating global reduction 3 with 6 rules applied. Total rules applied 2388 place count 295 transition count 789
Symmetric choice reduction at 3 with 2 rule applications. Total rules 2390 place count 295 transition count 789
Deduced a syphon composed of 2 places in 3 ms
Reduce places removed 2 places and 2 transitions.
Iterating global reduction 3 with 4 rules applied. Total rules applied 2394 place count 293 transition count 787
Symmetric choice reduction at 3 with 1 rule applications. Total rules 2395 place count 293 transition count 787
Deduced a syphon composed of 1 places in 2 ms
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 3 with 2 rules applied. Total rules applied 2397 place count 292 transition count 786
Performed 77 Post agglomeration using F-continuation condition.Transition count delta: 77
Deduced a syphon composed of 77 places in 2 ms
Reduce places removed 77 places and 0 transitions.
Iterating global reduction 3 with 154 rules applied. Total rules applied 2551 place count 215 transition count 709
Performed 34 Post agglomeration using F-continuation condition with reduction of 70 identical transitions.
Deduced a syphon composed of 34 places in 4 ms
Reduce places removed 34 places and 0 transitions.
Iterating global reduction 3 with 68 rules applied. Total rules applied 2619 place count 181 transition count 888
Drop transitions removed 11 transitions
Reduce isomorphic transitions removed 11 transitions.
Iterating post reduction 3 with 11 rules applied. Total rules applied 2630 place count 181 transition count 877
Free-agglomeration rule applied 48 times with reduction of 16 identical transitions.
Iterating global reduction 4 with 48 rules applied. Total rules applied 2678 place count 181 transition count 813
Reduce places removed 48 places and 0 transitions.
Drop transitions removed 75 transitions
Ensure Unique test removed 40 transitions
Reduce isomorphic transitions removed 115 transitions.
Discarding 1 places :
Also discarding 0 output transitions
Graph (complete) has 1035 edges and 133 vertex of which 132 are kept as prefixes of interest. Removing 1 places using SCC suffix rule.4 ms
Iterating post reduction 4 with 164 rules applied. Total rules applied 2842 place count 132 transition count 698
Drop transitions removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 5 with 1 rules applied. Total rules applied 2843 place count 132 transition count 697
Symmetric choice reduction at 6 with 1 rule applications. Total rules 2844 place count 132 transition count 697
Deduced a syphon composed of 1 places in 2 ms
Reduce places removed 1 places and 8 transitions.
Iterating global reduction 6 with 2 rules applied. Total rules applied 2846 place count 131 transition count 689
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 6 with 1 rules applied. Total rules applied 2847 place count 131 transition count 688
Partial Post-agglomeration rule applied 5 times.
Drop transitions removed 5 transitions
Iterating global reduction 7 with 5 rules applied. Total rules applied 2852 place count 131 transition count 688
Drop transitions removed 5 transitions
Reduce isomorphic transitions removed 5 transitions.
Iterating post reduction 7 with 5 rules applied. Total rules applied 2857 place count 131 transition count 683
Drop transitions removed 218 transitions
Redundant transition composition rules discarded 218 transitions
Iterating global reduction 8 with 218 rules applied. Total rules applied 3075 place count 131 transition count 465
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 8 with 1 rules applied. Total rules applied 3076 place count 130 transition count 464
Applied a total of 3076 rules in 924 ms. Remains 130 /1525 variables (removed 1395) and now considering 464/3132 (removed 2668) transitions.
Finished structural reductions, in 1 iterations. Remains : 130/1525 places, 464/3132 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 3082 ms. (steps per millisecond=324 ) properties seen :[0, 1, 0]
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-12 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 1000001 steps, including 0 resets, run finished after 1156 ms. (steps per millisecond=865 ) properties seen :[1, 0]
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-05 TRUE TECHNIQUES TOPOLOGICAL BESTFIRST_WALK
Incomplete Best-First random walk after 1000000 steps, including 0 resets, run finished after 1346 ms. (steps per millisecond=742 ) properties seen :[0]
[2020-06-04 18:44:36] [INFO ] Flow matrix only has 235 transitions (discarded 229 similar events)
// Phase 1: matrix 235 rows 130 cols
[2020-06-04 18:44:36] [INFO ] Computed 19 place invariants in 2 ms
[2020-06-04 18:44:36] [INFO ] [Real]Absence check using 5 positive place invariants in 8 ms returned sat
[2020-06-04 18:44:36] [INFO ] [Real]Absence check using 5 positive and 14 generalized place invariants in 9 ms returned sat
[2020-06-04 18:44:36] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 18:44:36] [INFO ] [Real]Absence check using state equation in 124 ms returned sat
[2020-06-04 18:44:36] [INFO ] Solution in real domain found non-integer solution.
[2020-06-04 18:44:37] [INFO ] [Nat]Absence check using 5 positive place invariants in 22 ms returned sat
[2020-06-04 18:44:37] [INFO ] [Nat]Absence check using 5 positive and 14 generalized place invariants in 9 ms returned sat
[2020-06-04 18:44:37] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-04 18:44:37] [INFO ] [Nat]Absence check using state equation in 156 ms returned sat
[2020-06-04 18:44:37] [INFO ] State equation strengthened by 36 read => feed constraints.
[2020-06-04 18:44:37] [INFO ] [Nat]Added 36 Read/Feed constraints in 36 ms returned sat
[2020-06-04 18:44:37] [INFO ] Computed and/alt/rep : 441/2430/212 causal constraints in 46 ms.
[2020-06-04 18:44:37] [INFO ] Added : 77 causal constraints over 16 iterations in 644 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 29 ms.
Finished Parikh walk after 77 steps, including 0 resets, run visited all 1 properties in 2 ms. (steps per millisecond=38 )
FORMULA CloudDeployment-PT-5b-ReachabilityCardinality-14 FALSE TECHNIQUES TOPOLOGICAL PARIKH_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="CloudDeployment-PT-5b"
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 CloudDeployment-PT-5b, 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 r168-smll-158987806600326"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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