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

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 1.9M
-rw-r--r-- 1 mcc users 11K Apr 1 20:24 CTLCardinality.txt
-rw-r--r-- 1 mcc users 43K Apr 1 20:24 CTLCardinality.xml
-rw-r--r-- 1 mcc users 40K Apr 1 13:51 CTLFireability.txt
-rw-r--r-- 1 mcc users 110K Apr 1 13:51 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 19K Apr 8 14:53 LTLCardinality.txt
-rw-r--r-- 1 mcc users 90K Apr 28 14:01 LTLCardinality.xml
-rw-r--r-- 1 mcc users 32K Apr 8 14:53 LTLFireability.txt
-rw-r--r-- 1 mcc users 94K Apr 28 14:01 LTLFireability.xml
-rw-r--r-- 1 mcc users 14K Apr 1 10:51 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 55K Apr 1 10:51 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 35K Apr 1 06:35 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 98K Apr 1 06:35 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 3.9K Apr 1 13:18 UpperBounds.txt
-rw-r--r-- 1 mcc users 9.5K 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 1.3M 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-L00020M0002C001P001G001-ReachabilityCardinality-00
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-01
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-02
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-03
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-04
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-05
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-06
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-07
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-08
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-09
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-10
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-11
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-12
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-13
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-14
FORMULA_NAME FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591292166804

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 17:36:09] [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 17:36:09] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 17:36:10] [INFO ] Load time of PNML (sax parser for PT used): 386 ms
[2020-06-04 17:36:10] [INFO ] Transformed 3271 places.
[2020-06-04 17:36:10] [INFO ] Transformed 2753 transitions.
[2020-06-04 17:36:10] [INFO ] Parsed PT model containing 3271 places and 2753 transitions in 490 ms.
Reduce places removed 11 places and 0 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 194 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 8 resets, run finished after 216 ms. (steps per millisecond=46 ) properties seen :[1, 0, 1, 1, 1, 0, 1, 1, 0, 1, 0, 0, 1, 0, 0, 1]
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-15 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-12 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-03 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-00 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 129 ms. (steps per millisecond=77 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 64 ms. (steps per millisecond=156 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 29 ms. (steps per millisecond=344 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 25 ms. (steps per millisecond=400 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 31 ms. (steps per millisecond=322 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 34 ms. (steps per millisecond=294 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 21 ms. (steps per millisecond=476 ) properties seen :[0, 0, 0, 0, 0, 0, 0]
// Phase 1: matrix 2753 rows 3260 cols
[2020-06-04 17:36:11] [INFO ] Computed 748 place invariants in 612 ms
[2020-06-04 17:36:12] [INFO ] [Real]Absence check using 61 positive place invariants in 236 ms returned sat
[2020-06-04 17:36:15] [INFO ] [Real]Absence check using 61 positive and 687 generalized place invariants in 2512 ms returned unsat
[2020-06-04 17:36:16] [INFO ] [Real]Absence check using 61 positive place invariants in 313 ms returned sat
[2020-06-04 17:36:19] [INFO ] [Real]Absence check using 61 positive and 687 generalized place invariants in 2878 ms returned sat
[2020-06-04 17:36:19] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 17:36:20] [INFO ] [Real]Absence check using state equation in 1056 ms returned (error "Solver has unexpectedly terminated")
[2020-06-04 17:36:21] [INFO ] [Real]Absence check using 61 positive place invariants in 333 ms returned sat
[2020-06-04 17:36:22] [INFO ] [Real]Absence check using 61 positive and 687 generalized place invariants in 1133 ms returned unsat
[2020-06-04 17:36:23] [INFO ] [Real]Absence check using 61 positive place invariants in 233 ms returned unsat
[2020-06-04 17:36:24] [INFO ] [Real]Absence check using 61 positive place invariants in 283 ms returned sat
[2020-06-04 17:36:26] [INFO ] [Real]Absence check using 61 positive and 687 generalized place invariants in 2032 ms returned unsat
[2020-06-04 17:36:27] [INFO ] [Real]Absence check using 61 positive place invariants in 106 ms returned unsat
[2020-06-04 17:36:27] [INFO ] [Real]Absence check using 61 positive place invariants in 272 ms returned sat
[2020-06-04 17:36:30] [INFO ] [Real]Absence check using 61 positive and 687 generalized place invariants in 2212 ms returned sat
[2020-06-04 17:36:30] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 17:36:32] [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 (= s124 (- 1 t40))") while checking expression at index 6
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-13 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-11 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-10 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-08 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-01 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Support contains 106 out of 3260 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 3260/3260 places, 2753/2753 transitions.
Discarding 340 places :
Also discarding 244 output transitions
Drop transitions removed 244 transitions
Graph (complete) has 4960 edges and 3260 vertex of which 2920 are kept as prefixes of interest. Removing 340 places using SCC suffix rule.40 ms
Drop transitions removed 43 transitions
Reduce isomorphic transitions removed 43 transitions.
Discarding 378 places :
Implicit places reduction removed 378 places
Performed 1094 Post agglomeration using F-continuation condition.Transition count delta: 1094
Iterating post reduction 0 with 1515 rules applied. Total rules applied 1516 place count 2542 transition count 1372
Reduce places removed 1094 places and 0 transitions.
Iterating post reduction 1 with 1094 rules applied. Total rules applied 2610 place count 1448 transition count 1372
Performed 168 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 168 Pre rules applied. Total rules applied 2610 place count 1448 transition count 1204
Deduced a syphon composed of 168 places in 6 ms
Ensure Unique test removed 63 places
Reduce places removed 231 places and 0 transitions.
Iterating global reduction 2 with 399 rules applied. Total rules applied 3009 place count 1217 transition count 1204
Discarding 42 places :
Implicit places reduction removed 42 places
Performed 63 Post agglomeration using F-continuation condition.Transition count delta: 63
Iterating post reduction 2 with 105 rules applied. Total rules applied 3114 place count 1175 transition count 1141
Reduce places removed 63 places and 0 transitions.
Iterating post reduction 3 with 63 rules applied. Total rules applied 3177 place count 1112 transition count 1141
Symmetric choice reduction at 4 with 210 rule applications. Total rules 3387 place count 1112 transition count 1141
Deduced a syphon composed of 210 places in 4 ms
Reduce places removed 210 places and 229 transitions.
Iterating global reduction 4 with 420 rules applied. Total rules applied 3807 place count 902 transition count 912
Ensure Unique test removed 21 transitions
Reduce isomorphic transitions removed 21 transitions.
Discarding 43 places :
Implicit places reduction removed 43 places
Performed 169 Post agglomeration using F-continuation condition.Transition count delta: 169
Iterating post reduction 4 with 233 rules applied. Total rules applied 4040 place count 859 transition count 722
Reduce places removed 169 places and 0 transitions.
Iterating post reduction 5 with 169 rules applied. Total rules applied 4209 place count 690 transition count 722
Performed 3 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 6 with 3 Pre rules applied. Total rules applied 4209 place count 690 transition count 719
Deduced a syphon composed of 3 places in 2 ms
Reduce places removed 3 places and 0 transitions.
Iterating global reduction 6 with 6 rules applied. Total rules applied 4215 place count 687 transition count 719
Symmetric choice reduction at 6 with 5 rule applications. Total rules 4220 place count 687 transition count 719
Deduced a syphon composed of 5 places in 2 ms
Reduce places removed 5 places and 86 transitions.
Iterating global reduction 6 with 10 rules applied. Total rules applied 4230 place count 682 transition count 633
Ensure Unique test removed 21 transitions
Reduce isomorphic transitions removed 21 transitions.
Discarding 83 places :
Implicit places reduction removed 83 places
Performed 83 Post agglomeration using F-continuation condition.Transition count delta: 83
Iterating post reduction 6 with 187 rules applied. Total rules applied 4417 place count 599 transition count 529
Reduce places removed 83 places and 0 transitions.
Iterating post reduction 7 with 83 rules applied. Total rules applied 4500 place count 516 transition count 529
Performed 62 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 8 with 62 Pre rules applied. Total rules applied 4500 place count 516 transition count 467
Deduced a syphon composed of 62 places in 1 ms
Reduce places removed 62 places and 0 transitions.
Iterating global reduction 8 with 124 rules applied. Total rules applied 4624 place count 454 transition count 467
Symmetric choice reduction at 8 with 19 rule applications. Total rules 4643 place count 454 transition count 467
Deduced a syphon composed of 19 places in 1 ms
Reduce places removed 19 places and 19 transitions.
Iterating global reduction 8 with 38 rules applied. Total rules applied 4681 place count 435 transition count 448
Performed 44 Post agglomeration using F-continuation condition.Transition count delta: 44
Deduced a syphon composed of 44 places in 1 ms
Reduce places removed 44 places and 0 transitions.
Iterating global reduction 8 with 88 rules applied. Total rules applied 4769 place count 391 transition count 404
Free-agglomeration rule (complex) applied 65 times.
Iterating global reduction 8 with 65 rules applied. Total rules applied 4834 place count 391 transition count 339
Ensure Unique test removed 1 places
Reduce places removed 66 places and 0 transitions.
Iterating post reduction 8 with 66 rules applied. Total rules applied 4900 place count 325 transition count 339
Partial Free-agglomeration rule applied 1 times.
Drop transitions removed 1 transitions
Iterating global reduction 9 with 1 rules applied. Total rules applied 4901 place count 325 transition count 339
Applied a total of 4901 rules in 1073 ms. Remains 325 /3260 variables (removed 2935) and now considering 339/2753 (removed 2414) transitions.
Finished structural reductions, in 1 iterations. Remains : 325/3260 places, 339/2753 transitions.
Finished random walk after 128 steps, including 0 resets, run visited all 2 properties in 3 ms. (steps per millisecond=42 )
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-14 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-PT-L00020M0002C001P001G001-ReachabilityCardinality-05 TRUE 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="FamilyReunion-PT-L00020M0002C001P001G001"
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-L00020M0002C001P001G001, 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-158987815600222"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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