Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2021-input.r094-tall-162048902800435.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/fkordon/mcc2021-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 gold2020
Input is FamilyReunion-COL-L00100M0010C005P005G002, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r094-tall-162048902800435
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 524K
-rw-r--r-- 1 mcc users 12K May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 116K May 10 09:43 CTLCardinality.xml
-rw-r--r-- 1 mcc users 18K May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 94K May 10 09:43 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 6 14:48 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 7.0K May 6 14:48 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.3K Mar 28 16:09 LTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Mar 28 16:09 LTLCardinality.xml
-rw-r--r-- 1 mcc users 3.1K Mar 28 16:09 LTLFireability.txt
-rw-r--r-- 1 mcc users 19K Mar 28 16:09 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Mar 23 10:50 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 21K Mar 23 10:49 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.6K Mar 22 18:56 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 16K Mar 22 18:55 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.0K Mar 22 09:12 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.0K Mar 22 09:11 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_pt
-rw-r--r-- 1 mcc users 24 May 5 16:51 instance
-rw-r--r-- 1 mcc users 5 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 140K May 5 16:51 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-COL-L00100M0010C005P005G002-ReachabilityCardinality-00
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-01
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-02
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-03
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-04
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-05
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-06
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-07
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-08
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-09
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-10
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-11
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-12
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-13
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-14
FORMULA_NAME FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1620787450170

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2021-05-12 02:44:11] [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]
[2021-05-12 02:44:11] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-12 02:44:11] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2021-05-12 02:44:12] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 664 ms
[2021-05-12 02:44:12] [INFO ] sort/places :
Response->r0,
LxM->m1,ml0,l2,m2,lm1,l3,m3,ml1,l4,lm2,m4,m5,l5,ml2,l6,lm3,m6,m7,ml3,l7,m9,m10,ml4,
CINFORMI->c2,c4,c7,c0,c1,
LxP->p1,p3,p2,p5,p4,p6,p9,pl0,pl1,
LegalResident->lm0,l12,l0,l30,l31,lc1,l1,l32,lc2,l33,lc3,l34,cg0,l35,lg0,l36,l8,l9,lm4,l38,l10,l11,l13,l16,l14,lc0,l15,l17,l18,lp0,l19,lp1,l20,l21,l22,l24,l25,l23,l28,l26,l27,l29,
LxC->c3,cl2,c5,c6,cl0,cl1,
LxR->gl1,l37,l39,l40,
GovernmentCommission->g0,g2,g4,
PublicAdminOffice->p0,p7,p8,p10,p11,
MICSystem->m0,m8,m11,
LxG->g1,gl0,g3,

