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.r170-smll-158987815600230.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 FamilyReunion-PT-L00050M0005C002P002G001, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r170-smll-158987815600230
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 6.6M
-rw-r--r-- 1 mcc users 64K Apr 1 20:27 CTLCardinality.txt
-rw-r--r-- 1 mcc users 252K Apr 1 20:27 CTLCardinality.xml
-rw-r--r-- 1 mcc users 82K Apr 1 13:55 CTLFireability.txt
-rw-r--r-- 1 mcc users 232K Apr 1 13:55 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.7K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 47K Apr 8 14:53 LTLCardinality.txt
-rw-r--r-- 1 mcc users 194K Apr 28 14:01 LTLCardinality.xml
-rw-r--r-- 1 mcc users 79K Apr 8 14:53 LTLFireability.txt
-rw-r--r-- 1 mcc users 228K Apr 28 14:01 LTLFireability.xml
-rw-r--r-- 1 mcc users 25K Apr 1 10:53 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 96K Apr 1 10:53 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 134K Apr 1 06:38 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 363K Apr 1 06:38 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 15K Apr 1 13:18 UpperBounds.txt
-rw-r--r-- 1 mcc users 41K Apr 1 13:18 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 equiv_col
-rw-r--r-- 1 mcc users 24 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 4.7M 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 FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-00
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-01
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-02
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-03
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-04
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-05
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-06
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-07
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-08
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-09
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-10
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-11
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-12
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-13
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-14
FORMULA_NAME FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591299509855

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 19:38:33] [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 19:38:33] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 19:38:33] [INFO ] Load time of PNML (sax parser for PT used): 784 ms
[2020-06-04 19:38:34] [INFO ] Transformed 12194 places.
[2020-06-04 19:38:34] [INFO ] Transformed 10560 transitions.
[2020-06-04 19:38:34] [INFO ] Parsed PT model containing 12194 places and 10560 transitions in 948 ms.
Reduce places removed 17 places and 0 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 637 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 3 resets, run finished after 449 ms. (steps per millisecond=22 ) properties seen :[0, 1, 1, 1, 1, 1, 1, 1, 0, 0, 1, 1, 1, 0, 0, 1]
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-12 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-11 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-10 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-06 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-05 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-04 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-03 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-01 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 100 ms. (steps per millisecond=100 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 41 ms. (steps per millisecond=243 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 53 ms. (steps per millisecond=188 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 30 ms. (steps per millisecond=333 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 48 ms. (steps per millisecond=208 ) properties seen :[0, 0, 0, 0, 0]
// Phase 1: matrix 10560 rows 12177 cols
[2020-06-04 19:38:37] [INFO ] Computed 2768 place invariants in 1549 ms
[2020-06-04 19:38:41] [INFO ] [Real]Absence check using 149 positive place invariants in 2278 ms returned sat
[2020-06-04 19:38:42] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 19:38:42] [INFO ] [Real]Absence check using 149 positive and 2619 generalized place invariants in 805 ms returned (error "Failed to check-sat")
[2020-06-04 19:38:42] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 19:38:42] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed") while checking expression at index 0
[2020-06-04 19:38:46] [INFO ] [Real]Absence check using 149 positive place invariants in 1606 ms returned sat
[2020-06-04 19:38:47] [INFO ] [Real]Absence check using 149 positive and 2619 generalized place invariants in 969 ms returned (error "Solver has unexpectedly terminated")
[2020-06-04 19:38:47] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 19:38:47] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed") while checking expression at index 1
[2020-06-04 19:38:51] [INFO ] [Real]Absence check using 149 positive place invariants in 2173 ms returned sat
[2020-06-04 19:38:52] [INFO ] [Real]Absence check using 149 positive and 2619 generalized place invariants in 991 ms returned (error "Solver has unexpectedly terminated")
[2020-06-04 19:38:52] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 19:38:52] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed") while checking expression at index 2
[2020-06-04 19:38:56] [INFO ] [Real]Absence check using 149 positive place invariants in 1921 ms returned unsat
[2020-06-04 19:39:01] [INFO ] [Real]Absence check using 149 positive place invariants in 2321 ms returned sat
[2020-06-04 19:39:01] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 19:39:01] [INFO ] [Real]Absence check using 149 positive and 2619 generalized place invariants in 170 ms returned (error "Failed to check-sat")
[2020-06-04 19:39:01] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 19:39:01] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed") while checking expression at index 4
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-13 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Support contains 385 out of 12177 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 12177/12177 places, 10560/10560 transitions.
Discarding 565 places :
Also discarding 444 output transitions
Drop transitions removed 444 transitions
Graph (complete) has 18927 edges and 12177 vertex of which 11612 are kept as prefixes of interest. Removing 565 places using SCC suffix rule.93 ms
Drop transitions removed 6 transitions
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 7 transitions.
Discarding 1834 places :
Implicit places reduction removed 1834 places
Performed 4771 Post agglomeration using F-continuation condition.Transition count delta: 4771
Iterating post reduction 0 with 6612 rules applied. Total rules applied 6613 place count 9778 transition count 5338
Reduce places removed 4771 places and 0 transitions.
Iterating post reduction 1 with 4771 rules applied. Total rules applied 11384 place count 5007 transition count 5338
Performed 565 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 565 Pre rules applied. Total rules applied 11384 place count 5007 transition count 4773
Deduced a syphon composed of 565 places in 11 ms
Ensure Unique test removed 306 places
Reduce places removed 871 places and 0 transitions.
Iterating global reduction 2 with 1436 rules applied. Total rules applied 12820 place count 4136 transition count 4773
Discarding 2 places :
Implicit places reduction removed 2 places
Performed 202 Post agglomeration using F-continuation condition.Transition count delta: 202
Iterating post reduction 2 with 204 rules applied. Total rules applied 13024 place count 4134 transition count 4571
Reduce places removed 202 places and 0 transitions.
Iterating post reduction 3 with 202 rules applied. Total rules applied 13226 place count 3932 transition count 4571
Symmetric choice reduction at 4 with 914 rule applications. Total rules 14140 place count 3932 transition count 4571
Deduced a syphon composed of 914 places in 12 ms
Reduce places removed 914 places and 914 transitions.
Iterating global reduction 4 with 1828 rules applied. Total rules applied 15968 place count 3018 transition count 3657
Performed 199 Post agglomeration using F-continuation condition.Transition count delta: 199
Iterating post reduction 4 with 199 rules applied. Total rules applied 16167 place count 3018 transition count 3458
Reduce places removed 199 places and 0 transitions.
Iterating post reduction 5 with 199 rules applied. Total rules applied 16366 place count 2819 transition count 3458
Performed 1 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 6 with 1 Pre rules applied. Total rules applied 16366 place count 2819 transition count 3457
Deduced a syphon composed of 1 places in 8 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 6 with 2 rules applied. Total rules applied 16368 place count 2818 transition count 3457
Symmetric choice reduction at 6 with 102 rule applications. Total rules 16470 place count 2818 transition count 3457
Deduced a syphon composed of 102 places in 4 ms
Reduce places removed 102 places and 102 transitions.
Iterating global reduction 6 with 204 rules applied. Total rules applied 16674 place count 2716 transition count 3355
Performed 51 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 6 with 51 Pre rules applied. Total rules applied 16674 place count 2716 transition count 3304
Deduced a syphon composed of 51 places in 4 ms
Reduce places removed 51 places and 0 transitions.
Iterating global reduction 6 with 102 rules applied. Total rules applied 16776 place count 2665 transition count 3304
Symmetric choice reduction at 6 with 2 rule applications. Total rules 16778 place count 2665 transition count 3304
Deduced a syphon composed of 2 places in 2 ms
Reduce places removed 2 places and 102 transitions.
Iterating global reduction 6 with 4 rules applied. Total rules applied 16782 place count 2663 transition count 3202
Ensure Unique test removed 102 transitions
Reduce isomorphic transitions removed 102 transitions.
Discarding 51 places :
Implicit places reduction removed 51 places
Performed 51 Post agglomeration using F-continuation condition.Transition count delta: 51
Iterating post reduction 6 with 204 rules applied. Total rules applied 16986 place count 2612 transition count 3049
Reduce places removed 51 places and 0 transitions.
Iterating post reduction 7 with 51 rules applied. Total rules applied 17037 place count 2561 transition count 3049
Performed 360 Post agglomeration using F-continuation condition.Transition count delta: 360
Deduced a syphon composed of 360 places in 3 ms
Ensure Unique test removed 48 places
Reduce places removed 408 places and 0 transitions.
Iterating global reduction 8 with 768 rules applied. Total rules applied 17805 place count 2153 transition count 2689
Performed 48 Post agglomeration using F-continuation condition.Transition count delta: 48
Deduced a syphon composed of 48 places in 2 ms
Reduce places removed 48 places and 0 transitions.
Iterating global reduction 8 with 96 rules applied. Total rules applied 17901 place count 2105 transition count 2641
Free-agglomeration rule applied 5 times.
Iterating global reduction 8 with 5 rules applied. Total rules applied 17906 place count 2105 transition count 2636
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 8 with 5 rules applied. Total rules applied 17911 place count 2100 transition count 2636
Free-agglomeration rule (complex) applied 415 times.
Iterating global reduction 9 with 415 rules applied. Total rules applied 18326 place count 2100 transition count 2221
Ensure Unique test removed 100 places
Reduce places removed 515 places and 0 transitions.
Iterating post reduction 9 with 515 rules applied. Total rules applied 18841 place count 1585 transition count 2221
Performed 1 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 10 with 1 Pre rules applied. Total rules applied 18841 place count 1585 transition count 2220
Deduced a syphon composed of 1 places in 3 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 10 with 2 rules applied. Total rules applied 18843 place count 1584 transition count 2220
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 10 with 1 rules applied. Total rules applied 18844 place count 1583 transition count 2219
Applied a total of 18844 rules in 5427 ms. Remains 1583 /12177 variables (removed 10594) and now considering 2219/10560 (removed 8341) transitions.
Finished structural reductions, in 1 iterations. Remains : 1583/12177 places, 2219/10560 transitions.
Incomplete random walk after 1000000 steps, including 2097 resets, run finished after 16236 ms. (steps per millisecond=61 ) properties seen :[0, 1, 1, 1]
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-14 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-08 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Interrupted Best-First random walk after 486528 steps, including 9 resets, run timeout after 5001 ms. (steps per millisecond=97 ) properties seen :[0]
// Phase 1: matrix 2219 rows 1583 cols
[2020-06-04 19:39:28] [INFO ] Computed 268 place invariants in 48 ms
[2020-06-04 19:39:29] [INFO ] [Real]Absence check using 0 positive and 268 generalized place invariants in 465 ms returned sat
[2020-06-04 19:39:29] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 19:39:33] [INFO ] [Real]Absence check using state equation in 4494 ms returned unsat
FORMULA FamilyReunion-PT-L00050M0005C002P002G001-ReachabilityCardinality-00 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
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="FamilyReunion-PT-L00050M0005C002P002G001"
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 FamilyReunion-PT-L00050M0005C002P002G001, 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 r170-smll-158987815600230"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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