Execution Chart

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

Trace from the execution

Formatting '/data/fko/mcc2021-input.r170-oct2-162089287200142.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2021-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 gold2020
Input is PolyORBLF-PT-S04J04T10, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r170-oct2-162089287200142
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 8.9M
-rw-r--r-- 1 mcc users 87K May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 360K May 10 09:43 CTLCardinality.xml
-rw-r--r-- 1 mcc users 364K May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 1.7M 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 6.3K May 6 14:48 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 13K Mar 28 16:27 LTLCardinality.txt
-rw-r--r-- 1 mcc users 46K Mar 28 16:27 LTLCardinality.xml
-rw-r--r-- 1 mcc users 33K Mar 28 16:27 LTLFireability.txt
-rw-r--r-- 1 mcc users 127K Mar 28 16:27 LTLFireability.xml
-rw-r--r-- 1 mcc users 14K Mar 27 09:22 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 43K Mar 27 09:22 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 58K Mar 25 11:58 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 173K Mar 25 11:58 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 6.4K Mar 22 09:16 UpperBounds.txt
-rw-r--r-- 1 mcc users 12K Mar 22 09:16 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_col
-rw-r--r-- 1 mcc users 10 May 5 16:51 instance
-rw-r--r-- 1 mcc users 6 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 6.0M 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 PolyORBLF-PT-S04J04T10-00
FORMULA_NAME PolyORBLF-PT-S04J04T10-01
FORMULA_NAME PolyORBLF-PT-S04J04T10-02
FORMULA_NAME PolyORBLF-PT-S04J04T10-03
FORMULA_NAME PolyORBLF-PT-S04J04T10-04
FORMULA_NAME PolyORBLF-PT-S04J04T10-05
FORMULA_NAME PolyORBLF-PT-S04J04T10-06
FORMULA_NAME PolyORBLF-PT-S04J04T10-07
FORMULA_NAME PolyORBLF-PT-S04J04T10-08
FORMULA_NAME PolyORBLF-PT-S04J04T10-09
FORMULA_NAME PolyORBLF-PT-S04J04T10-10
FORMULA_NAME PolyORBLF-PT-S04J04T10-11
FORMULA_NAME PolyORBLF-PT-S04J04T10-12
FORMULA_NAME PolyORBLF-PT-S04J04T10-13
FORMULA_NAME PolyORBLF-PT-S04J04T10-14
FORMULA_NAME PolyORBLF-PT-S04J04T10-15

=== Now, execution of the tool begins