[2021-05-12 02:44:12] [INFO ] Detected 5 constant HL places corresponding to 31 PT places.
[2021-05-12 02:44:12] [INFO ] Imported 104 HL places and 66 HL transitions for a total of 40706 PT places and 36972.0 transition bindings in 62 ms.
[2021-05-12 02:44:12] [INFO ] Computed order based on color domains.
[2021-05-12 02:44:12] [INFO ] Unfolded HLPN to a Petri net with 40706 places and 36871 transitions in 209 ms.
[2021-05-12 02:44:12] [INFO ] Unfolded HLPN properties in 3 ms.
Deduced a syphon composed of 101 places in 216 ms
Reduce places removed 132 places and 0 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 881 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 1 resets, run finished after 967 ms. (steps per millisecond=10 ) properties seen :[0, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 0, 1]
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-12 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-11 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-10 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-08 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-06 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-05 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 344 ms. (steps per millisecond=29 ) properties seen :[0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 860 ms. (steps per millisecond=11 ) properties seen :[0, 0]
// Phase 1: matrix 36871 rows 40574 cols
[2021-05-12 02:44:28] [INFO ] Computed 8805 place invariants in 12922 ms
[2021-05-12 02:44:33] [INFO ] SMT solver returned unknown. Retrying;
[2021-05-12 02:44:33] [INFO ] [Real]Absence check using 115 positive place invariants in 1433 ms returned (error "Failed to check-sat")
[2021-05-12 02:44:33] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-12 02:44:33] [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
[2021-05-12 02:44:38] [INFO ] [Real]Absence check using 115 positive place invariants in 1676 ms returned (error "Solver has unexpectedly terminated")
[2021-05-12 02:44:38] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-12 02:44:38] [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
Support contains 5362 out of 40574 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 40574/40574 places, 36871/36871 transitions.
Discarding 442 places :
Also discarding 101 output transitions
Drop transitions removed 101 transitions
Graph (complete) has 65258 edges and 40574 vertex of which 40132 are kept as prefixes of interest. Removing 442 places using SCC suffix rule.121 ms
Discarding 4444 places :
Implicit places reduction removed 4444 places
Performed 10201 Post agglomeration using F-continuation condition.Transition count delta: 10201
Iterating post reduction 0 with 14645 rules applied. Total rules applied 14646 place count 35688 transition count 26569
Reduce places removed 10201 places and 0 transitions.
Iterating post reduction 1 with 10201 rules applied. Total rules applied 24847 place count 25487 transition count 26569
Performed 3232 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 3232 Pre rules applied. Total rules applied 24847 place count 25487 transition count 23337
Deduced a syphon composed of 3232 places in 60 ms
Ensure Unique test removed 1818 places
Reduce places removed 5050 places and 0 transitions.
Iterating global reduction 2 with 8282 rules applied. Total rules applied 33129 place count 20437 transition count 23337
Symmetric choice reduction at 2 with 202 rule applications. Total rules 33331 place count 20437 transition count 23337
Deduced a syphon composed of 202 places in 19 ms
Reduce places removed 202 places and 404 transitions.
Iterating global reduction 2 with 404 rules applied. Total rules applied 33735 place count 20235 transition count 22933
Symmetric choice reduction at 2 with 2 rule applications. Total rules 33737 place count 20235 transition count 22933
Deduced a syphon composed of 2 places in 18 ms
Reduce places removed 2 places and 202 transitions.
Iterating global reduction 2 with 4 rules applied. Total rules applied 33741 place count 20233 transition count 22731
Performed 1414 Post agglomeration using F-continuation condition.Transition count delta: 1414
Deduced a syphon composed of 1414 places in 14 ms
Reduce places removed 1414 places and 0 transitions.
Iterating global reduction 2 with 2828 rules applied. Total rules applied 36569 place count 18819 transition count 21317
Free-agglomeration rule (complex) applied 2222 times.
Iterating global reduction 2 with 2222 rules applied. Total rules applied 38791 place count 18819 transition count 21620
Ensure Unique test removed 303 places
Reduce places removed 2525 places and 0 transitions.
Iterating post reduction 2 with 2525 rules applied. Total rules applied 41316 place count 16294 transition count 21620
Symmetric choice reduction at 3 with 2737 rule applications. Total rules 44053 place count 16294 transition count 21620
Deduced a syphon composed of 2737 places in 10 ms
Reduce places removed 2737 places and 6262 transitions.
Iterating global reduction 3 with 5474 rules applied. Total rules applied 49527 place count 13557 transition count 15358
Ensure Unique test removed 101 places
Ensure Unique test removed 1010 transitions
Reduce isomorphic transitions removed 1010 transitions.
Iterating post reduction 3 with 1111 rules applied. Total rules applied 50638 place count 13456 transition count 14348
Performed 101 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 101 Pre rules applied. Total rules applied 50638 place count 13456 transition count 14247
Deduced a syphon composed of 101 places in 6 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 4 with 202 rules applied. Total rules applied 50840 place count 13355 transition count 14247
Symmetric choice reduction at 4 with 10 rule applications. Total rules 50850 place count 13355 transition count 14247
Deduced a syphon composed of 10 places in 6 ms
Reduce places removed 10 places and 1010 transitions.
Iterating global reduction 4 with 20 rules applied. Total rules applied 50870 place count 13345 transition count 13237
Discarding 101 places :
Implicit places reduction removed 101 places
Performed 101 Post agglomeration using F-continuation condition.Transition count delta: 101
Iterating post reduction 4 with 202 rules applied. Total rules applied 51072 place count 13244 transition count 13136
Reduce places removed 101 places and 0 transitions.
Iterating post reduction 5 with 101 rules applied. Total rules applied 51173 place count 13143 transition count 13136
Performed 101 Post agglomeration using F-continuation condition.Transition count delta: 101
Deduced a syphon composed of 101 places in 5 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 6 with 202 rules applied. Total rules applied 51375 place count 13042 transition count 13035
Applied a total of 51375 rules in 19190 ms. Remains 13042 /40574 variables (removed 27532) and now considering 13035/36871 (removed 23836) transitions.
Finished structural reductions, in 1 iterations. Remains : 13042/40574 places, 13035/36871 transitions.
Finished random walk after 5325 steps, including 2 resets, run visited all 2 properties in 116 ms. (steps per millisecond=45 )
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-14 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00100M0010C005P005G002-ReachabilityCardinality-00 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-COL-L00100M0010C005P005G002"
export BK_EXAMINATION="ReachabilityCardinality"
export BK_TOOL="gold2020"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
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-4028"
echo " Executing tool gold2020"
echo " Input is FamilyReunion-COL-L00100M0010C005P005G002, 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 r094-tall-162048902800435"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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