Execution Chart

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

Trace from the execution

Formatting '/local/x2003239/mcc2020-input.r194-csrt-159033390100526.qcow2', fmt=qcow2 size=4294967296 backing_file=/local/x2003239/mcc2020-input.qcow2 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.....................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itslola
Input is TokenRing-PT-050, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r194-csrt-159033390100526
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 624M
-rw-r--r-- 1 mcc users 1.3M Apr 27 15:14 CTLCardinality.txt
-rw-r--r-- 1 mcc users 3.9M Apr 27 15:14 CTLCardinality.xml
-rw-r--r-- 1 mcc users 42M Apr 27 15:14 CTLFireability.txt
-rw-r--r-- 1 mcc users 112M Apr 27 15:14 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Apr 27 15:14 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.2K Apr 27 15:14 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 1.2M Apr 27 15:14 LTLCardinality.txt
-rw-r--r-- 1 mcc users 3.9M Apr 28 14:03 LTLCardinality.xml
-rw-r--r-- 1 mcc users 39M Apr 27 15:14 LTLFireability.txt
-rw-r--r-- 1 mcc users 105M Apr 28 14:04 LTLFireability.xml
-rw-r--r-- 1 mcc users 1.7M Apr 27 15:14 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 5.1M Apr 27 15:14 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 60M Apr 27 15:14 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 160M Apr 27 15:14 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 299K Apr 27 15:14 UpperBounds.txt
-rw-r--r-- 1 mcc users 707K Apr 27 15:14 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Apr 27 15:14 equiv_col
-rw-r--r-- 1 mcc users 4 Apr 27 15:14 instance
-rw-r--r-- 1 mcc users 6 Apr 27 15:14 iscolored
-rw-r--r-- 1 mcc users 91M Apr 27 15:14 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 TokenRing-PT-050-ReachabilityCardinality-00
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-01
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-02
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-03
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-04
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-05
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-06
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-07
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-08
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-09
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-10
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-11
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-12
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-13
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-14
FORMULA_NAME TokenRing-PT-050-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591231071223

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 00:37:53] [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 00:37:54] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 00:37:57] [INFO ] Load time of PNML (sax parser for PT used): 3476 ms
[2020-06-04 00:37:57] [INFO ] Transformed 2601 places.
[2020-06-04 00:37:58] [INFO ] Transformed 127551 transitions.
[2020-06-04 00:37:58] [INFO ] Found NUPN structural information;
[2020-06-04 00:37:58] [INFO ] Parsed PT model containing 2601 places and 127551 transitions in 4142 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 3127 ms.
Working with output stream class java.io.PrintStream
FORMULA TokenRing-PT-050-ReachabilityCardinality-00 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-05 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-050-ReachabilityCardinality-12 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 0 resets, run finished after 1271 ms. (steps per millisecond=7 ) properties seen :[1, 1, 0, 1, 1, 1]
FORMULA TokenRing-PT-050-ReachabilityCardinality-15 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-050-ReachabilityCardinality-14 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-050-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-050-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-050-ReachabilityCardinality-08 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10000 steps, including 0 resets, run finished after 775 ms. (steps per millisecond=12 ) properties seen :[0]
// Phase 1: matrix 127551 rows 2601 cols
[2020-06-04 00:38:04] [INFO ] Computed 51 place invariants in 607 ms
[2020-06-04 00:38:05] [INFO ] [Real]Absence check using 51 positive place invariants in 252 ms returned sat
[2020-06-04 00:38:05] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 00:38:09] [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: Broken pipe") while checking expression at index 0
Support contains 6 out of 2601 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 2601/2601 places, 127551/127551 transitions.
Applied a total of 0 rules in 12468 ms. Remains 2601 /2601 variables (removed 0) and now considering 127551/127551 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 2601/2601 places, 127551/127551 transitions.
Interrupted random walk after 371961 steps, including 0 resets, run timeout after 30001 ms. (steps per millisecond=12 ) properties seen :[0]
Interrupted Best-First random walk after 71433 steps, including 0 resets, run timeout after 5001 ms. (steps per millisecond=14 ) properties seen :[0]
Interrupted probabilistic random walk after 19734 steps, run timeout after 30001 ms. (steps per millisecond=0 ) properties seen :[0]
Probabilistic random walk after 19734 steps, saw 5497 distinct states, run finished after 30001 ms. (steps per millisecond=0 ) properties seen :[0]
// Phase 1: matrix 127551 rows 2601 cols
[2020-06-04 00:39:27] [INFO ] Computed 51 place invariants in 352 ms
[2020-06-04 00:39:28] [INFO ] [Real]Absence check using 51 positive place invariants in 178 ms returned sat
[2020-06-04 00:39:28] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 00:40:03] [INFO ] [Real]Absence check using state equation in 35591 ms returned sat
[2020-06-04 00:40:05] [INFO ] Solution in real domain found non-integer solution.
[2020-06-04 00:40:06] [INFO ] [Nat]Absence check using 51 positive place invariants in 180 ms returned sat
[2020-06-04 00:40:06] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-04 00:40:42] [INFO ] [Nat]Absence check using state equation in 36257 ms returned sat
[2020-06-04 00:40:45] [INFO ] State equation strengthened by 125050 read => feed constraints.
[2020-06-04 00:40:50] [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 (=> (> t16651 0) (or (> t3018 0) (> t3099 0) (> t9630 0) (> t11291 0) (> t11640 0) (> t13342 0) (> t13589 0) (> t15797 0) (> t18050 0) (> t20805 0) (> t20989 0) (> t21209 0) (> t23266 0) (> t27605 0) (> t30485 0) (> t31918 0) (> t34049 0) (> t44122 0) (> t44185 0) (> t47700 0) (> t47929 0) (> t48342 0) (> t52041 0) (> t52860 0) (> t54275 0) (> t55340 0) (> t56461 0) (> t57600 0) (> t58341 0) (> t61898 0) (> t62257 0) (> t68592 0) (> t68656 0) (> t71024 0) (> t72872 0) (> t73424 0) (> t75079 0) (> t79595 0) (> t83117 0) (> t92457 0) (> t92798 0) (> t94839 0) (> t105680 0) (> t105685 0) (> t106002 0) (> t114995 0) (> t121176 0) (> t124186 0) (> t124209 0) (> t126361 0)))") while checking expression at index 0
Support contains 6 out of 2601 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 2601/2601 places, 127551/127551 transitions.
Applied a total of 0 rules in 15295 ms. Remains 2601 /2601 variables (removed 0) and now considering 127551/127551 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 2601/2601 places, 127551/127551 transitions.
Starting structural reductions, iteration 0 : 2601/2601 places, 127551/127551 transitions.
Applied a total of 0 rules in 7321 ms. Remains 2601 /2601 variables (removed 0) and now considering 127551/127551 (removed 0) transitions.
// Phase 1: matrix 127551 rows 2601 cols
[2020-06-04 00:41:13] [INFO ] Computed 51 place invariants in 279 ms
[2020-06-04 00:41:14] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 00:41:32] [INFO ] Implicit Places using invariants in 19448 ms returned []
Implicit Place search using SMT only with invariants took 19453 ms to find 0 implicit places.
// Phase 1: matrix 127551 rows 2601 cols
[2020-06-04 00:41:33] [INFO ] Computed 51 place invariants in 331 ms
[2020-06-04 00:41:33] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 00:42:03] [INFO ] Performed 7207/127551 'is it Dead' test of which 0 returned DEAD in 30 seconds.
[2020-06-04 00:42:33] [INFO ] Dead Transitions with SMT raised an exceptionSMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Broken pipe (and (>= s388 1) (>= s1125 1))") after 60401 ms
Finished structural reductions, in 1 iterations. Remains : 2601/2601 places, 127551/127551 transitions.
Incomplete random walk after 100000 steps, including 0 resets, run finished after 7861 ms. (steps per millisecond=12 ) properties seen :[0]
// Phase 1: matrix 127551 rows 2601 cols
[2020-06-04 00:42:41] [INFO ] Computed 51 place invariants in 350 ms
[2020-06-04 00:42:42] [INFO ] [Real]Absence check using 51 positive place invariants in 177 ms returned sat
[2020-06-04 00:42:42] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 00:43:01] [INFO ] [Real]Absence check using state equation in 19424 ms returned (error "Solver has unexpectedly terminated")
Graph (trivial) has 127049 edges and 2601 vertex of which 2545 / 2601 are part of one of the 50 SCC in 144 ms
Free SCC test removed 2495 places
Discarding 45 places :
Also discarding 114750 output transitions
Drop transitions removed 114750 transitions
Graph (complete) has 61 edges and 106 vertex of which 61 are kept as prefixes of interest. Removing 45 places using SCC suffix rule.757 ms
Drop transitions removed 12250 transitions
Ensure Unique test removed 490 transitions
Reduce isomorphic transitions removed 12740 transitions.
Performed 48 Post agglomeration using F-continuation condition.Transition count delta: 48
Iterating post reduction 0 with 12788 rules applied. Total rules applied 12790 place count 61 transition count 13
Reduce places removed 48 places and 0 transitions.
Iterating post reduction 1 with 48 rules applied. Total rules applied 12838 place count 13 transition count 13
Performed 1 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 1 Pre rules applied. Total rules applied 12838 place count 13 transition count 12
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 12840 place count 12 transition count 12
Applied a total of 12840 rules in 1120 ms. Remains 12 /2601 variables (removed 2589) and now considering 12/127551 (removed 127539) transitions.
// Phase 1: matrix 12 rows 12 cols
[2020-06-04 00:43:03] [INFO ] Computed 6 place invariants in 0 ms
[2020-06-04 00:43:03] [INFO ] [Real]Absence check using 6 positive place invariants in 4 ms returned sat
[2020-06-04 00:43:03] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 00:43:03] [INFO ] [Real]Absence check using state equation in 8 ms returned sat
[2020-06-04 00:43:03] [INFO ] Solution in real domain found non-integer solution.
[2020-06-04 00:43:03] [INFO ] [Nat]Absence check using 6 positive place invariants in 3 ms returned sat
[2020-06-04 00:43:03] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-04 00:43:03] [INFO ] [Nat]Absence check using state equation in 5 ms returned sat
[2020-06-04 00:43:03] [INFO ] Computed and/alt/rep : 6/6/6 causal constraints in 2 ms.
[2020-06-04 00:43:03] [INFO ] Added : 0 causal constraints over 0 iterations in 8 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 3 ms.
[2020-06-04 00:43:03] [INFO ] Export to MCC properties in file /home/mcc/execution/ReachabilityCardinality.sr.xml took 2 ms.
[2020-06-04 00:43:03] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 451 ms.
[2020-06-04 00:43:08] [INFO ] Flatten gal took : 4062 ms
info: Time: 3600 - MCC
vrfy: Checking ReachabilityCardinality @ TokenRing-PT-050 @ 3570 seconds
vrfy: finished
info: timeLeft: 3283
rslt: Output for ReachabilityCardinality @ TokenRing-PT-050
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: input: PNML file (--pnml)
lola: reading net from model.pnml
lola: reading pnml
lola: PNML file contains place/transition net
lola: finished parsing
lola: closed net file model.pnml
lola: 130152/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 83232
lola: finding significant places
lola: 2601 places, 127551 transitions, 2550 significant places
lola: compute conflict clusters
lola: computed conflict clusters
lola: Computing conflicting sets
lola: Computing back conflicting sets
lola: TASK
lola: Reading formula in XML format (--xmlformula)
lola: reading pnml
lola: reading formula from ReachabilityCardinality.xml
lola: A (G ((((p511 <= 0)) OR ((p1383 <= 1) AND (1 <= p1383)) OR ((((p456 <= 0)) OR ((p1843 <= 1) AND (1 <= p1843))) AND (((p14 <= 0)) OR ((p2 <= 1) AND (1 <= p2)))))))
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: processed formula: A (G ((((p511 <= 0)) OR ((p1383 <= 1) AND (1 <= p1383)) OR ((((p456 <= 0)) OR ((p1843 <= 1) AND (1 <= p1843))) AND (((p14 <= 0)) OR ((p2 <= 1) AND (1 <= p2)))))))
lola: processed formula length: 166
lola: 2 rewrites
lola: closed formula file ReachabilityCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: built state equation task
lola: RUNNING
lola: subprocess will run for 0 seconds at most (--localtimelimit)
lola: local time limit reached - aborting
Segmentation fault
rslt: finished

--------------------
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="TokenRing-PT-050"
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 TokenRing-PT-050, 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 r194-csrt-159033390100526"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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