BK_START 1621382157420

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2021-05-18 23:55:59] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2021-05-18 23:56:00] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-18 23:56:00] [INFO ] Load time of PNML (sax parser for PT used): 593 ms
[2021-05-18 23:56:00] [INFO ] Transformed 870 places.
[2021-05-18 23:56:00] [INFO ] Transformed 5034 transitions.
[2021-05-18 23:56:00] [INFO ] Parsed PT model containing 870 places and 5034 transitions in 758 ms.
[2021-05-18 23:56:00] [INFO ] Reduced 440 identical enabling conditions.
[2021-05-18 23:56:00] [INFO ] Reduced 440 identical enabling conditions.
Ensure Unique test removed 2710 transitions
Reduce redundant transitions removed 2710 transitions.
Parsed 16 properties from file /home/mcc/execution/LTLFireability.xml in 276 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 100000 steps, including 3 resets, run finished after 985 ms. (steps per millisecond=101 ) properties seen :[1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 0, 1, 1, 1, 1, 1, 0, 1, 1, 0, 1, 1, 0, 1, 1, 1, 1, 1, 1, 1, 0, 0, 1]
[2021-05-18 23:56:02] [INFO ] Flow matrix only has 2284 transitions (discarded 40 similar events)
// Phase 1: matrix 2284 rows 870 cols
[2021-05-18 23:56:02] [INFO ] Computed 58 place invariants in 259 ms
[2021-05-18 23:56:03] [INFO ] [Real]Absence check using 16 positive place invariants in 148 ms returned sat
[2021-05-18 23:56:03] [INFO ] [Real]Absence check using 16 positive and 42 generalized place invariants in 134 ms returned sat
[2021-05-18 23:56:03] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-18 23:56:14] [INFO ] [Real]Absence check using state equation in 11115 ms returned sat
[2021-05-18 23:56:14] [INFO ] Solution in real domain found non-integer solution.
[2021-05-18 23:56:14] [INFO ] [Nat]Absence check using 16 positive place invariants in 53 ms returned sat
[2021-05-18 23:56:14] [INFO ] [Nat]Absence check using 16 positive and 42 generalized place invariants in 80 ms returned sat
[2021-05-18 23:56:14] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-18 23:56:31] [INFO ] SMT solver returned unknown. Retrying;
[2021-05-18 23:56:34] [INFO ] [Nat]Absence check using state equation in 19594 ms returned unknown
[2021-05-18 23:56:34] [INFO ] [Real]Absence check using 16 positive place invariants in 106 ms returned sat
[2021-05-18 23:56:34] [INFO ] [Real]Absence check using 16 positive and 42 generalized place invariants in 63 ms returned unsat
[2021-05-18 23:56:35] [INFO ] [Real]Absence check using 16 positive place invariants in 93 ms returned sat
[2021-05-18 23:56:35] [INFO ] [Real]Absence check using 16 positive and 42 generalized place invariants in 48 ms returned sat
[2021-05-18 23:56:35] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-18 23:56:44] [INFO ] [Real]Absence check using state equation in 9595 ms returned sat
[2021-05-18 23:56:44] [INFO ] Solution in real domain found non-integer solution.
[2021-05-18 23:56:44] [INFO ] [Nat]Absence check using 16 positive place invariants in 34 ms returned sat
[2021-05-18 23:56:45] [INFO ] [Nat]Absence check using 16 positive and 42 generalized place invariants in 102 ms returned sat
[2021-05-18 23:56:45] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-18 23:56:58] [INFO ] [Nat]Absence check using state equation in 13324 ms returned sat
[2021-05-18 23:56:58] [INFO ] State equation strengthened by 210 read => feed constraints.
[2021-05-18 23:57:01] [INFO ] [Nat]Added 210 Read/Feed constraints in 2688 ms returned sat
[2021-05-18 23:57:02] [INFO ] Deduced a trap composed of 75 places in 1092 ms
[2021-05-18 23:57:05] [INFO ] Deduced a trap composed of 75 places in 1352 ms
[2021-05-18 23:57:05] [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 (> (+ s3 s12 s29 s34 s46 s53 s57 s67 s69 s79 s100 s104 s106 s107 s133 s135 s156 s159 s180 s186 s219 s223 s229 s241 s256 s258 s267 s272 s276 s285 s296 s310 s329 s341 s344 s379 s382 s384 s420 s462 s463 s470 s485 s487 s507 s514 s516 s532 s546 s548 s554 s555 s556 s604 s617 s630 s634 s642 s656 s685 s688 s689 s711 s727 s736 s754 s761 s770 s789 s795 s819 s838 s855 s863 s867) 0)") while checking expression at index 2
[2021-05-18 23:57:05] [INFO ] [Real]Absence check using 16 positive place invariants in 67 ms returned sat
[2021-05-18 23:57:06] [INFO ] [Real]Absence check using 16 positive and 42 generalized place invariants in 40 ms returned unsat
[2021-05-18 23:57:06] [INFO ] [Real]Absence check using 16 positive place invariants in 66 ms returned unsat
[2021-05-18 23:57:06] [INFO ] [Real]Absence check using 16 positive place invariants in 66 ms returned sat
[2021-05-18 23:57:06] [INFO ] [Real]Absence check using 16 positive and 42 generalized place invariants in 75 ms returned unsat
Successfully simplified 4 atomic propositions for a total of 4 simplifications.
[2021-05-18 23:57:07] [INFO ] Initial state reduction rules for CTL removed 4 formulas.
[2021-05-18 23:57:07] [INFO ] Flatten gal took : 577 ms
FORMULA PolyORBLF-PT-S04J04T10-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-PT-S04J04T10-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-PT-S04J04T10-08 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-PT-S04J04T10-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2021-05-18 23:57:07] [INFO ] Flatten gal took : 270 ms
[2021-05-18 23:57:08] [INFO ] Export to MCC properties in file /home/mcc/execution/LTLFireability.sr.xml took 50 ms.
[2021-05-18 23:57:08] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 20 ms.
info: Time: 3600 - MCC
vrfy: Checking LTLFireability @ PolyORBLF-PT-S04J04T10 @ 3570 seconds
check_solution: Variable C1015 = -2 is below its lower bound 0
check_solution: Variable C1277 = -0.714285714286 is below its lower bound 0
check_solution: Variable C1401 = -0.5 is below its lower bound 0
check_solution: Variable C1485 = -14.3333333333 is below its lower bound 0
check_solution: Constraint R5 = 0 is above its equality of -1
check_solution: Constraint R30 = 2.12199579146e-314 is above its equality of -1
check_solution: Constraint R56 = 2.12199579146e-314 is above its equality of -1
check_solution: Constraint R61 = 0 is above its equality of -1
check_solution: Constraint R63 = 0 is above its equality of -1
check_solution: Constraint R78 = 2.12199579146e-314 is above its equality of -1

