Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2021-input.r303-tall-162124171000018.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/fkordon/mcc2021-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 gold2020
Input is CANConstruction-PT-040, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r303-tall-162124171000018
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 7.9M
-rw-r--r-- 1 mcc users 31K May 15 08:57 CTLCardinality.txt
-rw-r--r-- 1 mcc users 168K May 15 08:57 CTLCardinality.xml
-rw-r--r-- 1 mcc users 19K May 15 08:57 CTLFireability.txt
-rw-r--r-- 1 mcc users 101K May 15 08:57 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.6K May 12 07:56 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K May 12 07:56 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.7K May 12 07:56 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K May 12 07:56 LTLFireability.xml
-rw-r--r-- 1 mcc users 1 May 12 08:13 NewModel
-rw-r--r-- 1 mcc users 3.6K May 11 18:16 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 15K May 11 18:16 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.0K May 11 15:34 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 15K May 11 15:34 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K May 12 04:39 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K May 12 04:39 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 12 08:13 equiv_col
-rw-r--r-- 1 mcc users 4 May 12 08:13 instance
-rw-r--r-- 1 mcc users 6 May 12 08:13 iscolored
-rw-r--r-- 1 mcc users 7.5M May 12 08:13 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 CANConstruction-PT-040-00
FORMULA_NAME CANConstruction-PT-040-01
FORMULA_NAME CANConstruction-PT-040-02
FORMULA_NAME CANConstruction-PT-040-03
FORMULA_NAME CANConstruction-PT-040-04
FORMULA_NAME CANConstruction-PT-040-05
FORMULA_NAME CANConstruction-PT-040-06
FORMULA_NAME CANConstruction-PT-040-07
FORMULA_NAME CANConstruction-PT-040-08
FORMULA_NAME CANConstruction-PT-040-09
FORMULA_NAME CANConstruction-PT-040-10
FORMULA_NAME CANConstruction-PT-040-11
FORMULA_NAME CANConstruction-PT-040-12
FORMULA_NAME CANConstruction-PT-040-13
FORMULA_NAME CANConstruction-PT-040-14
FORMULA_NAME CANConstruction-PT-040-15

=== Now, execution of the tool begins

BK_START 1621324331924

