Execution Chart

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

Trace from the execution

Formatting '/data/fko/mcc2020-input.r186-oct2-158987939100479.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2020-input.qcow2 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 SharedMemory-COL-000200, examination is ReachabilityFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r186-oct2-158987939100479
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 208K
-rw-r--r-- 1 mcc users 4.0K Apr 27 15:14 CTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Apr 27 15:14 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Apr 27 15:14 CTLFireability.txt
-rw-r--r-- 1 mcc users 17K 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.1K Apr 27 15:14 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.8K Apr 27 15:14 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Apr 28 15:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Apr 27 15:14 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 28 15:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.3K Apr 27 15:14 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 21K Apr 27 15:14 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.9K Apr 27 15:14 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 13K Apr 27 15:14 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Apr 27 15:14 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Apr 27 15:14 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Apr 27 15:14 equiv_pt
-rw-r--r-- 1 mcc users 7 Apr 27 15:14 instance
-rw-r--r-- 1 mcc users 5 Apr 27 15:14 iscolored
-rw-r--r-- 1 mcc users 20K 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 SharedMemory-COL-000200-ReachabilityFireability-00
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-01
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-02
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-03
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-04
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-05
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-06
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-07
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-08
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-09
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-10
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-11
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-12
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-13
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-14
FORMULA_NAME SharedMemory-COL-000200-ReachabilityFireability-15

=== Now, execution of the tool begins