Seriously low accuracy found ||*|| = 14.3333 (rel. error 14.3333)
check_solution: Variable C441 = -0.112439632416 is below its lower bound 0
check_solution: Variable C442 = -0.0663213497161 is below its lower bound 0
check_solution: Variable C1755 = -0.070465028286 is below its lower bound 0
check_solution: Variable C2193 = -0.144095420837 is below its lower bound 0
check_solution: Variable C2194 = -0.174497447716 is below its lower bound 0
check_solution: Variable C2631 = -0.176730394363 is below its lower bound 0
check_solution: Variable C2632 = -0.255769523211 is below its lower bound 0
check_solution: Variable C3069 = -0.234103083611 is below its lower bound 0
check_solution: Variable C3070 = -0.2573699498 is below its lower bound 0
check_solution: Constraint R5 = 6.86041239402e-311 is above its equality of -1

Seriously low accuracy found ||*|| = 10 (rel. error 12.9063)
check_solution: Variable C342 = -0.129850535771 is below its lower bound 0
check_solution: Variable C779 = -0.0691139698029 is below its lower bound 0
check_solution: Variable C780 = -0.0411967652948 is below its lower bound 0
check_solution: Variable C1217 = -1.09163856506 is below its lower bound 0
check_solution: Variable C1218 = -1.06801712543 is below its lower bound 0
check_solution: Variable C1655 = -0.196171522141 is below its lower bound 0
check_solution: Variable C1656 = -0.105244206893 is below its lower bound 0
check_solution: Variable C2093 = -0.814167022705 is below its lower bound 0
check_solution: Variable C2969 = -0.526176452637 is below its lower bound 0
check_solution: Variable C2970 = -0.78733519474 is below its lower bound 0

Seriously low accuracy found ||*|| = 10 (rel. error 9.50171)
check_solution: Variable C736 = -0.613648522051 is below its lower bound 0
check_solution: Variable C1173 = -0.358065366745 is below its lower bound 0
check_solution: Variable C1174 = -0.258362905758 is below its lower bound 0
check_solution: Variable C1612 = -1.39024841408 is below its lower bound 0
check_solution: Variable C2049 = -1.05443286896 is below its lower bound 0
check_solution: Variable C2050 = -1.88880158571 is below its lower bound 0
check_solution: Variable C2925 = -0.488926649094 is below its lower bound 0
check_solution: Constraint R5 = 4.11667183552e-312 is above its equality of -1
check_solution: Constraint R30 = 2.04772593876e-311 is above its equality of -1
check_solution: Constraint R56 = 1.97770007761e-311 is above its equality of -1

