About the Execution of MARCIE for DES-PT-60a
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
11290.770 | 3600000.00 | 3600060.00 | 20.00 | FF?FF??F??FF?FFT | normal |
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)
.................
=====================================================================
Generated by BenchKit 2-3253
Executing tool marcie
Input is DES-PT-60a, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r011-ebro-149436297200336
=====================================================================
--------------------
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 DES-PT-60a-CTLCardinality-0
FORMULA_NAME DES-PT-60a-CTLCardinality-1
FORMULA_NAME DES-PT-60a-CTLCardinality-10
FORMULA_NAME DES-PT-60a-CTLCardinality-11
FORMULA_NAME DES-PT-60a-CTLCardinality-12
FORMULA_NAME DES-PT-60a-CTLCardinality-13
FORMULA_NAME DES-PT-60a-CTLCardinality-14
FORMULA_NAME DES-PT-60a-CTLCardinality-15
FORMULA_NAME DES-PT-60a-CTLCardinality-2
FORMULA_NAME DES-PT-60a-CTLCardinality-3
FORMULA_NAME DES-PT-60a-CTLCardinality-4
FORMULA_NAME DES-PT-60a-CTLCardinality-5
FORMULA_NAME DES-PT-60a-CTLCardinality-6
FORMULA_NAME DES-PT-60a-CTLCardinality-7
FORMULA_NAME DES-PT-60a-CTLCardinality-8
FORMULA_NAME DES-PT-60a-CTLCardinality-9
=== Now, execution of the tool begins
BK_START 1494456202013
timeout --kill-after=10s --signal=SIGINT 1m for testing only
Marcie rev. 8852M (built: crohr on 2017-05-03)
A model checker for Generalized Stochastic Petri nets
authors: Alex Tovchigrechko (IDD package and CTL model checking)
Martin Schwarick (Symbolic numerical analysis and CSL model checking)
Christian Rohr (Simulative and approximative numerical model checking)
marcie@informatik.tu-cottbus.de
called as: marcie --net-file=model.pnml --mcc-file=CTLCardinality.xml --memory=6
parse successfull
net created successfully
Net: DES_PT_60a
(NrP: 354 NrTr: 311 NrArc: 1496)
parse formulas
formulas created successfully
place and transition orderings generation:0m 0.022sec
net check time: 0m 0.001sec
init dd package: 0m 2.323sec
after gc: zbdd nodes used:80131, unused:18669869
after gc: zbdd nodes used:118823, unused:37381177
RS generation: 2m18.449sec
-> reachability set: #nodes 115998 (1.2e+05) #states 81,839,417,852,245 (13)
starting MCC model checker
--------------------------
checking: ~ [AG [EF [p331<=p159]]]
normalized: E [true U ~ [E [true U p331<=p159]]]
abstracting: (p331<=p159)
states: 7,995,786,465,155 (12)
after gc: zbdd nodes used:332503, unused:74667497
after gc: zbdd nodes used:292284, unused:149707716MC time: 3m37.020sec
checking: AG [p57<=p249]
normalized: ~ [E [true U ~ [p57<=p249]]]
abstracting: (p57<=p249)
states: 81,345,034,940,565 (13)
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-12 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m55.698sec
checking: AG [AF [[3<=p193 & 3<=p205]]]
normalized: ~ [E [true U EG [~ [[3<=p193 & 3<=p205]]]]]
abstracting: (3<=p205)
states: 0
abstracting: (3<=p193)
states: 0
EG iterations: 0
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-15 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m10.879sec
checking: E [[~ [3<=p345] | 1<=p95] U EX [3<=p338]]
normalized: E [[1<=p95 | ~ [3<=p345]] U EX [3<=p338]]
abstracting: (3<=p338)
states: 0
.abstracting: (3<=p345)
states: 0
abstracting: (1<=p95)
states: 1,427,258,182,664 (12)
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-0 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.003sec
checking: EX [AF [[2<=p87 & p302<=p264]]]
normalized: EX [~ [EG [~ [[2<=p87 & p302<=p264]]]]]
abstracting: (p302<=p264)
states: 58,935,545,393,197 (13)
abstracting: (2<=p87)
states: 0
EG iterations: 0
.-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-7 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.175sec
checking: AG [EX [[2<=p123 | p40<=p321]]]
normalized: ~ [E [true U ~ [EX [[2<=p123 | p40<=p321]]]]]
abstracting: (p40<=p321)
states: 80,889,488,061,005 (13)
abstracting: (2<=p123)
states: 0
.
after gc: zbdd nodes used:432571, unused:299567429-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-8 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 4m18.960sec
checking: [~ [AG [1<=p240]] & E [~ [3<=p147] U 3<=p318]]
normalized: [E [~ [3<=p147] U 3<=p318] & E [true U ~ [1<=p240]]]
abstracting: (1<=p240)
states: 41,168,478,639,264 (13)
abstracting: (3<=p318)
states: 0
abstracting: (3<=p147)
states: 0
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-11 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 3m24.628sec
checking: [EG [AF [1<=p243]] | AG [[~ [3<=p311] & ~ [p31<=p104]]]]
normalized: [~ [E [true U ~ [[~ [p31<=p104] & ~ [3<=p311]]]]] | EG [~ [EG [~ [1<=p243]]]]]
abstracting: (1<=p243)
states: 40,887,680,745,120 (13)
............MC time: 4m32.136sec
checking: E [~ [[3<=p242 & 2<=p105]] U AG [p353<=p226]]
normalized: E [~ [[3<=p242 & 2<=p105]] U ~ [E [true U ~ [p353<=p226]]]]
abstracting: (p353<=p226)
states: 66,842,866,729,694 (13)
after gc: zbdd nodes used:539016, unused:599460984abstracting: (2<=p105)
states: 0
abstracting: (3<=p242)
states: 0
MC time: 4m 5.026sec
checking: A [EF [p247<=p247] U EG [p162<=p145]]
normalized: [~ [EG [~ [EG [p162<=p145]]]] & ~ [E [~ [EG [p162<=p145]] U [~ [E [true U p247<=p247]] & ~ [EG [p162<=p145]]]]]]
abstracting: (p162<=p145)
states: 80,452,045,935,909 (13)
................................MC time: 3m40.075sec
checking: ~ [[AX [[2<=p46 | p11<=p224]] & E [p43<=p35 U 2<=p130]]]
normalized: ~ [[E [p43<=p35 U 2<=p130] & ~ [EX [~ [[2<=p46 | p11<=p224]]]]]]
abstracting: (p11<=p224)
states: 80,412,159,669,581 (13)
abstracting: (2<=p46)
states: 0
.abstracting: (2<=p130)
states: 0
abstracting: (p43<=p35)
states: 80,412,159,669,581 (13)
-> the formula is TRUE
FORMULA DES-PT-60a-CTLCardinality-9 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 1.122sec
checking: A [~ [[2<=p137 & 3<=p186]] U [[3<=p201 & 2<=p338] & [1<=p15 | p61<=p41]]]
normalized: [~ [EG [~ [[[3<=p201 & 2<=p338] & [1<=p15 | p61<=p41]]]]] & ~ [E [~ [[[3<=p201 & 2<=p338] & [1<=p15 | p61<=p41]]] U [[2<=p137 & 3<=p186] & ~ [[[3<=p201 & 2<=p338] & [1<=p15 | p61<=p41]]]]]]]
abstracting: (p61<=p41)
states: 80,414,717,513,441 (13)
abstracting: (1<=p15)
states: 1,427,258,182,664 (12)
abstracting: (2<=p338)
states: 0
abstracting: (3<=p201)
states: 0
abstracting: (3<=p186)
states: 0
abstracting: (2<=p137)
states: 0
abstracting: (p61<=p41)
states: 80,414,717,513,441 (13)
abstracting: (1<=p15)
states: 1,427,258,182,664 (12)
abstracting: (2<=p338)
states: 0
abstracting: (3<=p201)
states: 0
abstracting: (p61<=p41)
states: 80,414,717,513,441 (13)
abstracting: (1<=p15)
states: 1,427,258,182,664 (12)
abstracting: (2<=p338)
states: 0
abstracting: (3<=p201)
states: 0
EG iterations: 0
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-4 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.008sec
checking: EF [[[~ [p188<=p82] & [p11<=p183 | p204<=p49]] & AG [3<=p237]]]
normalized: E [true U [~ [E [true U ~ [3<=p237]]] & [[p11<=p183 | p204<=p49] & ~ [p188<=p82]]]]
abstracting: (p188<=p82)
states: 80,412,159,669,581 (13)
abstracting: (p204<=p49)
states: 80,412,159,669,581 (13)
abstracting: (p11<=p183)
states: 80,412,159,669,581 (13)
abstracting: (3<=p237)
states: 0
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-5 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m18.091sec
checking: A [[[p192<=p283 & p78<=p207] & [3<=p303 & p195<=p201]] U EF [3<=p140]]
normalized: [~ [EG [~ [E [true U 3<=p140]]]] & ~ [E [~ [E [true U 3<=p140]] U [~ [E [true U 3<=p140]] & ~ [[[3<=p303 & p195<=p201] & [p192<=p283 & p78<=p207]]]]]]]
abstracting: (p78<=p207)
states: 80,412,159,669,581 (13)
abstracting: (p192<=p283)
states: 81,311,389,723,581 (13)
abstracting: (p195<=p201)
states: 80,412,159,669,581 (13)
abstracting: (3<=p303)
states: 0
abstracting: (3<=p140)
states: 0
abstracting: (3<=p140)
states: 0
abstracting: (3<=p140)
states: 0
EG iterations: 0
-> the formula is FALSE
FORMULA DES-PT-60a-CTLCardinality-1 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.178sec
checking: EF [[AF [p217<=p242] & [[p218<=p124 | p74<=p142] & [2<=p185 | 2<=p45]]]]
normalized: E [true U [[[2<=p185 | 2<=p45] & [p218<=p124 | p74<=p142]] & ~ [EG [~ [p217<=p242]]]]]
abstracting: (p217<=p242)
states: 81,126,192,780,333 (13)
.........................................................MC time: 5m27.055sec
checking: EF [[EX [1<=p76] & [[p342<=p333 & p275<=p191] & [p278<=p304 | p22<=p152]]]]
normalized: E [true U [[[p278<=p304 | p22<=p152] & [p342<=p333 & p275<=p191]] & EX [1<=p76]]]
abstracting: (1<=p76)
states: 1,427,258,182,664 (12)
.abstracting: (p275<=p191)
states: 7,912,051,000,608 (12)
abstracting: (p342<=p333)
states: 59,858,581,303,877 (13)
abstracting: (p22<=p152)
states: 80,436,356,626,109 (13)
abstracting: (p278<=p304)
states: 49,428,517,193,873 (13)
MC time: 4m32.000sec
checking: ~ [AG [EF [p331<=p159]]]
normalized: E [true U ~ [E [true U p331<=p159]]]
abstracting: (p331<=p159)
states: 7,995,786,465,155 (12)
after gc: zbdd nodes used:918361, unused:599081639
BK_TIME_CONFINEMENT_REACHED
--------------------
content from stderr:
check for maximal unmarked siphon
ok
check for constant places
ok
check if there are places and transitions
ok
check if there are transitions without pre-places
ok
check if at least one transition is enabled in m0
ok
check if there are transitions that can never fire
ok
initing FirstDep: 0m 0.002sec
56909 97985 106003 114222 107381 111569 110376 112009 110680 112092 118481 111197 115229 114006 115257 121237 115036 117521 115071 115213 119706 118438 119092
iterations count:2302282 (7402), effective:103367 (332)
initing FirstDep: 0m 0.002sec
iterations count:82090 (263), effective:2063 (6)
sat_reach.icc:155: Timeout: after 216 sec
iterations count:52486 (168), effective:2295 (7)
iterations count:311 (1), effective:0 (0)
128317 131954
iterations count:259279 (833), effective:12240 (39)
135658
iterations count:167024 (537), effective:6180 (19)
net_ddint.h:596: Timeout: after 271 sec
126973 126486 123985
iterations count:311138 (1000), effective:12688 (40)
sat_reach.icc:155: Timeout: after 244 sec
net_ddint.h:596: Timeout: after 219 sec
iterations count:311 (1), effective:0 (0)
iterations count:311 (1), effective:0 (0)
net_ddint.h:596: Timeout: after 326 sec
119161 128936 133726 131807 137196
sat_reach.icc:155: Timeout: after 271 sec
iterations count:82090 (263), effective:2063 (6)
146606 149203 155109 154894 153964
iterations count:523883 (1684), effective:21151 (68)
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="DES-PT-60a"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="marcie"
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/DES-PT-60a.tgz
mv DES-PT-60a execution
# this is for BenchKit: explicit launching of the test
cd execution
echo "====================================================================="
echo " Generated by BenchKit 2-3253"
echo " Executing tool marcie"
echo " Input is DES-PT-60a, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 1"
echo " Run identifier is r011-ebro-149436297200336"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "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 "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.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
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 ;