Execution Chart

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

Trace from the execution

Formatting '/mnt/tpsp/fkordon/mcc2020-input.r178-tajo-158987881800030.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/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 DLCshifumi-PT-3b, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r178-tajo-158987881800030
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 2.4M
-rw-r--r-- 1 mcc users 3.2K Mar 30 21:48 CTLCardinality.txt
-rw-r--r-- 1 mcc users 17K Mar 30 21:48 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.5K Mar 29 12:05 CTLFireability.txt
-rw-r--r-- 1 mcc users 17K Mar 29 12:05 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.0K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.3K Apr 8 14:51 LTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Apr 28 14:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Apr 8 14:51 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 28 14:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.1K Mar 28 07:25 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 22K Mar 28 07:25 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.4K Mar 27 01:49 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 13K Mar 27 01:49 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K 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 2.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 DLCshifumi-PT-3b-ReachabilityCardinality-00
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-01
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-02
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-03
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-04
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-05
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-06
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-07
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-08
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-09
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-10
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-11
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-12
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-13
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-14
FORMULA_NAME DLCshifumi-PT-3b-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591199219594

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-03 15:47:01] [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 15:47:01] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-03 15:47:01] [INFO ] Load time of PNML (sax parser for PT used): 297 ms
[2020-06-03 15:47:01] [INFO ] Transformed 7058 places.
[2020-06-03 15:47:01] [INFO ] Transformed 9611 transitions.
[2020-06-03 15:47:01] [INFO ] Found NUPN structural information;
[2020-06-03 15:47:01] [INFO ] Parsed PT model containing 7058 places and 9611 transitions in 468 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 327 ms.
Working with output stream class java.io.PrintStream
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-00 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-11 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 0 resets, run finished after 129 ms. (steps per millisecond=77 ) properties seen :[1, 1, 0, 0, 1, 0, 1, 0, 1]
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-14 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-12 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-08 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-02 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
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]
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]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 23 ms. (steps per millisecond=434 ) properties seen :[0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 15 ms. (steps per millisecond=666 ) properties seen :[0, 0, 0, 0]
// Phase 1: matrix 9611 rows 7058 cols
[2020-06-03 15:47:02] [INFO ] Computed 282 place invariants in 200 ms
[2020-06-03 15:47:05] [INFO ] [Real]Absence check using 282 positive place invariants in 1485 ms returned sat
[2020-06-03 15:47:05] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 15:47:07] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-03 15:47:07] [INFO ] [Real]Absence check using state equation in 2706 ms returned (error "Failed to check-sat")
[2020-06-03 15:47:10] [INFO ] [Real]Absence check using 282 positive place invariants in 1566 ms returned sat
[2020-06-03 15:47:10] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 15:47:12] [INFO ] [Real]Absence check using state equation in 2334 ms returned (error "Solver has unexpectedly terminated")
[2020-06-03 15:47:15] [INFO ] [Real]Absence check using 282 positive place invariants in 1232 ms returned sat
[2020-06-03 15:47:15] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 15:47:17] [INFO ] [Real]Absence check using state equation in 2632 ms returned (error "Solver has unexpectedly terminated")
[2020-06-03 15:47:19] [INFO ] [Real]Absence check using 282 positive place invariants in 1222 ms returned sat
[2020-06-03 15:47:19] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 15:47:22] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-03 15:47:22] [INFO ] [Real]Absence check using state equation in 3023 ms returned (error "Failed to check-sat")
Support contains 22 out of 7058 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 7058/7058 places, 9611/9611 transitions.
Graph (trivial) has 6744 edges and 7058 vertex of which 759 / 7058 are part of one of the 49 SCC in 58 ms
Free SCC test removed 710 places
Drop transitions removed 801 transitions
Reduce isomorphic transitions removed 801 transitions.
Performed 3507 Post agglomeration using F-continuation condition.Transition count delta: 3507
Iterating post reduction 0 with 4308 rules applied. Total rules applied 4309 place count 6348 transition count 5303
Reduce places removed 3507 places and 0 transitions.
Ensure Unique test removed 126 transitions
Reduce isomorphic transitions removed 126 transitions.
Performed 122 Post agglomeration using F-continuation condition.Transition count delta: 122
Iterating post reduction 1 with 3755 rules applied. Total rules applied 8064 place count 2841 transition count 5055
Reduce places removed 122 places and 0 transitions.
Ensure Unique test removed 38 transitions
Reduce isomorphic transitions removed 38 transitions.
Performed 38 Post agglomeration using F-continuation condition.Transition count delta: 38
Iterating post reduction 2 with 198 rules applied. Total rules applied 8262 place count 2719 transition count 4979
Reduce places removed 38 places and 0 transitions.
Iterating post reduction 3 with 38 rules applied. Total rules applied 8300 place count 2681 transition count 4979
Performed 55 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 55 Pre rules applied. Total rules applied 8300 place count 2681 transition count 4924
Deduced a syphon composed of 55 places in 105 ms
Reduce places removed 55 places and 0 transitions.
Iterating global reduction 4 with 110 rules applied. Total rules applied 8410 place count 2626 transition count 4924
Symmetric choice reduction at 4 with 730 rule applications. Total rules 9140 place count 2626 transition count 4924
Deduced a syphon composed of 730 places in 39 ms
Reduce places removed 730 places and 730 transitions.
Iterating global reduction 4 with 1460 rules applied. Total rules applied 10600 place count 1896 transition count 4194
Performed 273 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 273 Pre rules applied. Total rules applied 10600 place count 1896 transition count 3921
Deduced a syphon composed of 273 places in 76 ms
Reduce places removed 273 places and 0 transitions.
Iterating global reduction 4 with 546 rules applied. Total rules applied 11146 place count 1623 transition count 3921
Symmetric choice reduction at 4 with 93 rule applications. Total rules 11239 place count 1623 transition count 3921
Deduced a syphon composed of 93 places in 27 ms
Reduce places removed 93 places and 1077 transitions.
Iterating global reduction 4 with 186 rules applied. Total rules applied 11425 place count 1530 transition count 2844
Ensure Unique test removed 78 transitions
Reduce isomorphic transitions removed 78 transitions.
Iterating post reduction 4 with 78 rules applied. Total rules applied 11503 place count 1530 transition count 2766
Performed 385 Post agglomeration using F-continuation condition with reduction of 3 identical transitions.
Deduced a syphon composed of 385 places in 1 ms
Reduce places removed 385 places and 0 transitions.
Iterating global reduction 5 with 770 rules applied. Total rules applied 12273 place count 1145 transition count 2378
Ensure Unique test removed 3 transitions
Reduce isomorphic transitions removed 3 transitions.
Iterating post reduction 5 with 3 rules applied. Total rules applied 12276 place count 1145 transition count 2375
Renaming transitions due to excessive name length > 1024 char.
Performed 101 Post agglomeration using F-continuation condition with reduction of 93 identical transitions.
Deduced a syphon composed of 101 places in 1 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 6 with 202 rules applied. Total rules applied 12478 place count 1044 transition count 2583
Ensure Unique test removed 2 transitions
Reduce isomorphic transitions removed 2 transitions.
Iterating post reduction 6 with 2 rules applied. Total rules applied 12480 place count 1044 transition count 2581
Performed 22 Post agglomeration using F-continuation condition with reduction of 15 identical transitions.
Deduced a syphon composed of 22 places in 1 ms
Reduce places removed 22 places and 0 transitions.
Iterating global reduction 7 with 44 rules applied. Total rules applied 12524 place count 1022 transition count 2652
Drop transitions removed 10 transitions
Reduce isomorphic transitions removed 10 transitions.
Iterating post reduction 7 with 10 rules applied. Total rules applied 12534 place count 1022 transition count 2642
Free-agglomeration rule applied 596 times with reduction of 346 identical transitions.
Iterating global reduction 8 with 596 rules applied. Total rules applied 13130 place count 1022 transition count 1700
Reduce places removed 596 places and 0 transitions.
Drop transitions removed 695 transitions
Ensure Unique test removed 8 transitions
Reduce isomorphic transitions removed 703 transitions.
Discarding 151 places :
Also discarding 158 output transitions
Drop transitions removed 158 transitions
Graph (complete) has 1338 edges and 426 vertex of which 275 are kept as prefixes of interest. Removing 151 places using SCC suffix rule.6 ms
Iterating post reduction 8 with 1300 rules applied. Total rules applied 14430 place count 275 transition count 839
Drop transitions removed 154 transitions
Ensure Unique test removed 12 transitions
Reduce isomorphic transitions removed 166 transitions.
Iterating post reduction 9 with 166 rules applied. Total rules applied 14596 place count 275 transition count 673
Symmetric choice reduction at 10 with 9 rule applications. Total rules 14605 place count 275 transition count 673
Deduced a syphon composed of 9 places in 0 ms
Reduce places removed 9 places and 27 transitions.
Iterating global reduction 10 with 18 rules applied. Total rules applied 14623 place count 266 transition count 646
Ensure Unique test removed 22 transitions
Reduce isomorphic transitions removed 22 transitions.
Iterating post reduction 10 with 22 rules applied. Total rules applied 14645 place count 266 transition count 624
Free-agglomeration rule (complex) applied 9 times.
Iterating global reduction 11 with 9 rules applied. Total rules applied 14654 place count 266 transition count 978
Reduce places removed 9 places and 0 transitions.
Drop transitions removed 366 transitions
Reduce isomorphic transitions removed 366 transitions.
Iterating post reduction 11 with 375 rules applied. Total rules applied 15029 place count 257 transition count 612
Symmetric choice reduction at 12 with 4 rule applications. Total rules 15033 place count 257 transition count 612
Deduced a syphon composed of 4 places in 0 ms
Reduce places removed 4 places and 4 transitions.
Iterating global reduction 12 with 8 rules applied. Total rules applied 15041 place count 253 transition count 608
Ensure Unique test removed 164 transitions
Reduce isomorphic transitions removed 164 transitions.
Iterating post reduction 12 with 164 rules applied. Total rules applied 15205 place count 253 transition count 444
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 0 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 13 with 4 rules applied. Total rules applied 15209 place count 251 transition count 442
Drop transitions removed 82 transitions
Reduce isomorphic transitions removed 82 transitions.
Discarding 54 places :
Also discarding 0 output transitions
Graph (complete) has 586 edges and 251 vertex of which 197 are kept as prefixes of interest. Removing 54 places using SCC suffix rule.1 ms
Iterating post reduction 13 with 83 rules applied. Total rules applied 15292 place count 197 transition count 360
Drop transitions removed 11 transitions
Redundant transition composition rules discarded 11 transitions
Iterating global reduction 14 with 11 rules applied. Total rules applied 15303 place count 197 transition count 349
Reduce places removed 2 places and 0 transitions.
Iterating post reduction 14 with 2 rules applied. Total rules applied 15305 place count 195 transition count 349
Applied a total of 15305 rules in 2159 ms. Remains 195 /7058 variables (removed 6863) and now considering 349/9611 (removed 9262) transitions.
Finished structural reductions, in 1 iterations. Remains : 195/7058 places, 349/9611 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 3471 ms. (steps per millisecond=288 ) properties seen :[1, 1, 1, 0]
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-09 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-06 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-05 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Finished Best-First random walk after 131 steps, including 0 resets, run visited all 1 properties in 1 ms. (steps per millisecond=131 )
FORMULA DLCshifumi-PT-3b-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL BESTFIRST_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="DLCshifumi-PT-3b"
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 DLCshifumi-PT-3b, 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 r178-tajo-158987881800030"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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