About the Execution of ITS-Tools for PolyORBNT-COL-S05J80
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
5136.632 | 95266.00 | 137567.00 | 65.40 | F | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/mnt/tpsp/fkordon/mcc2024-input.r299-tajo-171654455900249.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/fkordon/mcc2024-input.qcow2' backing_fmt='qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
........................
=====================================================================
Generated by BenchKit 2-5568
Executing tool itstools
Input is PolyORBNT-COL-S05J80, examination is Liveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r299-tajo-171654455900249
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 556K
-rw-r--r-- 1 mcc users 7.1K Apr 12 09:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 67K Apr 12 09:58 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.2K Apr 12 09:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 54K Apr 12 09:54 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 18 16:43 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 4.6K Apr 23 07:44 LTLCardinality.txt
-rw-r--r-- 1 mcc users 28K Apr 23 07:44 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.8K Apr 23 07:44 LTLFireability.txt
-rw-r--r-- 1 mcc users 19K Apr 23 07:44 LTLFireability.xml
-rw-r--r-- 1 mcc users 13K Apr 12 10:18 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 119K Apr 12 10:18 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 11K Apr 12 10:13 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 82K Apr 12 10:13 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Apr 23 07:44 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Apr 23 07:44 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 18 16:43 equiv_pt
-rw-r--r-- 1 mcc users 7 May 18 16:43 instance
-rw-r--r-- 1 mcc users 5 May 18 16:43 iscolored
-rw-r--r-- 1 mcc users 94K May 18 16:43 model.pnml
--------------------
content from stdout:
=== Data for post analysis generated by BenchKit (invocation template)
The expected result is a vector of booleans
BOOL_VECTOR
FORMULA_NAME Liveness
=== Now, execution of the tool begins
BK_START 1717142047285
Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=Liveness
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=PolyORBNT-COL-S05J80
BK_MEMORY_CONFINEMENT=16384
Not applying reductions.
Model is COL
Liveness COL
Running Version 202405141337
[2024-05-31 07:54:08] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, Liveness, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2024-05-31 07:54:08] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2024-05-31 07:54:08] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
log4j:WARN No appenders could be found for logger (org.apache.axiom.locator.DefaultOMMetaFactoryLocator).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
[2024-05-31 07:54:09] [WARNING] Using fallBack plugin, rng conformance not checked
[2024-05-31 07:54:09] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 608 ms
[2024-05-31 07:54:09] [INFO ] Imported 48 HL places and 38 HL transitions for a total of 1269 PT places and 2592.0 transition bindings in 22 ms.
[2024-05-31 07:54:09] [INFO ] Built PT skeleton of HLPN with 48 places and 38 transitions 140 arcs in 4 ms.
[2024-05-31 07:54:09] [INFO ] Skeletonized 0 HLPN properties in 0 ms.
[2024-05-31 07:54:09] [INFO ] Unfolded HLPN to a Petri net with 1269 places and 2430 transitions 14624 arcs in 63 ms.
[2024-05-31 07:54:09] [INFO ] Unfolded 0 HLPN properties in 0 ms.
[2024-05-31 07:54:09] [INFO ] Unfolded HLPN to a Petri net with 1269 places and 2430 transitions 14624 arcs in 26 ms.
[2024-05-31 07:54:09] [INFO ] Unfolded 38 HLPN properties in 1 ms.
[2024-05-31 07:54:09] [INFO ] Reduced 555 identical enabling conditions.
[2024-05-31 07:54:09] [INFO ] Reduced 90 identical enabling conditions.
[2024-05-31 07:54:09] [INFO ] Reduced 10 identical enabling conditions.
[2024-05-31 07:54:09] [INFO ] Built PT skeleton of HLPN with 48 places and 38 transitions 140 arcs in 1 ms.
[2024-05-31 07:54:09] [INFO ] Skeletonized 38 HLPN properties in 2 ms.
Computed a total of 0 stabilizing places and 0 stable transitions
Prefix of Interest using HLPN skeleton for deadlock discarded 0 places and 0 transitions.
Transition Run forces synchronizations/join behavior on parameter j of sort Jobs
Transition trans_376 forces synchronizations/join behavior on parameter s of sort Sources
Symmetric sort wr.t. initial and guards and successors and join/free detected :States
Arc [42:1*[$t, 0, $j]] contains constants of sort States
Transition WillPerformWork : constants on arcs in [[42:1*[$t, 0, $j]]] introduces in States(2) partition with 1 elements that refines current partition to 2 subsets.
[2024-05-31 07:54:09] [INFO ] Unfolded HLPN to a Petri net with 1269 places and 2430 transitions 14624 arcs in 38 ms.
[2024-05-31 07:54:09] [INFO ] Unfolded 38 HLPN properties in 2 ms.
[2024-05-31 07:54:09] [INFO ] Reduced 555 identical enabling conditions.
[2024-05-31 07:54:09] [INFO ] Reduced 90 identical enabling conditions.
[2024-05-31 07:54:09] [INFO ] Reduced 10 identical enabling conditions.
Deduced a syphon composed of 80 places in 11 ms
Reduce places removed 80 places and 80 transitions.
Ensure Unique test removed 655 transitions
Reduce redundant transitions removed 655 transitions.
Built sparse matrix representations for Structural reductions in 5 ms.31762KB memory used
Starting structural reductions in DEADLOCK mode, iteration 0 : 1189/1189 places, 1695/1695 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 0 rules in 106 ms. Remains 1189 /1189 variables (removed 0) and now considering 1695/1695 (removed 0) transitions.
Running 1689 sub problems to find dead transitions.
[2024-05-31 07:54:09] [INFO ] Flow matrix only has 1691 transitions (discarded 4 similar events)
// Phase 1: matrix 1691 rows 1189 cols
[2024-05-31 07:54:10] [INFO ] Computed 182 invariants in 141 ms
[2024-05-31 07:54:10] [INFO ] State equation strengthened by 1 read => feed constraints.
At refinement iteration 0 (INCLUDED_ONLY) 0/1178 variables, 166/166 constraints. Problems are: Problem set: 0 solved, 1689 unsolved
SMT process timed out in 25513ms, After SMT, problems are : Problem set: 0 solved, 1689 unsolved
Search for dead transitions found 0 dead transitions in 25569ms
Finished structural reductions in DEADLOCK mode , in 1 iterations and 25719 ms. Remains : 1189/1189 places, 1695/1695 transitions.
Starting structural reductions in DEADLOCK mode, iteration 0 : 1189/1189 places, 1695/1695 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 0 rules in 45 ms. Remains 1189 /1189 variables (removed 0) and now considering 1695/1695 (removed 0) transitions.
[2024-05-31 07:54:35] [INFO ] Flow matrix only has 1691 transitions (discarded 4 similar events)
[2024-05-31 07:54:35] [INFO ] Invariant cache hit.
[2024-05-31 07:54:35] [INFO ] Implicit Places using invariants in 190 ms returned []
[2024-05-31 07:54:35] [INFO ] Flow matrix only has 1691 transitions (discarded 4 similar events)
[2024-05-31 07:54:35] [INFO ] Invariant cache hit.
[2024-05-31 07:54:37] [INFO ] State equation strengthened by 1 read => feed constraints.
[2024-05-31 07:54:37] [INFO ] Implicit Places using invariants and state equation in 1459 ms returned []
Implicit Place search using SMT with State Equation took 1657 ms to find 0 implicit places.
[2024-05-31 07:54:37] [INFO ] Redundant transitions in 96 ms returned []
Running 1689 sub problems to find dead transitions.
[2024-05-31 07:54:37] [INFO ] Flow matrix only has 1691 transitions (discarded 4 similar events)
[2024-05-31 07:54:37] [INFO ] Invariant cache hit.
[2024-05-31 07:54:37] [INFO ] State equation strengthened by 1 read => feed constraints.
At refinement iteration 0 (INCLUDED_ONLY) 0/1178 variables, 166/166 constraints. Problems are: Problem set: 0 solved, 1689 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/1178 variables, 5/171 constraints. Problems are: Problem set: 0 solved, 1689 unsolved
Solver is answering 'unknown', stopping.
After SMT solving in domain Real declared 1178/2880 variables, and 171 constraints, problems are : Problem set: 0 solved, 1689 unsolved in 30056 ms.
Refiners :[Positive P Invariants (semi-flows): 166/175 constraints, Generalized P Invariants (flows): 5/7 constraints, State Equation: 0/1189 constraints, ReadFeed: 0/1 constraints, PredecessorRefiner: 1689/1689 constraints, Known Traps: 0/0 constraints]
Escalating to Integer solving :Problem set: 0 solved, 1689 unsolved
At refinement iteration 0 (INCLUDED_ONLY) 0/1178 variables, 166/166 constraints. Problems are: Problem set: 0 solved, 1689 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/1178 variables, 5/171 constraints. Problems are: Problem set: 0 solved, 1689 unsolved
[2024-05-31 07:55:30] [INFO ] Deduced a trap composed of 12 places in 439 ms of which 39 ms to minimize.
[2024-05-31 07:55:31] [INFO ] Deduced a trap composed of 15 places in 1249 ms of which 13 ms to minimize.
Solver is answering 'unknown', stopping.
After SMT solving in domain Int declared 1178/2880 variables, and 173 constraints, problems are : Problem set: 0 solved, 1689 unsolved in 30039 ms.
Refiners :[Positive P Invariants (semi-flows): 166/175 constraints, Generalized P Invariants (flows): 5/7 constraints, State Equation: 0/1189 constraints, ReadFeed: 0/1 constraints, PredecessorRefiner: 0/1689 constraints, Known Traps: 2/2 constraints]
After SMT, in 65140ms problems are : Problem set: 0 solved, 1689 unsolved
Search for dead transitions found 0 dead transitions in 65164ms
Finished structural reductions in DEADLOCK mode , in 1 iterations and 66979 ms. Remains : 1189/1189 places, 1695/1695 transitions.
Finished random walk after 12 steps, including 0 resets, run found a deadlock after 2 ms. (steps per millisecond=6 )
FORMULA Liveness FALSE TECHNIQUES STRUCTURAL DEADLOCK_TEST
Total runtime 93793 ms.
BK_STOP 1717142142551
--------------------
content from stderr:
+ export BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ Liveness = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution Liveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202405141337.jar
+ VERSION=202405141337
+ echo 'Running Version 202405141337'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination Liveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
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="PolyORBNT-COL-S05J80"
export BK_EXAMINATION="Liveness"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
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-5568"
echo " Executing tool itstools"
echo " Input is PolyORBNT-COL-S05J80, examination is Liveness"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r299-tajo-171654455900249"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/PolyORBNT-COL-S05J80.tgz
mv PolyORBNT-COL-S05J80 execution
cd execution
if [ "Liveness" = "ReachabilityDeadlock" ] || [ "Liveness" = "UpperBounds" ] || [ "Liveness" = "QuasiLiveness" ] || [ "Liveness" = "StableMarking" ] || [ "Liveness" = "Liveness" ] || [ "Liveness" = "OneSafe" ] || [ "Liveness" = "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 [ "Liveness" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "Liveness" != "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 "Liveness.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property Liveness.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "Liveness.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 '
echo "FORMULA_NAME $x"
done
elif [ "Liveness" = "ReachabilityDeadlock" ] || [ "Liveness" = "QuasiLiveness" ] || [ "Liveness" = "StableMarking" ] || [ "Liveness" = "Liveness" ] || [ "Liveness" = "OneSafe" ] ; then
echo "FORMULA_NAME Liveness"
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 ;