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 CircularTrains-PT-384, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r001-csrt-149436061700624
=====================================================================

--------------------
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 CircularTrains-PT-384-CTLCardinality-0
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-1
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-10
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-11
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-12
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-13
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-14
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-15
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-2
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-3
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-4
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-5
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-6
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-7
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-8
FORMULA_NAME CircularTrains-PT-384-CTLCardinality-9

=== Now, execution of the tool begins

BK_START 1494466307724

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: CircularTrains_PT_384
(NrP: 768 NrTr: 384 NrArc: 1536)

parse formulas
formulas created successfully
place and transition orderings generation:0m 0.043sec

net check time: 0m 0.000sec

init dd package: 0m 1.315sec


RS generation: 0m 0.013sec


-> last computed set: #nodes 384 (3.8e+02) #states 1


parse successfull
net created successfully

Net: CircularTrains_PT_384
(NrP: 768 NrTr: 384 NrArc: 1536)

parse formulas
formulas created successfully
place and transition orderings generation:0m 0.042sec

net check time: 0m 0.000sec

init dd package: 0m 4.248sec


before gc: list nodes free: 1648174

after gc: idd nodes used:182206, unused:63817794; list nodes free:298930020

before gc: list nodes free: 1216307

after gc: idd nodes used:145676, unused:63854324; list nodes free:299142874

before gc: list nodes free: 1249569

after gc: idd nodes used:233718, unused:63766282; list nodes free:298749036

RS generation: 27m 4.753sec


-> reachability set: #nodes 196619 (2.0e+05) #states 16,376,641,351,227,849,741,077,397,217,895,636,582,218,158,650,060,650,984,502,471,241,967,517,991,687,943,434,910,035 (88)



starting MCC model checker
--------------------------

checking: AF [AF [~ [1<=Section_384]]]
normalized: ~ [EG [EG [1<=Section_384]]]

abstracting: (1<=Section_384)
states: 6,544,227,931,657,292,266,056,053,233,750,854,887,811,497,205,473,717,866,476,468,557,933,830,522,871,672,773,083,216 (87)
......................................................................................................
before gc: list nodes free: 1013398

after gc: idd nodes used:320949, unused:63679051; list nodes free:298342630
.MC time: 2m 4.123sec

checking: ~ [EG [EF [2<=Section_284]]]
normalized: ~ [EG [E [true U 2<=Section_284]]]

abstracting: (2<=Section_284)
states: 0
.
EG iterations: 1
-> the formula is TRUE

FORMULA CircularTrains-PT-384-CTLCardinality-11 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.026sec

checking: AG [EF [~ [F378<=Section_166]]]
normalized: ~ [E [true U ~ [E [true U ~ [F378<=Section_166]]]]]

abstracting: (F378<=Section_166)
states: 11,146,386,631,797,675,813,361,831,422,207,325,787,057,490,543,896,417,640,321,181,331,733,577,941,228,285,649,332,186 (88)
-> the formula is TRUE

FORMULA CircularTrains-PT-384-CTLCardinality-8 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 1m27.029sec

checking: ~ [EF [AX [F355<=F126]]]
normalized: ~ [E [true U ~ [EX [~ [F355<=F126]]]]]

abstracting: (F355<=F126)
states: 12,434,721,714,546,494,726,055,934,903,708,004,304,265,671,352,132,197,417,616,935,298,867,846,574,451,898,472,393,934 (88)

before gc: list nodes free: 971060

after gc: idd nodes used:837107, unused:63162893; list nodes free:295921568
.MC time: 2m 6.028sec

checking: [F378<=F138 & EF [EG [2<=Section_20]]]
normalized: [F378<=F138 & E [true U EG [2<=Section_20]]]

abstracting: (2<=Section_20)
states: 0
.
EG iterations: 1
abstracting: (F378<=F138)
states: 12,434,721,714,546,494,726,055,934,903,708,004,304,265,671,352,132,197,417,616,935,298,867,846,574,451,898,472,393,934 (88)
-> the formula is FALSE

FORMULA CircularTrains-PT-384-CTLCardinality-1 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.800sec

checking: E [~ [[3<=Section_295 | 3<=Section_291]] U AX [1<=F67]]
normalized: E [~ [[3<=Section_295 | 3<=Section_291]] U ~ [EX [~ [1<=F67]]]]

abstracting: (1<=F67)
states: 6,544,227,931,657,292,266,056,053,233,750,854,887,811,497,205,473,717,866,476,468,557,933,830,522,871,672,773,083,216 (87)
.abstracting: (3<=Section_291)
states: 0
abstracting: (3<=Section_295)
states: 0

before gc: list nodes free: 1618180