Seriously low accuracy found ||*|| = 10 (rel. error 2.79279)
check_solution: Variable C214 = -0.0768036799407 is below its lower bound 0
check_solution: Variable C652 = -1.10248727181 is below its lower bound 0
check_solution: Variable C1090 = -0.172629611437 is below its lower bound 0
check_solution: Variable C1527 = -0.0428522825241 is below its lower bound 0
check_solution: Variable C1528 = -0.311650087438 is below its lower bound 0
check_solution: Variable C1965 = -0.699595451355 is below its lower bound 0
check_solution: Variable C1966 = -1.55871129035 is below its lower bound 0
check_solution: Variable C2403 = -0.225534915924 is below its lower bound 0
check_solution: Variable C2404 = -0.29778507285 is below its lower bound 0
check_solution: Variable C2841 = -1.29055213928 is below its lower bound 0

Seriously low accuracy found ||*|| = 10 (rel. error 23.336)
check_solution: Variable C1 = -2 is below its lower bound 0
check_solution: Variable C2 = -1 is below its lower bound 0
check_solution: Variable C3 = -1 is below its lower bound 0
check_solution: Variable C4 = -2 is below its lower bound 0
check_solution: Variable C5 = -1 is below its lower bound 0
check_solution: Variable C6 = -2 is below its lower bound 0
check_solution: Variable C7 = -1 is below its lower bound 0
check_solution: Variable C8 = -2 is below its lower bound 0
check_solution: Variable C9 = -1 is below its lower bound 0
check_solution: Variable C10 = -1 is below its lower bound 0

Seriously low accuracy found ||*|| = 11 (rel. error 4)
check_solution: Variable C862 = -0.954400968683 is below its lower bound 0
check_solution: Variable C1299 = -1.16772270203 is below its lower bound 0
check_solution: Variable C1300 = -0.733304285123 is below its lower bound 0
check_solution: Variable C1737 = -0.763683319092 is below its lower bound 0
check_solution: Variable C1738 = -0.0311082631193 is below its lower bound 0
check_solution: Variable C2175 = -0.364126682282 is below its lower bound 0
check_solution: Variable C2176 = -0.761873081597 is below its lower bound 0
check_solution: Variable C2613 = -1.50961017609 is below its lower bound 0
check_solution: Variable C2614 = -0.748305847138 is below its lower bound 0
check_solution: Constraint R5 = 6.91558428412e-311 is above its equality of -1

Seriously low accuracy found ||*|| = 10 (rel. error 4.50303)
check_solution: Constraint R5 = 5.02913002555e-312 is above its equality of -1
check_solution: Constraint R30 = 1.88645425863e-311 is above its equality of -1
check_solution: Constraint R56 = 1.88221026702e-311 is above its equality of -1
check_solution: Constraint R61 = 1.95223612815e-311 is above its equality of -1
check_solution: Constraint R63 = 1.87584427966e-311 is above its equality of -1
check_solution: Constraint R78 = 1.97133409027e-311 is above its equality of -1
check_solution: Constraint R80 = 2.08167787138e-311 is above its equality of -1
check_solution: Constraint R83 = 1.89918623337e-311 is above its equality of -1
check_solution: Constraint R85 = 2.08167787139e-311 is above its equality of -1
check_solution: Constraint R138 = 1.89918623337e-311 is above its equality of -1

TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16427332 kB
MemFree: 10684112 kB
After kill :
MemTotal: 16427332 kB
MemFree: 16129260 kB

--------------------
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="PolyORBLF-PT-S04J04T10"
export BK_EXAMINATION="LTLFireability"
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 PolyORBLF-PT-S04J04T10, examination is LTLFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r170-oct2-162089287200142"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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