BK_START 1591243819471

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 04:10:21] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2020-06-04 04:10:21] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 04:10:21] [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.
[2020-06-04 04:10:22] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 485 ms
[2020-06-04 04:10:22] [INFO ] sort/places :
P->ownMemAcc,queue,memory,active,
Dot->extBus,
PxP->extMemAcc,

[2020-06-04 04:10:22] [INFO ] Imported 6 HL places and 5 HL transitions for a total of 40801 PT places and 120400.0 transition bindings in 49 ms.
[2020-06-04 04:10:22] [INFO ] Computed order based on color domains.
[2020-06-04 04:10:23] [INFO ] Unfolded HLPN to a Petri net with 40801 places and 80400 transitions in 612 ms.
[2020-06-04 04:10:23] [INFO ] Unfolded HLPN properties in 39 ms.
Deduced a syphon composed of 200 places in 70 ms
Reduce places removed 200 places and 200 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityFireability.xml in 2789 ms.
Working with output stream class java.io.PrintStream
FORMULA SharedMemory-COL-000200-ReachabilityFireability-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA SharedMemory-COL-000200-ReachabilityFireability-11 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA SharedMemory-COL-000200-ReachabilityFireability-12 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Interrupted random walk after 5951 steps, including 0 resets, run timeout after 30019 ms. (steps per millisecond=0 ) properties seen :[0, 1, 1, 1, 1, 1, 1, 1, 1, 1, 0, 1, 0]
FORMULA SharedMemory-COL-000200-ReachabilityFireability-14 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-10 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-09 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-08 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-06 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-05 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-04 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA SharedMemory-COL-000200-ReachabilityFireability-01 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Interrupted Best-First random walk after 7925 steps, including 0 resets, run timeout after 5665 ms. (steps per millisecond=1 ) properties seen :[0, 0, 0]
Interrupted Best-First random walk after 801 steps, including 0 resets, run timeout after 7165 ms. (steps per millisecond=0 ) properties seen :[0, 0, 0]
Interrupted Best-First random walk after 999 steps, including 0 resets, run timeout after 6970 ms. (steps per millisecond=0 ) properties seen :[0, 0, 0]
// Phase 1: matrix 80200 rows 40601 cols
[2020-06-04 04:11:55] [INFO ] Computed 401 place invariants in 40227 ms
[2020-06-04 04:12:00] [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 (= 1 (+ s469 s868 s1067 s1266 s1465 s1664 s1863 s2062 s2261 s2460 s2659 s2858 s3057 s3256 s3455 s3654 s3853 s4052 s4251 s4450 s4649 s4848 s5047 s5246 s5445 s5644 s5843 s6042 s6241 s6440 s6639 s6838 s7037 s7236 s7435 s7634 s7833 s8032 s8231 s8430 s8629 s8828 s9027 s9226 s9425 s9624 s9823 s10022 s10221 s10420 s10619 s10818 s11017 s11216 s11415 s11614 s11813 s12012 s12211 s12410 s12609 s12808 s13007 s13206 s13405 s13604 s13803 s14002 s14201 s14400 s14799 s14998 s15197 s15396 s15595 s15794 s15993 s16192 s16391 s16590 s16789 s16988 s17187 s17386 s17585 s17784 s17983 s18182 s18381 s18580 s18779 s18978 s19177 s19376 s19575 s19774 s19973 s20172 s20371 s20570 s20769 s20968 s21167 s21366 s21565 s21764 s21963 s22162 s22361 s22560 s22759 s22958 s23157 s23356 s23555 s23754 s23953 s24152 s24351 s24550 s24749 s24948 s25147 s25346 s25545 s25744 s25943 s26142 s26341 s26540 s26739 s26938 s27137 s27336 s27535 s27734 s27933 s28132 s28331 s28530 s28729 s28928 s29127 s29326 s29525 s29724 s29923 s30122 s30321 s30520 s30719 s30918 s31117 s31316 s31515 s31714 s31913 s32112 s32311 s32510 s32709 s32908 s33107 s33306 s33505 s33704 s33903 s34102 s34301 s34500 s34699 s34898 s35097 s35296 s35495 s35694 s35893 s36092 s36291 s36490 s36689 s36888 s37087 s37286 s37485 s37684 s37883 s38082 s38281 s38480 s38679 s38878 s39077 s39276 s39475 s39674 s39873 s40072 s40271 s40470))") while checking expression at index 0
[2020-06-04 04:12:05] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:12:05] [INFO ] [Real]Absence check using 401 positive place invariants in 726 ms returned (error "Failed to check-sat")
[2020-06-04 04:12:05] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 04:12:06] [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
[2020-06-04 04:12:11] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:12:11] [INFO ] [Real]Absence check using 401 positive place invariants in 2081 ms returned (error "Failed to check-sat")
[2020-06-04 04:12:11] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 04:12:11] [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 2
Support contains 40601 out of 40601 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 40601/40601 places, 80200/80200 transitions.
Applied a total of 0 rules in 1227 ms. Remains 40601 /40601 variables (removed 0) and now considering 80200/80200 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 40601/40601 places, 80200/80200 transitions.
Interrupted random walk after 4235 steps, including 0 resets, run timeout after 30031 ms. (steps per millisecond=0 ) properties seen :[0, 0, 0]
Interrupted Best-First random walk after 7936 steps, including 0 resets, run timeout after 5723 ms. (steps per millisecond=1 ) properties seen :[0, 0, 0]
Interrupted Best-First random walk after 401 steps, including 0 resets, run timeout after 5108 ms. (steps per millisecond=0 ) properties seen :[0, 0, 0]
Interrupted Best-First random walk after 999 steps, including 0 resets, run timeout after 13667 ms. (steps per millisecond=0 ) properties seen :[0, 0, 0]
Probabilistic random walk after 50202 steps, saw 79 distinct states, run finished after 30185 ms. (steps per millisecond=1 ) properties seen :[0, 0, 0]
// Phase 1: matrix 80200 rows 40601 cols
[2020-06-04 04:14:20] [INFO ] Computed 401 place invariants in 41845 ms
[2020-06-04 04:14:37] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:14:42] [INFO ] [Real]Absence check using 401 positive place invariants in 17972 ms returned unknown
[2020-06-04 04:15:02] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:15:09] [INFO ] [Real]Absence check using 401 positive place invariants in 20817 ms returned unknown
[2020-06-04 04:15:19] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:15:23] [INFO ] [Real]Absence check using 401 positive place invariants in 10491 ms returned unknown
Support contains 40601 out of 40601 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 40601/40601 places, 80200/80200 transitions.
Applied a total of 0 rules in 1024 ms. Remains 40601 /40601 variables (removed 0) and now considering 80200/80200 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 40601/40601 places, 80200/80200 transitions.
Starting structural reductions, iteration 0 : 40601/40601 places, 80200/80200 transitions.
Applied a total of 0 rules in 810 ms. Remains 40601 /40601 variables (removed 0) and now considering 80200/80200 (removed 0) transitions.
// Phase 1: matrix 80200 rows 40601 cols
[2020-06-04 04:16:04] [INFO ] Computed 401 place invariants in 39236 ms
[2020-06-04 04:16:07] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:16:07] [INFO ] Implicit Places using invariants in 42137 ms returned []
Implicit Place search using SMT only with invariants took 42169 ms to find 0 implicit places.
// Phase 1: matrix 80200 rows 40601 cols
[2020-06-04 04:16:44] [INFO ] Computed 401 place invariants in 37465 ms
[2020-06-04 04:16:47] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:17:17] [INFO ] Performed 374/80200 'is it Dead' test of which 0 returned DEAD in 30 seconds.
[2020-06-04 04:17:44] [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 (>= s1598 1)") after 97512 ms
Finished structural reductions, in 1 iterations. Remains : 40601/40601 places, 80200/80200 transitions.
Interrupted random walk after 5727 steps, including 0 resets, run timeout after 30019 ms. (steps per millisecond=0 ) properties seen :[0, 0, 0]
// Phase 1: matrix 80200 rows 40601 cols
[2020-06-04 04:18:55] [INFO ] Computed 401 place invariants in 38982 ms
[2020-06-04 04:19:09] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:19:15] [INFO ] [Real]Absence check using 401 positive place invariants in 17109 ms returned unknown
[2020-06-04 04:19:35] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:19:35] [INFO ] [Real]Absence check using 401 positive place invariants in 13830 ms returned (error "Failed to check-sat")
[2020-06-04 04:19:35] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 04:19:35] [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
[2020-06-04 04:19:45] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:19:48] [INFO ] [Real]Absence check using 401 positive place invariants in 10118 ms returned unknown
Applied a total of 0 rules in 785 ms. Remains 40601 /40601 variables (removed 0) and now considering 80200/80200 (removed 0) transitions.
// Phase 1: matrix 80200 rows 40601 cols
[2020-06-04 04:20:29] [INFO ] Computed 401 place invariants in 39100 ms
[2020-06-04 04:20:47] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:20:53] [INFO ] [Real]Absence check using 401 positive place invariants in 18139 ms returned unknown
[2020-06-04 04:21:13] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:21:20] [INFO ] [Real]Absence check using 401 positive place invariants in 21241 ms returned unknown
[2020-06-04 04:21:30] [INFO ] SMT solver returned unknown. Retrying;
[2020-06-04 04:21:33] [INFO ] [Real]Absence check using 401 positive place invariants in 10421 ms returned unknown
[2020-06-04 04:21:34] [INFO ] Export to MCC properties in file /home/mcc/execution/ReachabilityFireability.sr.xml took 284 ms.
[2020-06-04 04:21:34] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 313 ms.
[2020-06-04 04:21:39] [INFO ] Flatten gal took : 3442 ms
info: Time: 3600 - MCC
vrfy: Checking ReachabilityFireability @ SharedMemory-COL-000200 @ 3570 seconds
vrfy: finished
info: timeLeft: 3520
rslt: Output for ReachabilityFireability @ SharedMemory-COL-000200
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: 120801/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 40601
lola: finding significant places
lola: 40601 places, 80200 transitions, 40200 significant places
lola: compute conflict clusters
lola: computed conflict clusters
lola: Computing conflicting sets
Killed
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="SharedMemory-COL-000200"
export BK_EXAMINATION="ReachabilityFireability"
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 SharedMemory-COL-000200, examination is ReachabilityFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r186-oct2-158987939100479"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/SharedMemory-COL-000200.tgz
mv SharedMemory-COL-000200 execution
cd execution
if [ "ReachabilityFireability" = "ReachabilityDeadlock" ] || [ "ReachabilityFireability" = "UpperBounds" ] || [ "ReachabilityFireability" = "QuasiLiveness" ] || [ "ReachabilityFireability" = "StableMarking" ] || [ "ReachabilityFireability" = "Liveness" ] || [ "ReachabilityFireability" = "OneSafe" ] || [ "ReachabilityFireability" = "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 [ "ReachabilityFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityFireability" != "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 "ReachabilityFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityFireability.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 '' ReachabilityFireability.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "ReachabilityFireability" = "ReachabilityDeadlock" ] || [ "ReachabilityFireability" = "QuasiLiveness" ] || [ "ReachabilityFireability" = "StableMarking" ] || [ "ReachabilityFireability" = "Liveness" ] || [ "ReachabilityFireability" = "OneSafe" ] ; then
echo "FORMULA_NAME ReachabilityFireability"
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 ;