after gc: idd nodes used:1144515, unused:62855485; list nodes free:294513652
MC time: 2m 6.123sec

checking: EX [[~ [F349<=F49] & EG [1<=Section_318]]]
normalized: EX [[~ [F349<=F49] & EG [1<=Section_318]]]

abstracting: (1<=Section_318)
states: 6,544,227,931,657,292,266,056,053,233,750,854,887,811,497,205,473,717,866,476,468,557,933,830,522,871,672,773,083,216 (87)
......................................................................................................................................
before gc: list nodes free: 936048

after gc: idd nodes used:1032285, unused:62967715; list nodes free:295021962
.MC time: 1m56.138sec

checking: A [AX [2<=F114] U AG [F99<=Section_300]]
normalized: [~ [E [E [true U ~ [F99<=Section_300]] U [EX [~ [2<=F114]] & E [true U ~ [F99<=Section_300]]]]] & ~ [EG [E [true U ~ [F99<=Section_300]]]]]

abstracting: (F99<=Section_300)
states: 12,460,359,844,024,794,151,702,318,860,269,869,879,708,319,643,205,902,162,616,359,979,433,468,413,640,300,636,837,553 (88)
MC time: 1m47.101sec

checking: AF [AX [[Section_244<=F54 & F70<=F90]]]
normalized: ~ [EG [EX [~ [[Section_244<=F54 & F70<=F90]]]]]

abstracting: (F70<=F90)
states: 12,434,721,714,546,494,726,055,934,903,708,004,304,265,671,352,132,197,417,616,935,298,867,846,574,451,898,472,393,934 (88)
abstracting: (Section_244<=F54)
states: 14,402,429,075,541,702,870,452,593,905,564,253,868,273,823,510,256,920,255,248,115,763,567,551,518,155,360,533,671,799 (88)

before gc: list nodes free: 940940

after gc: idd nodes used:2075367, unused:61924633; list nodes free:290151948
.MC time: 1m39.288sec

checking: AX [AX [[Section_340<=F206 | Section_244<=Section_11]]]
normalized: ~ [EX [EX [~ [[Section_340<=F206 | Section_244<=Section_11]]]]]

abstracting: (Section_244<=Section_11)
states: 14,402,429,075,541,702,870,452,593,905,564,253,868,273,823,510,256,920,255,248,115,763,567,551,518,155,360,533,671,799 (88)
abstracting: (Section_340<=F206)
states: 15,854,165,086,093,040,928,627,184,012,022,017,542,640,480,929,664,548,786,609,809,315,349,465,681,157,858,616,449,662 (88)

before gc: list nodes free: 833313

after gc: idd nodes used:2032599, unused:61967401; list nodes free:290361516
.MC time: 1m32.441sec

checking: EG [[AF [F31<=F22] | EX [F261<=Section_150]]]
normalized: EG [[~ [EG [~ [F31<=F22]]] | EX [F261<=Section_150]]]

abstracting: (F261<=Section_150)
states: 12,460,359,844,024,794,151,702,318,860,269,869,879,708,319,643,205,902,162,616,359,979,433,468,413,640,300,636,837,553 (88)

before gc: list nodes free: 1150507

after gc: idd nodes used:2034819, unused:61965181; list nodes free:290355596
.abstracting: (F31<=F22)
states: 12,434,721,714,546,494,726,055,934,903,708,004,304,265,671,352,132,197,417,616,935,298,867,846,574,451,898,472,393,934 (88)
MC time: 1m24.126sec

checking: [[~ [3<=Section_318] & EG [[2<=F224 | Section_244<=F311]]] & ~ [~ [AF [2<=F243]]]]
normalized: [~ [EG [~ [2<=F243]]] & [~ [3<=Section_318] & EG [[2<=F224 | Section_244<=F311]]]]

abstracting: (Section_244<=F311)
states: 15,854,165,086,093,040,928,627,184,012,022,017,542,640,480,929,664,548,786,609,809,315,349,465,681,157,858,616,449,662 (88)
abstracting: (2<=F224)
states: 5,890,493,782,889,202,459,999,881,669,957,149,416,454,174,146,658,479,551,140,466,740,934,016,051,580,225,699,310,718 (87)

before gc: list nodes free: 784877

after gc: idd nodes used:2346275, unused:61653725; list nodes free:288900959
.
EG iterations: 1
abstracting: (3<=Section_318)
states: 0
abstracting: (2<=F243)
states: 0

EG iterations: 0
-> the formula is FALSE

FORMULA CircularTrains-PT-384-CTLCardinality-7 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 1m 8.050sec

