About the Execution of MARCIE for S_AutoFlight-PT-06a
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
6656.240 | 654631.00 | 653999.00 | 30.30 | TFFFTFFFTFFFTFTT | 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-3254
Executing tool marcie
Input is S_AutoFlight-PT-06a, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r081-csrt-149441064200201
=====================================================================
--------------------
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 AutoFlight-PT-06a-CTLCardinality-0
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-1
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-10
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-11
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-12
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-13
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-14
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-15
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-2
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-3
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-4
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-5
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-6
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-7
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-8
FORMULA_NAME AutoFlight-PT-06a-CTLCardinality-9
=== Now, execution of the tool begins
BK_START 1494887399098
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: AutoFlight_PT_06a
(NrP: 157 NrTr: 155 NrArc: 500)
parse formulas
formulas created successfully
place and transition orderings generation:0m 0.002sec
net check time: 0m 0.000sec
init dd package: 0m 1.275sec
RS generation: 0m 0.068sec
-> reachability set: #nodes 488 (4.9e+02) #states 1,371,919,681 (9)
starting MCC model checker
--------------------------
checking: ~ [AG [p16<=p132]]
normalized: E [true U ~ [p16<=p132]]
abstracting: (p16<=p132)
states: 954,566,209 (8)
-> the formula is TRUE
FORMULA AutoFlight-PT-06a-CTLCardinality-0 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 3.373sec
checking: EF [AF [[2<=p7 & 3<=p28]]]
normalized: E [true U ~ [EG [~ [[2<=p7 & 3<=p28]]]]]
abstracting: (3<=p28)
states: 0
abstracting: (2<=p7)
states: 0
EG iterations: 0
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-11 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.000sec
checking: ~ [[AX [~ [3<=p40]] & EG [p119<=p38]]]
normalized: ~ [[~ [EX [3<=p40]] & EG [p119<=p38]]]
abstracting: (p119<=p38)
states: 1,349,244,865 (9)
.
EG iterations: 1
abstracting: (3<=p40)
states: 0
.-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-3 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.219sec
checking: A [EG [p106<=p75] U 3<=p80]
normalized: [~ [EG [~ [3<=p80]]] & ~ [E [~ [3<=p80] U [~ [3<=p80] & ~ [EG [p106<=p75]]]]]]
abstracting: (p106<=p75)
states: 1,368,933,697 (9)
................................................
EG iterations: 48
abstracting: (3<=p80)
states: 0
abstracting: (3<=p80)
states: 0
abstracting: (3<=p80)
states: 0
EG iterations: 0
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-5 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 2.932sec
checking: EX [[1<=p81 | AG [p150<=p118]]]
normalized: EX [[~ [E [true U ~ [p150<=p118]]] | 1<=p81]]
abstracting: (1<=p81)
states: 2,985,984 (6)
abstracting: (p150<=p118)
states: 1,371,919,681 (9)
.-> the formula is TRUE
FORMULA AutoFlight-PT-06a-CTLCardinality-6 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.002sec
checking: AF [EG [[1<=p28 & p136<=p62]]]
normalized: ~ [EG [~ [EG [[1<=p28 & p136<=p62]]]]]
abstracting: (p136<=p62)
states: 173,047,105 (8)
abstracting: (1<=p28)
states: 1,371,919,680 (9)
................................
EG iterations: 32
.
EG iterations: 1
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-7 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.147sec
checking: EG [A [1<=p30 U p22<=p51]]
normalized: EG [[~ [E [~ [p22<=p51] U [~ [p22<=p51] & ~ [1<=p30]]]] & ~ [EG [~ [p22<=p51]]]]]
abstracting: (p22<=p51)
states: 1,371,919,681 (9)
.
EG iterations: 1
abstracting: (1<=p30)
states: 420,292,800 (8)
abstracting: (p22<=p51)
states: 1,371,919,681 (9)
abstracting: (p22<=p51)
states: 1,371,919,681 (9)
EG iterations: 0
-> the formula is TRUE
FORMULA AutoFlight-PT-06a-CTLCardinality-9 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.001sec
checking: ~ [[p40<=p118 & AF [~ [p142<=p3]]]]
normalized: ~ [[~ [EG [p142<=p3]] & p40<=p118]]
abstracting: (p40<=p118)
states: 1,360,582,273 (9)
abstracting: (p142<=p3)
states: 583,122,241 (8)
.......
after gc: zbdd nodes used:78812, unused:18671188........
after gc: zbdd nodes used:2008299, unused:35491701.........................
EG iterations: 40
-> the formula is TRUE
FORMULA AutoFlight-PT-06a-CTLCardinality-8 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m41.347sec
checking: [EF [[~ [3<=p73] & [p148<=p72 | 1<=p36]]] & AF [AX [2<=p88]]]
normalized: [E [true U [[p148<=p72 | 1<=p36] & ~ [3<=p73]]] & ~ [EG [EX [~ [2<=p88]]]]]
abstracting: (2<=p88)
states: 0
..........
after gc: zbdd nodes used:1314012, unused:73685988..........
after gc: zbdd nodes used:2870377, unused:147129623...............
EG iterations: 34
abstracting: (3<=p73)
states: 0
abstracting: (1<=p36)
states: 479,592,576 (8)
abstracting: (p148<=p72)
states: 173,047,105 (8)
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-10 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 2m57.653sec
checking: [AG [~ [3<=p49]] | [[EX [2<=p125] & ~ [~ [2<=p119]]] & p127<=p2]]
normalized: [~ [E [true U 3<=p49]] | [[EX [2<=p125] & 2<=p119] & p127<=p2]]
abstracting: (p127<=p2)
states: 1,349,244,865 (9)
abstracting: (2<=p119)
states: 0
abstracting: (2<=p125)
states: 0
.abstracting: (3<=p49)
states: 0
-> the formula is TRUE
FORMULA AutoFlight-PT-06a-CTLCardinality-12 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.001sec
checking: A [~ [[2<=p113 | 1<=p121]] U [~ [p29<=p27] | [2<=p115 & 2<=p88]]]
normalized: [~ [EG [~ [[[2<=p115 & 2<=p88] | ~ [p29<=p27]]]]] & ~ [E [~ [[[2<=p115 & 2<=p88] | ~ [p29<=p27]]] U [~ [[[2<=p115 & 2<=p88] | ~ [p29<=p27]]] & [2<=p113 | 1<=p121]]]]]
abstracting: (1<=p121)
states: 34,012,224 (7)
abstracting: (2<=p113)
states: 0
abstracting: (p29<=p27)
states: 1,059,044,545 (9)
abstracting: (2<=p88)
states: 0
abstracting: (2<=p115)
states: 0
abstracting: (p29<=p27)
states: 1,059,044,545 (9)
abstracting: (2<=p88)
states: 0
abstracting: (2<=p115)
states: 0
abstracting: (p29<=p27)
states: 1,059,044,545 (9)
abstracting: (2<=p88)
states: 0
abstracting: (2<=p115)
states: 0
..................................
EG iterations: 34
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-1 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 2m 8.733sec
checking: ~ [[[EG [p131<=p145] | [[p141<=p132 & 2<=p98] & [2<=p12 & 1<=p117]]] & AX [~ [3<=p95]]]]
normalized: ~ [[~ [EX [3<=p95]] & [[[2<=p12 & 1<=p117] & [p141<=p132 & 2<=p98]] | EG [p131<=p145]]]]
abstracting: (p131<=p145)
states: 1,337,907,457 (9)
.
EG iterations: 1
abstracting: (2<=p98)
states: 0
abstracting: (p141<=p132)
states: 1,337,907,457 (9)
abstracting: (1<=p117)
states: 34,012,224 (7)
abstracting: (2<=p12)
states: 0
abstracting: (3<=p95)
states: 0
.-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-14 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.130sec
checking: A [[[3<=p80 | p66<=p85] & [p120<=p120 & p55<=p140]] U EF [3<=p148]]
normalized: [~ [EG [~ [E [true U 3<=p148]]]] & ~ [E [~ [E [true U 3<=p148]] U [~ [E [true U 3<=p148]] & ~ [[[p120<=p120 & p55<=p140] & [3<=p80 | p66<=p85]]]]]]]
abstracting: (p66<=p85)
states: 1,368,933,697 (9)
abstracting: (3<=p80)
states: 0
abstracting: (p55<=p140)
states: 702,965,953 (8)
abstracting: (p120<=p120)
states: 1,371,919,681 (9)
abstracting: (3<=p148)
states: 0
abstracting: (3<=p148)
states: 0
abstracting: (3<=p148)
states: 0
EG iterations: 0
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-15 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.033sec
checking: [[EX [~ [p140<=p53]] | AF [1<=p52]] | ~ [[AF [p59<=p91] | [[2<=p126 | 3<=p137] & ~ [p15<=p99]]]]]
normalized: [~ [[[~ [p15<=p99] & [2<=p126 | 3<=p137]] | ~ [EG [~ [p59<=p91]]]]] | [~ [EG [~ [1<=p52]]] | EX [~ [p140<=p53]]]]
abstracting: (p140<=p53)
states: 1,354,913,569 (9)
.abstracting: (1<=p52)
states: 685,959,840 (8)
................
after gc: zbdd nodes used:1252444, unused:298747556..................
EG iterations: 34
abstracting: (p59<=p91)
states: 702,965,953 (8)
..................................
EG iterations: 34
abstracting: (3<=p137)
states: 0
abstracting: (2<=p126)
states: 0
abstracting: (p15<=p99)
states: 901,300,609 (8)
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-4 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 4m53.377sec
checking: [~ [EF [[p44<=p89 & 3<=p121]]] & E [[p39<=p127 & p16<=p74] U [p82<=p118 | p16<=p106]]]
normalized: [E [[p39<=p127 & p16<=p74] U [p82<=p118 | p16<=p106]] & ~ [E [true U [p44<=p89 & 3<=p121]]]]
abstracting: (3<=p121)
states: 0
abstracting: (p44<=p89)
states: 693,518,113 (8)
abstracting: (p16<=p106)
states: 944,224,129 (8)
abstracting: (p82<=p118)
states: 1,371,919,681 (9)
abstracting: (p16<=p74)
states: 943,228,801 (8)
abstracting: (p39<=p127)
states: 906,650,497 (8)
-> the formula is TRUE
FORMULA AutoFlight-PT-06a-CTLCardinality-2 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.031sec
checking: [[[[p118<=p98 | [1<=p49 | p21<=p66]] & p95<=p88] & EF [[2<=p93 & p9<=p118]]] & p12<=p4]
normalized: [[[[[1<=p49 | p21<=p66] | p118<=p98] & p95<=p88] & E [true U [2<=p93 & p9<=p118]]] & p12<=p4]
abstracting: (p12<=p4)
states: 1,080,651,457 (9)
abstracting: (p9<=p118)
states: 1,321,982,209 (9)
abstracting: (2<=p93)
states: 0
abstracting: (p95<=p88)
states: 1,368,933,697 (9)
abstracting: (p118<=p98)
states: 149,812,417 (8)
abstracting: (p21<=p66)
states: 2,985,985 (6)
abstracting: (1<=p49)
states: 685,959,840 (8)
-> the formula is FALSE
FORMULA AutoFlight-PT-06a-CTLCardinality-13 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.004sec
totally nodes used: 400523220(4.0e+08)
number of garbage collections: 5
fire ops cache: hits/miss/sum: 190917051 256475400 447392451
used/not used/entry size/cache size: 41601485 25507379 16 1024MB
basic ops cache: hits/miss/sum: 536598872 1225288869 1761887741
used/not used/entry size/cache size: 16777216 0 12 192MB
unary ops cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 8388608 8 64MB
abstract ops cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 8388608 12 96MB
state nr cache: hits/miss/sum: 4819 7043 11862
used/not used/entry size/cache size: 2691 2094461 32 64MB
max state cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 8388608 32 256MB
uniqueHash elements/entry size/size: 67108864 4 256MB
0 11872885
1 20363794
2 17650121
3 10326040
4 4581083
5 1648276
6 498515
7 130992
8 29791
9 6019
>= 10 1348
Total processing time: 10m54.600sec
BK_STOP 1494888053729
--------------------
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.000sec
iterations count:5839 (37), effective:507 (3)
initing FirstDep: 0m 0.000sec
iterations count:4165 (26), effective:317 (2)
iterations count:1635 (10), effective:106 (0)
iterations count:367 (2), effective:20 (0)
iterations count:1697 (10), effective:129 (0)
iterations count:292 (1), effective:4 (0)
iterations count:155 (1), effective:0 (0)
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="S_AutoFlight-PT-06a"
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/S_AutoFlight-PT-06a.tgz
mv S_AutoFlight-PT-06a execution
# this is for BenchKit: explicit launching of the test
cd execution
echo "====================================================================="
echo " Generated by BenchKit 2-3254"
echo " Executing tool marcie"
echo " Input is S_AutoFlight-PT-06a, 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 r081-csrt-149441064200201"
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 ;