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.r166-smll-158987787700446.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 AutoFlight-PT-05b, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r166-smll-158987787700446
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 288K
-rw-r--r-- 1 mcc users 3.3K Mar 25 23:16 CTLCardinality.txt
-rw-r--r-- 1 mcc users 19K Mar 25 23:16 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.5K Mar 25 18:28 CTLFireability.txt
-rw-r--r-- 1 mcc users 17K Mar 25 18:28 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.2K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.2K Apr 8 14:42 LTLCardinality.txt
-rw-r--r-- 1 mcc users 24K Apr 28 14:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.9K Apr 8 14:42 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Apr 28 14:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.6K Mar 25 15:00 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 18K Mar 25 15:00 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Mar 25 10:43 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 12K Mar 25 10:43 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Mar 25 17:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Mar 25 17:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 equiv_col
-rw-r--r-- 1 mcc users 4 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 6 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 113K 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 AutoFlight-PT-05b-ReachabilityCardinality-00
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-01
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-02
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-03
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-04
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-05
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-06
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-07
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-08
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-09
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-10
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-11
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-12
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-13
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-14
FORMULA_NAME AutoFlight-PT-05b-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1591481082690

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-06 22:04:45] [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-06 22:04:45] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-06 22:04:45] [INFO ] Load time of PNML (sax parser for PT used): 134 ms
[2020-06-06 22:04:45] [INFO ] Transformed 482 places.
[2020-06-06 22:04:45] [INFO ] Transformed 480 transitions.
[2020-06-06 22:04:45] [INFO ] Found NUPN structural information;
[2020-06-06 22:04:45] [INFO ] Parsed PT model containing 482 places and 480 transitions in 198 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 42 ms.
Working with output stream class java.io.PrintStream
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-05 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-07 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-11 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 41 resets, run finished after 93 ms. (steps per millisecond=107 ) properties seen :[1, 1, 1, 1, 1, 0, 0, 1, 1, 0]
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-14 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-08 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-01 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-00 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10000 steps, including 3 resets, run finished after 30 ms. (steps per millisecond=333 ) properties seen :[1, 0, 0]
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL BESTFIRST_WALK
Incomplete Best-First random walk after 10001 steps, including 4 resets, run finished after 27 ms. (steps per millisecond=370 ) properties seen :[0, 0]
Incomplete Best-First random walk after 10001 steps, including 3 resets, run finished after 19 ms. (steps per millisecond=526 ) properties seen :[0, 0]
// Phase 1: matrix 480 rows 482 cols
[2020-06-06 22:04:45] [INFO ] Computed 34 place invariants in 35 ms
[2020-06-06 22:04:46] [INFO ] [Real]Absence check using 33 positive place invariants in 86 ms returned sat
[2020-06-06 22:04:46] [INFO ] [Real]Absence check using 33 positive and 1 generalized place invariants in 10 ms returned sat
[2020-06-06 22:04:46] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-06 22:04:47] [INFO ] [Real]Absence check using state equation in 843 ms returned sat
[2020-06-06 22:04:47] [INFO ] Solution in real domain found non-integer solution.
[2020-06-06 22:04:47] [INFO ] [Nat]Absence check using 33 positive place invariants in 108 ms returned sat
[2020-06-06 22:04:47] [INFO ] [Nat]Absence check using 33 positive and 1 generalized place invariants in 6 ms returned sat
[2020-06-06 22:04:47] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-06 22:04:48] [INFO ] [Nat]Absence check using state equation in 720 ms returned sat
[2020-06-06 22:04:48] [INFO ] Deduced a trap composed of 33 places in 416 ms
[2020-06-06 22:04:48] [INFO ] Deduced a trap composed of 43 places in 222 ms
[2020-06-06 22:04:49] [INFO ] Deduced a trap composed of 21 places in 216 ms
[2020-06-06 22:04:49] [INFO ] Deduced a trap composed of 39 places in 255 ms
[2020-06-06 22:04:49] [INFO ] Deduced a trap composed of 75 places in 202 ms
[2020-06-06 22:04:49] [INFO ] Deduced a trap composed of 64 places in 238 ms
[2020-06-06 22:04:50] [INFO ] Deduced a trap composed of 30 places in 258 ms
[2020-06-06 22:04:50] [INFO ] Deduced a trap composed of 30 places in 217 ms
[2020-06-06 22:04:50] [INFO ] Deduced a trap composed of 68 places in 250 ms
[2020-06-06 22:04:51] [INFO ] Deduced a trap composed of 29 places in 233 ms
[2020-06-06 22:04:51] [INFO ] Deduced a trap composed of 49 places in 211 ms
[2020-06-06 22:04:51] [INFO ] Deduced a trap composed of 63 places in 195 ms
[2020-06-06 22:04:51] [INFO ] Deduced a trap composed of 75 places in 200 ms
[2020-06-06 22:04:52] [INFO ] Deduced a trap composed of 76 places in 233 ms
[2020-06-06 22:04:52] [INFO ] Deduced a trap composed of 57 places in 232 ms
[2020-06-06 22:04:52] [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 (> (+ s0 s1 s2 s3 s4 s5 s6 s7 s8 s9 s10 s11 s12 s13 s14 s15 s16 s17 s18 s19 s20 s21 s22 s23 s24 s25 s26 s27 s29 s31 s32 s35 s36 s37 s206 s207 s208 s209 s210 s211 s212 s213 s214 s215 s216 s217 s218 s338 s394 s395 s396 s397 s398 s399 s400 s401 s402) 0)") while checking expression at index 0
[2020-06-06 22:04:52] [INFO ] [Real]Absence check using 33 positive place invariants in 39 ms returned sat
[2020-06-06 22:04:52] [INFO ] [Real]Absence check using 33 positive and 1 generalized place invariants in 2 ms returned sat
[2020-06-06 22:04:52] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-06 22:04:53] [INFO ] [Real]Absence check using state equation in 936 ms returned sat
[2020-06-06 22:04:53] [INFO ] Solution in real domain found non-integer solution.
[2020-06-06 22:04:53] [INFO ] [Nat]Absence check using 33 positive place invariants in 182 ms returned sat
[2020-06-06 22:04:53] [INFO ] [Nat]Absence check using 33 positive and 1 generalized place invariants in 3 ms returned sat
[2020-06-06 22:04:53] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-06 22:04:54] [INFO ] [Nat]Absence check using state equation in 933 ms returned sat
[2020-06-06 22:04:55] [INFO ] Deduced a trap composed of 54 places in 316 ms
[2020-06-06 22:04:55] [INFO ] Deduced a trap composed of 23 places in 340 ms
[2020-06-06 22:04:55] [INFO ] Deduced a trap composed of 39 places in 353 ms
[2020-06-06 22:04:56] [INFO ] Deduced a trap composed of 33 places in 197 ms
[2020-06-06 22:04:56] [INFO ] Deduced a trap composed of 32 places in 212 ms
[2020-06-06 22:04:56] [INFO ] Deduced a trap composed of 29 places in 261 ms
[2020-06-06 22:04:56] [INFO ] Deduced a trap composed of 29 places in 203 ms
[2020-06-06 22:04:57] [INFO ] Deduced a trap composed of 44 places in 200 ms
[2020-06-06 22:04:57] [INFO ] Deduced a trap composed of 28 places in 205 ms
[2020-06-06 22:04:57] [INFO ] Deduced a trap composed of 37 places in 128 ms
[2020-06-06 22:04:57] [INFO ] Deduced a trap composed of 47 places in 142 ms
[2020-06-06 22:04:57] [INFO ] Deduced a trap composed of 36 places in 140 ms
[2020-06-06 22:04:57] [INFO ] Deduced a trap composed of 42 places in 147 ms
[2020-06-06 22:04:58] [INFO ] Deduced a trap composed of 46 places in 192 ms
[2020-06-06 22:04:58] [INFO ] Deduced a trap composed of 51 places in 154 ms
[2020-06-06 22:04:58] [INFO ] Deduced a trap composed of 43 places in 137 ms
[2020-06-06 22:04:58] [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 (> (+ s0 s1 s2 s3 s4 s5 s6 s7 s8 s9 s10 s11 s12 s13 s14 s15 s16 s17 s18 s19 s20 s21 s22 s23 s24 s66 s67 s68 s69 s70 s71 s74 s75 s76 s411 s412 s413 s414 s415 s416 s417 s418 s419) 0)") while checking expression at index 1
Support contains 12 out of 482 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 482/482 places, 480/480 transitions.
Performed 182 Post agglomeration using F-continuation condition.Transition count delta: 182
Iterating post reduction 0 with 182 rules applied. Total rules applied 182 place count 482 transition count 298
Reduce places removed 182 places and 0 transitions.
Ensure Unique test removed 23 transitions
Reduce isomorphic transitions removed 23 transitions.
Performed 10 Post agglomeration using F-continuation condition.Transition count delta: 10
Iterating post reduction 1 with 215 rules applied. Total rules applied 397 place count 300 transition count 265
Reduce places removed 10 places and 0 transitions.
Iterating post reduction 2 with 10 rules applied. Total rules applied 407 place count 290 transition count 265
Performed 58 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 58 Pre rules applied. Total rules applied 407 place count 290 transition count 207
Deduced a syphon composed of 58 places in 4 ms
Reduce places removed 58 places and 0 transitions.
Iterating global reduction 3 with 116 rules applied. Total rules applied 523 place count 232 transition count 207
Symmetric choice reduction at 3 with 43 rule applications. Total rules 566 place count 232 transition count 207
Deduced a syphon composed of 43 places in 1 ms
Reduce places removed 43 places and 43 transitions.
Iterating global reduction 3 with 86 rules applied. Total rules applied 652 place count 189 transition count 164
Performed 14 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 14 Pre rules applied. Total rules applied 652 place count 189 transition count 150
Deduced a syphon composed of 14 places in 1 ms
Reduce places removed 14 places and 0 transitions.
Iterating global reduction 3 with 28 rules applied. Total rules applied 680 place count 175 transition count 150
Performed 45 Post agglomeration using F-continuation condition.Transition count delta: 45
Deduced a syphon composed of 45 places in 0 ms
Reduce places removed 45 places and 0 transitions.
Iterating global reduction 3 with 90 rules applied. Total rules applied 770 place count 130 transition count 105
Free-agglomeration rule applied 20 times.
Iterating global reduction 3 with 20 rules applied. Total rules applied 790 place count 130 transition count 85
Reduce places removed 20 places and 0 transitions.
Iterating post reduction 3 with 20 rules applied. Total rules applied 810 place count 110 transition count 85
Partial Post-agglomeration rule applied 2 times.
Drop transitions removed 2 transitions
Iterating global reduction 4 with 2 rules applied. Total rules applied 812 place count 110 transition count 85
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 4 with 1 rules applied. Total rules applied 813 place count 109 transition count 84
Reduce places removed 16 places and 0 transitions.
Performed 17 Post agglomeration using F-continuation condition.Transition count delta: 17
Iterating post reduction 4 with 33 rules applied. Total rules applied 846 place count 93 transition count 67
Reduce places removed 17 places and 0 transitions.
Iterating post reduction 5 with 17 rules applied. Total rules applied 863 place count 76 transition count 67
Performed 13 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 6 with 13 Pre rules applied. Total rules applied 863 place count 76 transition count 54
Deduced a syphon composed of 13 places in 0 ms
Reduce places removed 13 places and 0 transitions.
Iterating global reduction 6 with 26 rules applied. Total rules applied 889 place count 63 transition count 54
Applied a total of 889 rules in 158 ms. Remains 63 /482 variables (removed 419) and now considering 54/480 (removed 426) transitions.
Finished structural reductions, in 1 iterations. Remains : 63/482 places, 54/480 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 1788 ms. (steps per millisecond=559 ) properties seen :[1, 0]
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-12 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Finished Best-First random walk after 10287 steps, including 0 resets, run visited all 1 properties in 29 ms. (steps per millisecond=354 )
FORMULA AutoFlight-PT-05b-ReachabilityCardinality-15 TRUE 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="AutoFlight-PT-05b"
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 AutoFlight-PT-05b, 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 r166-smll-158987787700446"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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