About the Execution of MARCIE for S_TCPcondis-PT-05
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
7646.460 | 34084.00 | 34060.00 | 20.20 | TTTTTFTFTTFTFTTF | 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 S_TCPcondis-PT-05, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r151-ebro-149443454300201
=====================================================================
--------------------
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 TCPcondis-PT-05-CTLCardinality-0
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-1
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-10
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-11
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-12
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-13
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-14
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-15
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-2
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-3
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-4
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-5
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-6
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-7
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-8
FORMULA_NAME TCPcondis-PT-05-CTLCardinality-9
=== Now, execution of the tool begins
BK_START 1496683683873
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: TCPcondis_PT_05
(NrP: 30 NrTr: 32 NrArc: 108)
parse formulas
formulas created successfully
place and transition orderings generation:0m 0.000sec
net check time: 0m 0.000sec
init dd package: 0m 2.664sec
parse successfull
net created successfully
Net: TCPcondis_PT_05
(NrP: 30 NrTr: 32 NrArc: 108)
parse formulas
formulas created successfully
place and transition orderings generation:0m 0.000sec
net check time: 0m 0.000sec
init dd package: 0m 7.677sec
RS generation: 0m 0.895sec
-> reachability set: #nodes 9140 (9.1e+03) #states 2,985,834 (6)
starting MCC model checker
--------------------------
checking: EG [AF [~ [1<=xSYNSENT]]]
normalized: EG [~ [EG [1<=xSYNSENT]]]
abstracting: (1<=xSYNSENT)
states: 1,171,479 (6)
.
EG iterations: 1
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-2 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.385sec
checking: EG [~ [3<=FINACK]]
normalized: EG [~ [3<=FINACK]]
abstracting: (3<=FINACK)
states: 276,119 (5)
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-14 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.072sec
checking: ~ [AX [EG [xTIMEWAIT<=xSYN]]]
normalized: EX [~ [EG [xTIMEWAIT<=xSYN]]]
abstracting: (xTIMEWAIT<=xSYN)
states: 2,288,784 (6)
..........................................
EG iterations: 42
.-> the formula is FALSE
FORMULA TCPcondis-PT-05-CTLCardinality-4 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.919sec
checking: ~ [~ [AG [xTIMEWAIT<=FINACK]]]
normalized: ~ [E [true U ~ [xTIMEWAIT<=FINACK]]]
abstracting: (xTIMEWAIT<=FINACK)
states: 2,469,156 (6)
-> the formula is FALSE
FORMULA TCPcondis-PT-05-CTLCardinality-9 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 1.041sec
checking: EF [EG [xCLOSED<=xCLOSEWAIT]]
normalized: E [true U EG [xCLOSED<=xCLOSEWAIT]]
abstracting: (xCLOSED<=xCLOSEWAIT)
states: 2,193,435 (6)
...............................................
EG iterations: 47
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-10 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 1.574sec
checking: EG [xFINACK<=SYNACK]
normalized: EG [xFINACK<=SYNACK]
abstracting: (xFINACK<=SYNACK)
states: 1,528,702 (6)
...........................
EG iterations: 27
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-11 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.488sec
checking: AG [[AF [3<=TIMEWAIT] | ~ [2<=CLOSING]]]
normalized: ~ [E [true U ~ [[~ [2<=CLOSING] | ~ [EG [~ [3<=TIMEWAIT]]]]]]]
abstracting: (3<=TIMEWAIT)
states: 43,434 (4)
.
EG iterations: 1
abstracting: (2<=CLOSING)
states: 378,583 (5)
-> the formula is FALSE
FORMULA TCPcondis-PT-05-CTLCardinality-13 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 1.739sec
checking: AG [AF [[1<=xSYNSENT & 1<=xESTAB]]]
normalized: ~ [E [true U EG [~ [[1<=xSYNSENT & 1<=xESTAB]]]]]
abstracting: (1<=xESTAB)
states: 859,615 (5)
abstracting: (1<=xSYNSENT)
states: 1,171,479 (6)
...........................
EG iterations: 27
-> the formula is FALSE
FORMULA TCPcondis-PT-05-CTLCardinality-15 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.608sec
checking: EG [E [CLOSING<=xSYNRCVD U 1<=xFIN]]
normalized: EG [E [CLOSING<=xSYNRCVD U 1<=xFIN]]
abstracting: (1<=xFIN)
states: 1,515,785 (6)
abstracting: (CLOSING<=xSYNRCVD)
states: 2,077,025 (6)
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-7 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 1.310sec
checking: EG [[AX [2<=xCLOSING] | EG [SYNRCVD<=xCLOSING]]]
normalized: EG [[EG [SYNRCVD<=xCLOSING] | ~ [EX [~ [2<=xCLOSING]]]]]
abstracting: (2<=xCLOSING)
states: 378,583 (5)
.abstracting: (SYNRCVD<=xCLOSING)
states: 2,246,087 (6)
.
EG iterations: 1
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-12 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.300sec
checking: AF [[AX [SYN<=SYNACK] | AX [LISTEN<=xFIN]]]
normalized: ~ [EG [~ [[~ [EX [~ [LISTEN<=xFIN]]] | ~ [EX [~ [SYN<=SYNACK]]]]]]]
abstracting: (SYN<=SYNACK)
states: 2,229,268 (6)
.abstracting: (LISTEN<=xFIN)
states: 2,400,674 (6)
........
EG iterations: 7
-> the formula is FALSE
FORMULA TCPcondis-PT-05-CTLCardinality-6 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.750sec
checking: AG [EF [[xCLOSED<=xCLOSED & CLOSEWAIT<=xFIN]]]
normalized: ~ [E [true U ~ [E [true U [xCLOSED<=xCLOSED & CLOSEWAIT<=xFIN]]]]]
abstracting: (CLOSEWAIT<=xFIN)
states: 2,542,197 (6)
abstracting: (xCLOSED<=xCLOSED)
states: 2,985,834 (6)
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-8 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.167sec
checking: AF [[[2<=xFINWAIT1 | [1<=xFINACK | 1<=xSYNRCVD]] & EF [xESTAB<=xSYNSENT]]]
normalized: ~ [EG [~ [[E [true U xESTAB<=xSYNSENT] & [2<=xFINWAIT1 | [1<=xFINACK | 1<=xSYNRCVD]]]]]]
abstracting: (1<=xSYNRCVD)
states: 1,089,212 (6)
abstracting: (1<=xFINACK)
states: 1,870,970 (6)
abstracting: (2<=xFINWAIT1)
states: 383,358 (5)
abstracting: (xESTAB<=xSYNSENT)
states: 2,395,638 (6)
.............................................................................
EG iterations: 77
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-0 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 3.362sec
checking: EG [[[xCLOSEWAIT<=SYNACK & xCLOSED<=xLASTACK] | ~ [2<=xLISTEN]]]
normalized: EG [[~ [2<=xLISTEN] | [xCLOSEWAIT<=SYNACK & xCLOSED<=xLASTACK]]]
abstracting: (xCLOSED<=xLASTACK)
states: 2,309,323 (6)
abstracting: (xCLOSEWAIT<=SYNACK)
states: 2,446,116 (6)
abstracting: (2<=xLISTEN)
states: 239,516 (5)
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-3 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.120sec
checking: [[[EG [CLOSING<=CLOSEWAIT] & xSYNRCVD<=FINWAIT2] & A [FIN<=xLISTEN U xFINWAIT2<=FIN]] | [[~ [[SYNACK<=LASTACK & 3<=FINACK]] & 2<=CLOSING] & AF [[CLOSING<=FINWAIT2 & xFIN<=SYNSENT]]]]
normalized: [[~ [EG [~ [[CLOSING<=FINWAIT2 & xFIN<=SYNSENT]]]] & [2<=CLOSING & ~ [[SYNACK<=LASTACK & 3<=FINACK]]]] | [[~ [EG [~ [xFINWAIT2<=FIN]]] & ~ [E [~ [xFINWAIT2<=FIN] U [~ [FIN<=xLISTEN] & ~ [xFINWAIT2<=FIN]]]]] & [xSYNRCVD<=FINWAIT2 & EG [CLOSING<=CLOSEWAIT]]]]
abstracting: (CLOSING<=CLOSEWAIT)
states: 1,947,339 (6)
.
EG iterations: 1
abstracting: (xSYNRCVD<=FINWAIT2)
states: 2,190,846 (6)
abstracting: (xFINWAIT2<=FIN)
states: 2,564,432 (6)
abstracting: (FIN<=xLISTEN)
states: 1,811,680 (6)
abstracting: (xFINWAIT2<=FIN)
states: 2,564,432 (6)
abstracting: (xFINWAIT2<=FIN)
states: 2,564,432 (6)
.
EG iterations: 1
abstracting: (3<=FINACK)
states: 276,119 (5)
abstracting: (SYNACK<=LASTACK)
states: 2,246,087 (6)
abstracting: (2<=CLOSING)
states: 378,583 (5)
abstracting: (xFIN<=SYNSENT)
states: 1,893,439 (6)
abstracting: (CLOSING<=FINWAIT2)
states: 2,054,175 (6)
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-1 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 1.947sec
checking: [[EG [[xCLOSEWAIT<=xESTAB | 1<=CLOSING]] & [[~ [xFINWAIT1<=xFIN] | [xSYNSENT<=xFIN & FINACK<=xCLOSING]] & [[1<=LASTACK & 1<=SYNACK] | SYN<=FINWAIT2]]] & ~ [AF [[xSYNACK<=xCLOSEWAIT & 1<=xSYNSENT]]]]
normalized: [EG [~ [[xSYNACK<=xCLOSEWAIT & 1<=xSYNSENT]]] & [[[SYN<=FINWAIT2 | [1<=LASTACK & 1<=SYNACK]] & [[xSYNSENT<=xFIN & FINACK<=xCLOSING] | ~ [xFINWAIT1<=xFIN]]] & EG [[xCLOSEWAIT<=xESTAB | 1<=CLOSING]]]]
abstracting: (1<=CLOSING)
states: 1,228,477 (6)
abstracting: (xCLOSEWAIT<=xESTAB)
states: 2,400,117 (6)
.
EG iterations: 1
abstracting: (xFINWAIT1<=xFIN)
states: 2,377,103 (6)
abstracting: (FINACK<=xCLOSING)
states: 1,718,446 (6)
abstracting: (xSYNSENT<=xFIN)
states: 2,259,175 (6)
abstracting: (1<=SYNACK)
states: 1,089,212 (6)
abstracting: (1<=LASTACK)
states: 1,228,476 (6)
abstracting: (SYN<=FINWAIT2)
states: 2,076,164 (6)
abstracting: (1<=xSYNSENT)
states: 1,171,479 (6)
abstracting: (xSYNACK<=xCLOSEWAIT)
states: 2,113,461 (6)
.
EG iterations: 1
-> the formula is TRUE
FORMULA TCPcondis-PT-05-CTLCardinality-5 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT
MC time: 0m 0.743sec
totally nodes used: 1685429 (1.7e+06)
number of garbage collections: 0
fire ops cache: hits/miss/sum: 6060497 5942999 12003496
used/not used/entry size/cache size: 7019884 60088980 16 1024MB
basic ops cache: hits/miss/sum: 1105012 1194334 2299346
used/not used/entry size/cache size: 1926253 14850963 12 192MB
unary ops cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 16777216 8 128MB
abstract ops cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 16777216 12 192MB
state nr cache: hits/miss/sum: 126240 121820 248060
used/not used/entry size/cache size: 120931 8267677 32 256MB
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 65579274
1 1433545
2 74738
3 11324
4 3593
5 2057
6 1183
7 727
8 566
9 425
>= 10 1432
Total processing time: 0m33.776sec
BK_STOP 1496683717957
--------------------
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
ptnet_zbdd.cc:255: Boundedness exception: net is not 1-bounded!
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.001sec
iterations count:3000 (93), effective:370 (11)
initing FirstDep: 0m 0.000sec
iterations count:504 (15), effective:61 (1)
iterations count:853 (26), effective:108 (3)
iterations count:1139 (35), effective:135 (4)
iterations count:82 (2), effective:11 (0)
iterations count:324 (10), effective:33 (1)
iterations count:47 (1), effective:5 (0)
iterations count:73 (2), effective:12 (0)
iterations count:1144 (35), effective:149 (4)
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_TCPcondis-PT-05"
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_TCPcondis-PT-05.tgz
mv S_TCPcondis-PT-05 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 S_TCPcondis-PT-05, 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 r151-ebro-149443454300201"
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 ;