checking: ~ [AF [[3<=Section_19 & [F14<=F55 | F33<=Section_214]]]]
normalized: EG [~ [[3<=Section_19 & [F14<=F55 | F33<=Section_214]]]]

abstracting: (F33<=Section_214)
states: 11,146,386,631,797,675,813,361,831,422,207,325,787,057,490,543,896,417,640,321,181,331,733,577,941,228,285,649,332,186 (88)
abstracting: (F14<=F55)
states: 5,757,919,350,825,046,944,975,748,617,147,594,163,876,102,358,773,154,893,782,967,724,288,498,825,047,611,231,607,845 (87)
abstracting: (3<=Section_19)
states: 0

EG iterations: 0
-> the formula is TRUE

FORMULA CircularTrains-PT-384-CTLCardinality-9 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 1.573sec

checking: AG [[[Section_45<=F162 & 3<=Section_342] | AF [Section_3<=Section_185]]]
normalized: ~ [E [true U ~ [[~ [EG [~ [Section_3<=Section_185]]] | [Section_45<=F162 & 3<=Section_342]]]]]

abstracting: (3<=Section_342)
states: 0
abstracting: (Section_45<=F162)
states: 12,460,359,844,024,794,151,702,318,860,269,869,879,708,319,643,205,902,162,616,359,979,433,468,413,640,300,636,837,553 (88)
abstracting: (Section_3<=Section_185)
states: 12,434,721,714,546,494,726,055,934,903,708,004,304,265,671,352,132,197,417,616,935,298,867,846,574,451,898,472,393,934 (88)

before gc: list nodes free: 768788

after gc: idd nodes used:3228914, unused:60771086; list nodes free:284772329
.MC time: 1m26.058sec

checking: A [Section_119<=Section_78 U [[1<=Section_112 | 3<=Section_372] & ~ [1<=Section_261]]]
normalized: [~ [E [~ [[[1<=Section_112 | 3<=Section_372] & ~ [1<=Section_261]]] U [~ [[[1<=Section_112 | 3<=Section_372] & ~ [1<=Section_261]]] & ~ [Section_119<=Section_78]]]] & ~ [EG [~ [[[1<=Section_112 | 3<=Section_372] & ~ [1<=Section_261]]]]]]

abstracting: (1<=Section_261)
states: 6,544,227,931,657,292,266,056,053,233,750,854,887,811,497,205,473,717,866,476,468,557,933,830,522,871,672,773,083,216 (87)
abstracting: (3<=Section_372)
states: 0
abstracting: (1<=Section_112)
states: 3,288,185,487,913,265,208,965,290,750,393,926,806,595,164,239,113,215,251,549,534,126,099,856,945,944,597,888,743,603 (87)

before gc: list nodes free: 900828

after gc: idd nodes used:3497235, unused:60502765; list nodes free:283514022
MC time: 1m18.041sec

checking: A [[[Section_373<=Section_107 & Section_354<=Section_277] | [F326<=F73 | 1<=Section_253]] U AX [1<=Section_217]]
normalized: [~ [E [EX [~ [1<=Section_217]] U [~ [[[F326<=F73 | 1<=Section_253] | [Section_373<=Section_107 & Section_354<=Section_277]]] & EX [~ [1<=Section_217]]]]] & ~ [EG [EX [~ [1<=Section_217]]]]]

abstracting: (1<=Section_217)
states: 3,288,185,487,913,265,208,965,290,750,393,926,806,595,164,239,113,215,251,549,534,126,099,856,945,944,597,888,743,603 (87)
.
before gc: list nodes free: 720769

after gc: idd nodes used:3294704, unused:60705296; list nodes free:284468285

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

zbdd.cc:1122: 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.002sec

217201
iterations count:122624 (319), effective:24576 (64)

initing FirstDep: 0m 0.002sec


net_ddint.h:596: Timeout: after 123 sec


iterations count:1721 (4), effective:193 (0)

sat_reach.icc:155: Timeout: after 125 sec


sat_reach.icc:155: Timeout: after 125 sec


net_ddint.h:596: Timeout: after 115 sec


sat_reach.icc:155: Timeout: after 106 sec


net_ddint.h:596: Timeout: after 98 sec


net_ddint.h:596: Timeout: after 91 sec


net_ddint.h:596: Timeout: after 83 sec


net_ddint.h:596: Timeout: after 85 sec


net_ddint.h:596: Timeout: after 77 sec


net_ddint.h:596: Timeout: after 70 sec

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="CircularTrains-PT-384"
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/CircularTrains-PT-384.tgz
mv CircularTrains-PT-384 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 CircularTrains-PT-384, 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 r001-csrt-149436061700624"
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 '' CTLCardinality.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 ;