[2021-05-18 07:52:13] [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, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -greatspnpath, /home/mcc/BenchKit//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2021-05-18 07:52:13] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-18 07:52:13] [INFO ] Load time of PNML (sax parser for PT used): 336 ms
[2021-05-18 07:52:13] [INFO ] Transformed 3682 places.
[2021-05-18 07:52:13] [INFO ] Transformed 6720 transitions.
[2021-05-18 07:52:13] [INFO ] Parsed PT model containing 3682 places and 6720 transitions in 403 ms.
Parsed 16 properties from file /home/mcc/execution/LTLFireability.xml in 58 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 100000 steps, including 143 resets, run finished after 954 ms. (steps per millisecond=104 ) 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, 0, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
// Phase 1: matrix 6720 rows 3682 cols
[2021-05-18 07:52:15] [INFO ] Computed 81 place invariants in 137 ms
[2021-05-18 07:52:15] [INFO ] [Real]Absence check using 41 positive place invariants in 169 ms returned sat
[2021-05-18 07:52:15] [INFO ] [Real]Absence check using 41 positive and 40 generalized place invariants in 79 ms returned sat
[2021-05-18 07:52:15] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-18 07:52:35] [INFO ] SMT solver returned unknown. Retrying;
[2021-05-18 07:52:35] [INFO ] [Real]Absence check using state equation in 19365 ms returned (error "Failed to check-sat")
[2021-05-18 07:52:35] [INFO ] Initial state reduction rules for CTL removed 2 formulas.
[2021-05-18 07:52:35] [INFO ] Flatten gal took : 360 ms
FORMULA CANConstruction-PT-040-09 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA CANConstruction-PT-040-08 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2021-05-18 07:52:35] [INFO ] Flatten gal took : 211 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
[2021-05-18 07:52:36] [INFO ] Applying decomposition
[2021-05-18 07:52:36] [INFO ] Input system was already deterministic with 6720 transitions.
[2021-05-18 07:52:36] [INFO ] Too many transitions (6720) to apply POR reductions. Disabling POR matrices.
[2021-05-18 07:52:36] [INFO ] Flatten gal took : 233 ms
[2021-05-18 07:52:36] [INFO ] Built C files in 770ms conformant to PINS in folder :/home/mcc/execution
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/convert-linux64, -i, /tmp/graph5651233776233411528.txt, -o, /tmp/graph5651233776233411528.bin, -w, /tmp/graph5651233776233411528.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/louvain-linux64, /tmp/graph5651233776233411528.bin, -l, -1, -v, -w, /tmp/graph5651233776233411528.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-18 07:52:37] [INFO ] Decomposing Gal with order
[2021-05-18 07:52:37] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-18 07:52:37] [INFO ] Removed a total of 2737 redundant transitions.
[2021-05-18 07:52:38] [INFO ] Flatten gal took : 608 ms
[2021-05-18 07:52:38] [INFO ] Fuse similar labels procedure discarded/fused a total of 17 labels/synchronizations in 121 ms.
[2021-05-18 07:52:38] [INFO ] Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 96 ms
[2021-05-18 07:52:38] [INFO ] Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 14 LTL properties
Checking formula 0 : !((X(((!(F("((i30.u192.Node0IsInserted>=1)&&(i34.u190.Node39requestsent0>=1))")))U("((i10.u71.Node14Request>=1)&&(i40.u139.Node29IsInserted>=1))"))&&((X("((i30.u192.Node0IsInserted>=1)&&(i34.u190.Node39requestsent0>=1))"))||(!(F(X(X("((i12.u197.Node4IsInserted>=1)&&(i24.u238.Node38requestsent4>=1))")))))))))
Formula 0 simplified : !X((!F"((i30.u192.Node0IsInserted>=1)&&(i34.u190.Node39requestsent0>=1))" U "((i10.u71.Node14Request>=1)&&(i40.u139.Node29IsInserted>=1))") & (X"((i30.u192.Node0IsInserted>=1)&&(i34.u190.Node39requestsent0>=1))" | !FXX"((i12.u197.Node4IsInserted>=1)&&(i24.u238.Node38requestsent4>=1))"))
built 854 ordering constraints for composite.
built 122 ordering constraints for composite.
built 130 ordering constraints for composite.
built 131 ordering constraints for composite.
built 131 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 131 ordering constraints for composite.
built 131 ordering constraints for composite.
built 131 ordering constraints for composite.
built 131 ordering constraints for composite.
built 122 ordering constraints for composite.
built 130 ordering constraints for composite.
built 125 ordering constraints for composite.
built 130 ordering constraints for composite.
built 129 ordering constraints for composite.
built 130 ordering constraints for composite.
built 128 ordering constraints for composite.
built 95 ordering constraints for composite.
built 36 ordering constraints for composite.
built 131 ordering constraints for composite.
built 130 ordering constraints for composite.
built 95 ordering constraints for composite.
built 131 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 131 ordering constraints for composite.
built 130 ordering constraints for composite.
built 95 ordering constraints for composite.
built 131 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 130 ordering constraints for composite.
built 131 ordering constraints for composite.
built 130 ordering constraints for composite.
built 97 ordering constraints for composite.
built 130 ordering constraints for composite.
built 131 ordering constraints for composite.
built 131 ordering constraints for composite.
built 131 ordering constraints for composite.
Compilation finished in 91391 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 96 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(( (!( <>((LTLAP0==true))) )U((LTLAP1==true)) ) && ( ( X((LTLAP0==true))) || ( !( <>(X(X((LTLAP2==true))))) ) )), --buchi-type=spotba], workingDir=/home/mcc/execution]
/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc: error while loading shared libraries: libltdl.so.7: cannot open shared object file: No such file or directory
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(( (!( <>((LTLAP0==true))) )U((LTLAP1==true)) ) && ( ( X((LTLAP0==true))) || ( !( <>(X(X((LTLAP2==true))))) ) )), --buchi-type=spotba], workingDir=/home/mcc/execution]
127
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(( (!( <>((LTLAP0==true))) )U((LTLAP1==true)) ) && ( ( X((LTLAP0==true))) || ( !( <>(X(X((LTLAP2==true))))) ) )), --buchi-type=spotba], workingDir=/home/mcc/execution]
127
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:170)
at fr.lip6.move.gal.application.LTSminRunner.access$10(LTSminRunner.java:124)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:93)
at java.base/java.lang.Thread.run(Thread.java:834)
Detected timeout of ITS tools.
[2021-05-18 08:12:49] [INFO ] Flatten gal took : 651 ms
[2021-05-18 08:12:49] [INFO ] Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 74 ms
[2021-05-18 08:12:49] [INFO ] Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 3 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock --gen-order FOLLOW
Read 14 LTL properties
Checking formula 0 : !((X(((!(F("((Node0IsInserted>=1)&&(Node39requestsent0>=1))")))U("((Node14Request>=1)&&(Node29IsInserted>=1))"))&&((X("((Node0IsInserted>=1)&&(Node39requestsent0>=1))"))||(!(F(X(X("((Node4IsInserted>=1)&&(Node38requestsent4>=1))")))))))))
Formula 0 simplified : !X((!F"((Node0IsInserted>=1)&&(Node39requestsent0>=1))" U "((Node14Request>=1)&&(Node29IsInserted>=1))") & (X"((Node0IsInserted>=1)&&(Node39requestsent0>=1))" | !FXX"((Node4IsInserted>=1)&&(Node38requestsent4>=1))"))
Detected timeout of ITS tools.
[2021-05-18 08:33:33] [INFO ] Flatten gal took : 644 ms
[2021-05-18 08:33:35] [INFO ] Input system was already deterministic with 6720 transitions.
[2021-05-18 08:33:35] [INFO ] Transformed 3682 places.
[2021-05-18 08:33:35] [INFO ] Transformed 6720 transitions.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
P-invariant computation with GreatSPN timed out. Skipping.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
[2021-05-18 08:34:11] [INFO ] Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 24 ms
[2021-05-18 08:34:11] [INFO ] Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock, --load-order, /home/mcc/execution/model.ord, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock --load-order /home/mcc/execution/model.ord --gen-order FOLLOW
Read 14 LTL properties
Successfully loaded order from file /home/mcc/execution/model.ord
Checking formula 0 : !((X(((!(F("((Node0IsInserted>=1)&&(Node39requestsent0>=1))")))U("((Node14Request>=1)&&(Node29IsInserted>=1))"))&&((X("((Node0IsInserted>=1)&&(Node39requestsent0>=1))"))||(!(F(X(X("((Node4IsInserted>=1)&&(Node38requestsent4>=1))")))))))))
Formula 0 simplified : !X((!F"((Node0IsInserted>=1)&&(Node39requestsent0>=1))" U "((Node14Request>=1)&&(Node29IsInserted>=1))") & (X"((Node0IsInserted>=1)&&(Node39requestsent0>=1))" | !FXX"((Node4IsInserted>=1)&&(Node38requestsent4>=1))"))

BK_TIME_CONFINEMENT_REACHED

--------------------
content from stderr:

+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ LTLFireability = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLFireability -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination LTLFireability -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -timeout 3600 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6

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="CANConstruction-PT-040"
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 CANConstruction-PT-040, 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 r303-tall-162124171000018"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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