Execution Chart

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

Trace from the execution

Waiting for the VM to be ready (probing ssh)
.................................................................................................
/home/mcc/execution
total 536K
-rw-r--r-- 1 mcc users 3.0K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 16K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.9K May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 21K May 15 18:54 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K May 15 18:50 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.1K May 15 18:50 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 2.5K May 15 18:54 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K May 15 18:54 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.9K May 15 18:54 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.1K May 15 18:54 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.1K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 14K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 113 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 351 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 2.5K May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 13K May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K May 15 18:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 15 18:50 equiv_col
-rw-r--r-- 1 mcc users 4 May 15 18:50 instance
-rw-r--r-- 1 mcc users 6 May 15 18:50 iscolored
-rw-r--r-- 1 mcc users 374K May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool itstools
Input is FlexibleBarrier-PT-10b, examination is ReachabilityDeadlock
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r092-blw7-152650004400153
=====================================================================

--------------------
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 FlexibleBarrier-PT-10b-ReachabilityDeadlock-0

=== Now, execution of the tool begins

BK_START 1527256853102

Flatten gal took : 227 ms
Constant places removed 1 places and 1 transitions.
Performed 907 Post agglomeration using F-continuation condition.
Iterating post reduction 0 with 908 rules applied. Total rules applied 908 place count 1401 transition count 705
Constant places removed 909 places and 2 transitions.
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 1 with 910 rules applied. Total rules applied 1818 place count 492 transition count 702
Performed 1 Pre agglomeration using Quasi-Persistent + HF-interchangeable + Divergent Free condition.
Pre-agglomeration after 2 with 1 Pre rules applied. Total rules applied 1818 place count 492 transition count 701
Constant places removed 1 places and 0 transitions.
Iterating post reduction 2 with 1 rules applied. Total rules applied 1819 place count 491 transition count 701
Symmetric choice reduction at 3 with 167 rule applications. Total rules 1986 place count 491 transition count 701
Constant places removed 167 places and 167 transitions.
Reduce isomorphic transitions removed 81 transitions.
Iterating post reduction 3 with 248 rules applied. Total rules applied 2234 place count 324 transition count 453
Performed 51 Post agglomeration using F-continuation condition.
Constant places removed 51 places and 0 transitions.
Iterating post reduction 4 with 51 rules applied. Total rules applied 2285 place count 273 transition count 402
Performed 20 Post agglomeration using F-continuation condition.
Constant places removed 20 places and 0 transitions.
Iterating post reduction 5 with 20 rules applied. Total rules applied 2305 place count 253 transition count 464
Applied a total of 2305 rules in 383 ms. Remains 253 /1402 variables (removed 1149) and now considering 464/1613 (removed 1149) transitions.
Normalized transition count is 434
// Phase 1: matrix 434 rows 253 cols
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201805151631/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/ReachabilityDeadlock.pnml.gal, -t, CGAL, -ctl, DEADLOCK], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201805151631/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/ReachabilityDeadlock.pnml.gal -t CGAL -ctl DEADLOCK
No direction supplied, using forward translation only.
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 434
// Phase 1: matrix 434 rows 253 cols
invariant :p983 + p988 + p993 + p998 + p1003 + p1008 + p1013 + p1018 + p1023 + p1028 + p1033 + p1038 + p1043 + p1048 + p1053 + p1058 + p1063 + p1068 + p1073 + p1078 + p1083 + p1088 + p1093 + p1098 + p1103 + p1108 + p1113 + p1118 + p1123 + p1128 + p1133 + p1138 + p1143 + p1148 + p1153 + p1158 + p1163 + p1168 + p1173 + p1178 + p1183 + p1188 + p1193 + p1198 + p1203 + p1208 + p1213 + p1218 + p1223 + p1228 + p1233 + p1238 + p1243 + p1248 + p1253 + p1258 + p1263 + p1268 + p1273 + p1278 + p1283 + p1288 + p1293 + p1298 + p1303 + p1308 + p1313 + p1318 + p1323 + p1328 + p1333 + p1338 + p1343 + p1348 + p1353 + p1358 + p1363 + p1368 + p1373 + p1378 + p1383 + p1387 = 1
invariant :p647 + p651 + p655 + p659 + p663 + p667 + p671 + p675 + p682 + p688 + p689 + p691 + p692 + p695 + p701 + p706 + p708 = 1
invariant :p247 + p251 + p255 + p259 + p263 + p267 + p271 + p275 + p282 + p288 + p289 + p291 + p292 + p295 + p301 + p306 + p308 = 1
invariant :p1398 + p1399 = 1
invariant :p913 + p917 + p921 + p925 + p929 + p933 + p937 + p941 + p945 + p952 + p958 + p959 + p961 + p962 + p965 + p974 = 1
invariant :p447 + p451 + p455 + p459 + p463 + p467 + p471 + p475 + p482 + p488 + p489 + p491 + p492 + p495 + p501 + p506 + p508 = 1
invariant :p47 + p51 + p55 + p59 + p63 + p67 + p71 + p75 + p82 + p88 + p89 + p91 + p92 + p95 + p101 + p106 + p108 = 1
invariant :p347 + p351 + p355 + p359 + p363 + p367 + p371 + p375 + p382 + p388 + p389 + p391 + p392 + p395 + p401 + p406 + p408 = 1
invariant :p547 + p551 + p555 + p559 + p563 + p567 + p571 + p575 + p582 + p588 + p589 + p591 + p592 + p595 + p601 + p606 + p608 = 1
invariant :p147 + p151 + p155 + p159 + p163 + p167 + p171 + p175 + p182 + p188 + p189 + p191 + p192 + p195 + p201 + p206 + p208 = 1
invariant :p747 + p751 + p755 + p759 + p763 + p767 + p771 + p775 + p782 + p788 + p789 + p791 + p792 + p795 + p801 + p806 + p808 = 1
invariant :p847 + p851 + p855 + p859 + p863 + p867 + p871 + p875 + p882 + p888 + p889 + p891 + p892 + p895 + p901 + p906 + p908 = 1
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,3.11175e+14,27.6209,742680,2,132636,5,4.26533e+06,6,0,1478,2.02841e+06,0


Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
dead,2.33101e+13,122.522,2985084,2,529844,7,1.8427e+07,9,1,7030,5.83542e+06,2

