About the Execution of 2021-gold for ShieldPPPs-PT-100B
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
877.027 | 73609.00 | 101824.00 | 484.00 | F | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fkordon/mcc2022-input.r234-tall-165286038200328.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2022-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 gold2021
Input is ShieldPPPs-PT-100B, examination is StableMarking
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r234-tall-165286038200328
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 2.0M
-rw-r--r-- 1 mcc users 7.1K Apr 30 03:30 CTLCardinality.txt
-rw-r--r-- 1 mcc users 72K Apr 30 03:30 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.6K Apr 30 03:30 CTLFireability.txt
-rw-r--r-- 1 mcc users 50K Apr 30 03:30 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 10 09:34 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 4.0K May 9 08:53 LTLCardinality.txt
-rw-r--r-- 1 mcc users 30K May 9 08:53 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K May 9 08:53 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K May 9 08:53 LTLFireability.xml
-rw-r--r-- 1 mcc users 1.7K May 9 08:53 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K May 9 08:53 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 10 09:34 equiv_col
-rw-r--r-- 1 mcc users 5 May 10 09:34 instance
-rw-r--r-- 1 mcc users 6 May 10 09:34 iscolored
-rw-r--r-- 1 mcc users 1.8M May 10 09:34 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 StableMarking
=== Now, execution of the tool begins
BK_START 1653034679032
Running Version 0
[2022-05-20 08:18:00] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, StableMarking, -spotpath, /home/mcc/BenchKit/bin//..//ltlfilt, -z3path, /home/mcc/BenchKit/bin//..//z3/bin/z3, -yices2path, /home/mcc/BenchKit/bin//..//yices/bin/yices, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2022-05-20 08:18:00] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-20 08:18:01] [INFO ] Load time of PNML (sax parser for PT used): 402 ms
[2022-05-20 08:18:01] [INFO ] Transformed 6803 places.
[2022-05-20 08:18:01] [INFO ] Transformed 6303 transitions.
[2022-05-20 08:18:01] [INFO ] Found NUPN structural information;
[2022-05-20 08:18:01] [INFO ] Parsed PT model containing 6803 places and 6303 transitions in 762 ms.
Structural test allowed to assert that 2704 places are NOT stable. Took 41 ms.
Incomplete random walk after 10000 steps, including 2 resets, run finished after 1717 ms. (steps per millisecond=5 ) properties (out of 4099) seen :679
Running SMT prover for 3420 properties.
// Phase 1: matrix 6303 rows 6803 cols
[2022-05-20 08:18:03] [INFO ] Computed 1101 place invariants in 73 ms
[2022-05-20 08:18:28] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
Fused 3420 Parikh solutions to 1 different solutions.
Support contains 3420 out of 6803 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 6803/6803 places, 6303/6303 transitions.
Drop transitions removed 452 transitions
Trivial Post-agglo rules discarded 452 transitions
Performed 452 trivial Post agglomeration. Transition count delta: 452
Iterating post reduction 0 with 452 rules applied. Total rules applied 452 place count 6803 transition count 5851
Reduce places removed 452 places and 0 transitions.
Iterating post reduction 1 with 452 rules applied. Total rules applied 904 place count 6351 transition count 5851
Performed 337 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 337 Pre rules applied. Total rules applied 904 place count 6351 transition count 5514
Deduced a syphon composed of 337 places in 28 ms
Reduce places removed 337 places and 0 transitions.
Iterating global reduction 2 with 674 rules applied. Total rules applied 1578 place count 6014 transition count 5514
Discarding 97 places :
Symmetric choice reduction at 2 with 97 rule applications. Total rules 1675 place count 5917 transition count 5417
Iterating global reduction 2 with 97 rules applied. Total rules applied 1772 place count 5917 transition count 5417
Performed 55 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 55 Pre rules applied. Total rules applied 1772 place count 5917 transition count 5362
Deduced a syphon composed of 55 places in 26 ms
Reduce places removed 55 places and 0 transitions.
Iterating global reduction 2 with 110 rules applied. Total rules applied 1882 place count 5862 transition count 5362
Performed 1240 Post agglomeration using F-continuation condition.Transition count delta: 1240
Deduced a syphon composed of 1240 places in 16 ms
Reduce places removed 1240 places and 0 transitions.
Iterating global reduction 2 with 2480 rules applied. Total rules applied 4362 place count 4622 transition count 4122
Renaming transitions due to excessive name length > 1024 char.
Partial Free-agglomeration rule applied 148 times.
Drop transitions removed 148 transitions
Iterating global reduction 2 with 148 rules applied. Total rules applied 4510 place count 4622 transition count 4122
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 2 with 1 rules applied. Total rules applied 4511 place count 4621 transition count 4121
Applied a total of 4511 rules in 1693 ms. Remains 4621 /6803 variables (removed 2182) and now considering 4121/6303 (removed 2182) transitions.
Finished structural reductions, in 1 iterations. Remains : 4621/6803 places, 4121/6303 transitions.
[2022-05-20 08:18:30] [INFO ] Flatten gal took : 346 ms
[2022-05-20 08:18:31] [INFO ] Flatten gal took : 201 ms
[2022-05-20 08:18:31] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality910969655994969414.gal : 61 ms
[2022-05-20 08:18:31] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality9815673818679025843.prop : 8 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality910969655994969414.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality9815673818679025843.prop, --nowitness, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-reach command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality910969655994969414.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality9815673818679025843.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality9815673818679025843.prop.
Detected timeout of ITS tools.
[2022-05-20 08:18:46] [INFO ] Flatten gal took : 145 ms
[2022-05-20 08:18:46] [INFO ] Applying decomposition
[2022-05-20 08:18:46] [INFO ] Flatten gal took : 140 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph533813683280417604.txt, -o, /tmp/graph533813683280417604.bin, -w, /tmp/graph533813683280417604.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph533813683280417604.bin, -l, -1, -v, -w, /tmp/graph533813683280417604.weights, -q, 0, -e, 0.001], workingDir=null]
[2022-05-20 08:18:47] [INFO ] Decomposing Gal with order
[2022-05-20 08:18:47] [INFO ] Rewriting arrays to variables to allow decomposition.
[2022-05-20 08:18:48] [INFO ] Removed a total of 962 redundant transitions.
[2022-05-20 08:18:48] [INFO ] Flatten gal took : 308 ms
[2022-05-20 08:18:49] [INFO ] Fuse similar labels procedure discarded/fused a total of 231 labels/synchronizations in 90 ms.
[2022-05-20 08:18:49] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality3691370882553561579.gal : 32 ms
[2022-05-20 08:18:49] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality4482472220212802877.prop : 6 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality3691370882553561579.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality4482472220212802877.prop, --nowitness], workingDir=/home/mcc/execution]
its-reach command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality3691370882553561579.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality4482472220212802877.prop --nowitness
Loading property file /tmp/ReachabilityCardinality4482472220212802877.prop.
SDD proceeding with computation,3420 properties remain. new max is 4
SDD size :1 after 1
SDD proceeding with computation,3420 properties remain. new max is 8
SDD size :1 after 1
SDD proceeding with computation,3420 properties remain. new max is 16
SDD size :1 after 1
SDD proceeding with computation,3420 properties remain. new max is 32
SDD size :1 after 1
SDD proceeding with computation,3420 properties remain. new max is 64
SDD size :1 after 1
SDD proceeding with computation,3420 properties remain. new max is 128
SDD size :1 after 1
SDD proceeding with computation,3420 properties remain. new max is 256
SDD size :1 after 1
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin6386307660445480548
[2022-05-20 08:19:04] [INFO ] Built C files in 132ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin6386307660445480548
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin6386307660445480548]
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin6386307660445480548] killed by timeout after 1 SECONDS
java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin6386307660445480548] killed by timeout after 1 SECONDS
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:79)
at java.base/java.lang.Thread.run(Thread.java:834)
Finished random walk after 156492 steps, including 12 resets, run visited all 3420 properties in 5337 ms. (steps per millisecond=29 )
Able to resolve query StableMarking after proving 4100 properties.
FORMULA StableMarking FALSE TECHNIQUES RANDOM_WALK MARKED_SUFFIX_TEST TOPOLOGICAL
BK_STOP 1653034752641
--------------------
content from stderr:
+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ StableMarking = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution StableMarking -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
++ cut -d . -f 9
++ ls /home/mcc/BenchKit/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202104292328.jar
+ VERSION=0
+ echo 'Running Version 0'
+ /home/mcc/BenchKit/bin//..//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination StableMarking -spotpath /home/mcc/BenchKit/bin//..//ltlfilt -z3path /home/mcc/BenchKit/bin//..//z3/bin/z3 -yices2path /home/mcc/BenchKit/bin//..//yices/bin/yices -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m
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="ShieldPPPs-PT-100B"
export BK_EXAMINATION="StableMarking"
export BK_TOOL="gold2021"
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-4028"
echo " Executing tool gold2021"
echo " Input is ShieldPPPs-PT-100B, examination is StableMarking"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r234-tall-165286038200328"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/ShieldPPPs-PT-100B.tgz
mv ShieldPPPs-PT-100B execution
cd execution
if [ "StableMarking" = "ReachabilityDeadlock" ] || [ "StableMarking" = "UpperBounds" ] || [ "StableMarking" = "QuasiLiveness" ] || [ "StableMarking" = "StableMarking" ] || [ "StableMarking" = "Liveness" ] || [ "StableMarking" = "OneSafe" ] || [ "StableMarking" = "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 [ "StableMarking" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "StableMarking" != "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 "StableMarking.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property StableMarking.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "StableMarking.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 [ "StableMarking" = "ReachabilityDeadlock" ] || [ "StableMarking" = "QuasiLiveness" ] || [ "StableMarking" = "StableMarking" ] || [ "StableMarking" = "Liveness" ] || [ "StableMarking" = "OneSafe" ] ; then
echo "FORMULA_NAME StableMarking"
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 ;