System contains 2.33101e+13 deadlocks (shown below if less than --print-limit option) !
FORMULA FlexibleBarrier-PT-10b-ReachabilityDeadlock-0 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
[ 23310088139520 states ] showing 10 first states
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p247=1 p147=1 p47=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p247=1 p51=1 p147=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p151=1 p247=1 p47=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p151=1 p247=1 p51=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p251=1 p147=1 p47=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p251=1 p51=1 p147=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p251=1 p151=1 p47=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p251=1 p151=1 p51=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p55=1 p247=1 p147=1 ]
[ p1398=1 p913=1 p847=1 p747=1 p647=1 p547=1 p447=1 p1023=1 p347=1 p55=1 p151=1 p247=1 ]
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O3, model.c], workingDir=/home/mcc/execution]
WARNING : LTS min runner thread was asked to interrupt. Dying gracefully.

BK_STOP 1527256980187

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

+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution ReachabilityDeadlock -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -smt
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -consoleLog -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination ReachabilityDeadlock -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -smt -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss8m -Xms40m -Xmx8192m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
May 25, 2018 2:00:54 PM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityDeadlock, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -smt]
May 25, 2018 2:00:54 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
May 25, 2018 2:00:54 PM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 123 ms
May 25, 2018 2:00:54 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 1402 places.
May 25, 2018 2:00:55 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 1613 transitions.
May 25, 2018 2:00:55 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Found NUPN structural information;
May 25, 2018 2:00:55 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 31 ms
May 25, 2018 2:00:55 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 223 ms
May 25, 2018 2:00:55 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.simple.gal : 6 ms
May 25, 2018 2:00:55 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 1613 transitions.
May 25, 2018 2:00:56 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/ReachabilityDeadlock.pnml.gal : 2 ms
May 25, 2018 2:00:56 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 464 transitions.
May 25, 2018 2:00:56 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 12 place invariants in 151 ms
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 253 variables to be positive in 2308 ms
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 464 transitions.
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/464 took 1 ms. Total solver calls (SAT/UNSAT): 0(0/0)
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 34 ms. Total solver calls (SAT/UNSAT): 0(0/0)
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 464 transitions.
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 9 ms. Total solver calls (SAT/UNSAT): 0(0/0)
May 25, 2018 2:00:59 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 464 transitions.
May 25, 2018 2:01:10 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(1/464) took 11626 ms. Total solver calls (SAT/UNSAT): 343(170/173)
May 25, 2018 2:01:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(2/464) took 22868 ms. Total solver calls (SAT/UNSAT): 615(289/326)
May 25, 2018 2:01:32 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(3/464) took 33723 ms. Total solver calls (SAT/UNSAT): 886(407/479)
May 25, 2018 2:01:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(4/464) took 44410 ms. Total solver calls (SAT/UNSAT): 1156(524/632)
May 25, 2018 2:01:54 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(5/464) took 55102 ms. Total solver calls (SAT/UNSAT): 1425(640/785)
May 25, 2018 2:02:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(6/464) took 65924 ms. Total solver calls (SAT/UNSAT): 1693(755/938)
May 25, 2018 2:02:15 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(7/464) took 76437 ms. Total solver calls (SAT/UNSAT): 1960(869/1091)
May 25, 2018 2:02:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(8/464) took 87059 ms. Total solver calls (SAT/UNSAT): 2226(982/1244)
May 25, 2018 2:02:36 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(9/464) took 97512 ms. Total solver calls (SAT/UNSAT): 2491(1094/1397)
May 25, 2018 2:02:47 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(10/464) took 108413 ms. Total solver calls (SAT/UNSAT): 2755(1205/1550)
May 25, 2018 2:02:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(11/464) took 118842 ms. Total solver calls (SAT/UNSAT): 3018(1315/1703)
Skipping mayMatrices nes/nds SMT solver raised an exception or timeout.
java.lang.RuntimeException: SMT solver raised an exception or timeout.
at fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver.computeCoEnablingMatrix(NecessaryEnablingsolver.java:480)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printLabels(Gal2PinsTransformerNext.java:530)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printDependencyMatrix(Gal2PinsTransformerNext.java:209)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.buildBodyFile(Gal2PinsTransformerNext.java:85)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.transform(Gal2PinsTransformerNext.java:830)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:71)
at java.lang.Thread.run(Thread.java:748)
May 25, 2018 2:02:59 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 123614ms conformant to PINS in folder :/home/mcc/execution

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="FlexibleBarrier-PT-10b"
export BK_EXAMINATION="ReachabilityDeadlock"
export BK_TOOL="itstools"
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

tar xzf /home/mcc/BenchKit/INPUTS/FlexibleBarrier-PT-10b.tgz
mv FlexibleBarrier-PT-10b execution
cd execution
pwd
ls -lh

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3637"
echo " Executing tool itstools"
echo " Input is FlexibleBarrier-PT-10b, examination is ReachabilityDeadlock"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r092-blw7-152650004400153"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "ReachabilityDeadlock" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityDeadlock" != "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 "ReachabilityDeadlock.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityDeadlock.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityDeadlock.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 '' ReachabilityDeadlock.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
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 ;