Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2023-input.r097-tall-167814469500393.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
............................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-5348
Executing tool marcie
Input is DES-PT-05a, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r097-tall-167814469500393
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 480K
-rw-r--r-- 1 mcc users 7.7K Feb 26 15:46 CTLCardinality.txt
-rw-r--r-- 1 mcc users 86K Feb 26 15:46 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.3K Feb 26 15:45 CTLFireability.txt
-rw-r--r-- 1 mcc users 51K Feb 26 15:45 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:40 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.6K Jan 29 11:40 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.6K Feb 25 15:50 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Feb 25 15:50 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Feb 25 15:50 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Feb 25 15:50 LTLFireability.xml
-rw-r--r-- 1 mcc users 11K Feb 26 15:48 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 113K Feb 26 15:48 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 6.7K Feb 26 15:47 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 56K Feb 26 15:47 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.5K Feb 25 15:50 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.5K Feb 25 15:50 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 equiv_col
-rw-r--r-- 1 mcc users 4 Mar 5 18:22 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 iscolored
-rw-r--r-- 1 mcc users 37K Mar 5 18:22 model.pnml

--------------------
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-05a-CTLCardinality-00
FORMULA_NAME DES-PT-05a-CTLCardinality-01
FORMULA_NAME DES-PT-05a-CTLCardinality-02
FORMULA_NAME DES-PT-05a-CTLCardinality-03
FORMULA_NAME DES-PT-05a-CTLCardinality-04
FORMULA_NAME DES-PT-05a-CTLCardinality-05
FORMULA_NAME DES-PT-05a-CTLCardinality-06
FORMULA_NAME DES-PT-05a-CTLCardinality-07
FORMULA_NAME DES-PT-05a-CTLCardinality-08
FORMULA_NAME DES-PT-05a-CTLCardinality-09
FORMULA_NAME DES-PT-05a-CTLCardinality-10
FORMULA_NAME DES-PT-05a-CTLCardinality-11
FORMULA_NAME DES-PT-05a-CTLCardinality-12
FORMULA_NAME DES-PT-05a-CTLCardinality-13
FORMULA_NAME DES-PT-05a-CTLCardinality-14
FORMULA_NAME DES-PT-05a-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1678250320620

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=marcie
BK_EXAMINATION=CTLCardinality
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=3600
BK_INPUT=DES-PT-05a
Not applying reductions.
Model is PT
CTLCardinality PT
timeout --kill-after=10s --signal=SIGINT 1m for testing only

Marcie built on Linux at 2019-11-18.
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: /home/mcc/BenchKit/bin//../marcie/bin/marcie --net-file=model.pnml --mcc-file=CTLCardinality.xml --memory=6 --mcc-mode

parse successfull
net created successfully

Net: DES_PT_05a
(NrP: 135 NrTr: 92 NrArc: 457)

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

net check time: 0m 0.000sec

init dd package: 0m 2.840sec


RS generation: 0m 2.949sec


-> reachability set: #nodes 76402 (7.6e+04) #states 230,998,451,325 (11)



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

checking: EF [AG [p58<=0]]
normalized: E [true U ~ [E [true U ~ [p58<=0]]]]

abstracting: (p58<=0)
states: 148,008,740,206 (11)
-> the formula is TRUE

FORMULA DES-PT-05a-CTLCardinality-09 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m14.489sec

checking: ~ [E [AG [p41<=p10] U AG [[p34<=1 | AX [p23<=p11]]]]]
normalized: ~ [E [~ [E [true U ~ [p41<=p10]]] U ~ [E [true U ~ [[p34<=1 | ~ [EX [~ [p23<=p11]]]]]]]]]

abstracting: (p23<=p11)
states: 114,745,442,537 (11)
.abstracting: (p34<=1)
states: 230,998,451,325 (11)
abstracting: (p41<=p10)
states: 178,311,056,247 (11)
-> the formula is FALSE

FORMULA DES-PT-05a-CTLCardinality-07 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m11.091sec

checking: EF [[~ [E [EF [1<=p85] U ~ [p134<=p32]]] & EF [[p28<=p42 & 1<=p32]]]]
normalized: E [true U [E [true U [p28<=p42 & 1<=p32]] & ~ [E [E [true U 1<=p85] U ~ [p134<=p32]]]]]

abstracting: (p134<=p32)
states: 230,998,451,325 (11)
abstracting: (1<=p85)
states: 83,460,226,458 (10)
abstracting: (1<=p32)
states: 230,998,451,324 (11)
abstracting: (p28<=p42)
states: 186,298,285,231 (11)
-> the formula is TRUE

FORMULA DES-PT-05a-CTLCardinality-03 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m12.203sec

checking: [AG [p95<=p53] & A [AF [EX [AG [p59<=p118]]] U EX [~ [A [[1<=p17 | 1<=p34] U ~ [1<=p62]]]]]]
normalized: [[~ [EG [~ [EX [~ [[~ [EG [1<=p62]] & ~ [E [1<=p62 U [1<=p62 & ~ [[1<=p17 | 1<=p34]]]]]]]]]]] & ~ [E [~ [EX [~ [[~ [EG [1<=p62]] & ~ [E [1<=p62 U [1<=p62 & ~ [[1<=p17 | 1<=p34]]]]]]]]] U [EG [~ [EX [~ [E [true U ~ [p59<=p118]]]]]] & ~ [EX [~ [[~ [EG [1<=p62]] & ~ [E [1<=p62 U [1<=p62 & ~ [[1<=p17 | 1<=p34]]]]]]]]]]]]] & ~ [E [true U ~ [p95<=p53]]]]

abstracting: (p95<=p53)
states: 138,065,058,703 (11)
abstracting: (1<=p34)
states: 94,209,199,892 (10)
abstracting: (1<=p17)
states: 39,865,629,700 (10)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
.................
before gc: list nodes free: 1528995

after gc: idd nodes used:1534361, unused:62465639; list nodes free:299132006
..........
before gc: list nodes free: 1289138

after gc: idd nodes used:1894026, unused:62105974; list nodes free:299606426
..........
before gc: list nodes free: 412254

after gc: idd nodes used:2490629, unused:61509371; list nodes free:295949774
..MC time: 4m34.090sec

checking: ~ [EG [EX [[p49<=1 | [[[1<=p72 | p26<=1] & EF [p127<=p30]] & p120<=p24]]]]]
normalized: ~ [EG [EX [[p49<=1 | [p120<=p24 & [E [true U p127<=p30] & [1<=p72 | p26<=1]]]]]]]

abstracting: (p26<=1)
states: 230,998,451,325 (11)
abstracting: (1<=p72)
states: 147,538,224,866 (11)
abstracting: (p127<=p30)
states: 206,897,470,569 (11)
abstracting: (p120<=p24)
states: 217,442,278,275 (11)
abstracting: (p49<=1)
states: 230,998,451,325 (11)
...................
before gc: list nodes free: 1952263

after gc: idd nodes used:1484001, unused:62515999; list nodes free:302881401
......................
before gc: list nodes free: 71253

after gc: idd nodes used:1454854, unused:62545146; list nodes free:302965011
..............MC time: 4m13.021sec

checking: EX [[AF [EF [AG [1<=p54]]] & AX [~ [[[~ [p0<=p48] | ~ [1<=p81]] & [A [p119<=p60 U 1<=p62] & AG [1<=p14]]]]]]]
normalized: EX [[~ [EG [~ [E [true U ~ [E [true U ~ [1<=p54]]]]]]] & ~ [EX [[[~ [E [true U ~ [1<=p14]]] & [~ [EG [~ [1<=p62]]] & ~ [E [~ [1<=p62] U [~ [p119<=p60] & ~ [1<=p62]]]]]] & [~ [1<=p81] | ~ [p0<=p48]]]]]]]

abstracting: (p0<=p48)
states: 230,998,451,324 (11)
abstracting: (1<=p81)
states: 83,460,226,458 (10)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (p119<=p60)
states: 213,738,285,626 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
...............
before gc: list nodes free: 3164494

after gc: idd nodes used:1470844, unused:62529156; list nodes free:303657202
................
before gc: list nodes free: 5217161

after gc: idd nodes used:1727751, unused:62272249; list nodes free:302495963
........MC time: 3m54.028sec

checking: [AG [[AX [[[[p125<=1 | p30<=p19] & ~ [1<=p123]] & ~ [EX [p71<=p89]]]] & 1<=p44]] | ~ [AF [~ [p61<=p38]]]]
normalized: [EG [p61<=p38] | ~ [E [true U ~ [[1<=p44 & ~ [EX [~ [[~ [EX [p71<=p89]] & [~ [1<=p123] & [p125<=1 | p30<=p19]]]]]]]]]]]

abstracting: (p30<=p19)
states: 136,918,494,090 (11)
abstracting: (p125<=1)
states: 230,998,451,325 (11)
abstracting: (1<=p123)
states: 53,896,923,826 (10)
abstracting: (p71<=p89)
states: 179,343,962,437 (11)
..abstracting: (1<=p44)
states: 59,781,375,112 (10)
abstracting: (p61<=p38)
states: 167,371,491,895 (11)
.............
before gc: list nodes free: 4720436

after gc: idd nodes used:1325194, unused:62674806; list nodes free:304318186
...................
before gc: list nodes free: 272580

after gc: idd nodes used:1373167, unused:62626833; list nodes free:304109361
..............MC time: 3m36.019sec

checking: [AG [p111<=p46] & EF [[[[[AX [1<=p127] | ~ [AX [p92<=1]]] | AX [AG [1<=p34]]] & p5<=p119] & ~ [A [~ [A [1<=p46 U p35<=p53]] U AF [1<=p22]]]]]]
normalized: [E [true U [~ [[~ [EG [EG [~ [1<=p22]]]] & ~ [E [EG [~ [1<=p22]] U [[~ [EG [~ [p35<=p53]]] & ~ [E [~ [p35<=p53] U [~ [1<=p46] & ~ [p35<=p53]]]]] & EG [~ [1<=p22]]]]]]] & [p5<=p119 & [~ [EX [E [true U ~ [1<=p34]]]] | [EX [~ [p92<=1]] | ~ [EX [~ [1<=p127]]]]]]]] & ~ [E [true U ~ [p111<=p46]]]]

abstracting: (p111<=p46)
states: 230,425,542,273 (11)
abstracting: (1<=p127)
states: 55,080,246,711 (10)
.abstracting: (p92<=1)
states: 230,998,451,325 (11)
.abstracting: (1<=p34)
states: 94,209,199,892 (10)
.abstracting: (p5<=p119)
states: 197,017,194,002 (11)
abstracting: (1<=p22)
states: 99,852,643,016 (10)
...............
before gc: list nodes free: 3118648

after gc: idd nodes used:1395543, unused:62604457; list nodes free:304018719
.............................
before gc: list nodes free: 4008534

after gc: idd nodes used:1283565, unused:62716435; list nodes free:304521195
MC time: 3m27.371sec

checking: [E [A [~ [A [EG [p109<=1] U [p2<=p84 & 1<=p26]]] U 1<=p23] U ~ [p32<=0]] & AF [[EX [p125<=p118] & [[[[A [p9<=1 U p57<=1] | ~ [p93<=1]] | 1<=p81] | ~ [1<=p57]] & 1<=p100]]]]
normalized: [~ [EG [~ [[[1<=p100 & [~ [1<=p57] | [1<=p81 | [~ [p93<=1] | [~ [EG [~ [p57<=1]]] & ~ [E [~ [p57<=1] U [~ [p9<=1] & ~ [p57<=1]]]]]]]]] & EX [p125<=p118]]]]] & E [[~ [EG [~ [1<=p23]]] & ~ [E [~ [1<=p23] U [[~ [EG [~ [[p2<=p84 & 1<=p26]]]] & ~ [E [~ [[p2<=p84 & 1<=p26]] U [~ [EG [p109<=1]] & ~ [[p2<=p84 & 1<=p26]]]]]] & ~ [1<=p23]]]]] U ~ [p32<=0]]]

abstracting: (p32<=0)
states: 1
abstracting: (1<=p23)
states: 116,253,030,816 (11)
abstracting: (1<=p26)
states: 76,007,311,286 (10)
abstracting: (p2<=p84)
states: 222,597,768,333 (11)
abstracting: (p109<=1)
states: 230,998,451,325 (11)

EG iterations: 0
abstracting: (1<=p26)
states: 76,007,311,286 (10)
abstracting: (p2<=p84)
states: 222,597,768,333 (11)
abstracting: (1<=p26)
states: 76,007,311,286 (10)
abstracting: (p2<=p84)
states: 222,597,768,333 (11)
..........................
before gc: list nodes free: 3891779

after gc: idd nodes used:1495127, unused:62504873; list nodes free:303232443
.............MC time: 3m 3.035sec

checking: EG [EF [[[~ [1<=p125] | [[1<=p13 & [1<=p55 | p103<=1]] | p48<=p125]] & [~ [[~ [p111<=p23] | [p74<=p133 & p100<=0]]] | [[p40<=0 & AF [p121<=p21]] | p61<=0]]]]]
normalized: EG [E [true U [[[p61<=0 | [p40<=0 & ~ [EG [~ [p121<=p21]]]]] | ~ [[[p74<=p133 & p100<=0] | ~ [p111<=p23]]]] & [[p48<=p125 | [1<=p13 & [1<=p55 | p103<=1]]] | ~ [1<=p125]]]]]

abstracting: (1<=p125)
states: 37,344,743,829 (10)
abstracting: (p103<=1)
states: 230,998,451,325 (11)
abstracting: (1<=p55)
states: 153,192,119,290 (11)
abstracting: (1<=p13)
states: 55,176,523,300 (10)
abstracting: (p48<=p125)
states: 131,029,371,805 (11)
abstracting: (p111<=p23)
states: 230,351,088,462 (11)
abstracting: (p100<=0)
states: 154,658,764,698 (11)
abstracting: (p74<=p133)
states: 168,432,166,731 (11)
abstracting: (p121<=p21)
states: 225,977,402,925 (11)
...........................................
EG iterations: 43
abstracting: (p40<=0)
states: 194,172,896,871 (11)
abstracting: (p61<=0)
states: 147,538,224,867 (11)
....................
EG iterations: 20
-> the formula is TRUE

FORMULA DES-PT-05a-CTLCardinality-02 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m43.618sec

checking: AX [[EF [AX [[~ [p49<=0] | p92<=0]]] & [[~ [[E [p39<=1 U p101<=0] & p74<=p68]] & A [~ [[1<=p64 & p28<=p59]] U [AG [1<=p102] & EX [p56<=p72]]]] | AG [[[~ [p59<=1] | EF [p74<=p127]] | A [1<=p106 U p30<=0]]]]]]
normalized: ~ [EX [~ [[[~ [E [true U ~ [[[~ [EG [~ [p30<=0]]] & ~ [E [~ [p30<=0] U [~ [1<=p106] & ~ [p30<=0]]]]] | [E [true U p74<=p127] | ~ [p59<=1]]]]]] | [[~ [EG [~ [[EX [p56<=p72] & ~ [E [true U ~ [1<=p102]]]]]]] & ~ [E [~ [[EX [p56<=p72] & ~ [E [true U ~ [1<=p102]]]]] U [[1<=p64 & p28<=p59] & ~ [[EX [p56<=p72] & ~ [E [true U ~ [1<=p102]]]]]]]]] & ~ [[p74<=p68 & E [p39<=1 U p101<=0]]]]] & E [true U ~ [EX [~ [[p92<=0 | ~ [p49<=0]]]]]]]]]]

abstracting: (p49<=0)
states: 119,413,622,978 (11)
abstracting: (p92<=0)
states: 154,658,764,698 (11)
.abstracting: (p101<=0)
states: 90,812,996,624 (10)
abstracting: (p39<=1)
states: 230,998,451,325 (11)
abstracting: (p74<=p68)
states: 179,343,962,437 (11)
abstracting: (1<=p102)
states: 76,339,686,627 (10)
abstracting: (p56<=p72)
states: 152,102,907,154 (11)
.abstracting: (p28<=p59)
states: 199,538,585,747 (11)
abstracting: (1<=p64)
states: 147,538,224,866 (11)
abstracting: (1<=p102)
states: 76,339,686,627 (10)
abstracting: (p56<=p72)
states: 152,102,907,154 (11)
.abstracting: (1<=p102)
states: 76,339,686,627 (10)
abstracting: (p56<=p72)
states: 152,102,907,154 (11)
.
EG iterations: 0
abstracting: (p59<=1)
states: 230,998,451,325 (11)
abstracting: (p74<=p127)
states: 118,348,320,778 (11)
abstracting: (p30<=0)
states: 93,561,884,092 (10)
abstracting: (1<=p106)
states: 76,339,686,627 (10)
abstracting: (p30<=0)
states: 93,561,884,092 (10)
abstracting: (p30<=0)
states: 93,561,884,092 (10)
......
before gc: list nodes free: 5589549

after gc: idd nodes used:1815310, unused:62184690; list nodes free:302129279
......................
before gc: list nodes free: 4819074

after gc: idd nodes used:1926700, unused:62073300; list nodes free:301620723
MC time: 3m 0.193sec

checking: AG [[AF [[EF [[p34<=p11 & p70<=p19]] | E [[p119<=p82 | p106<=0] U [p29<=0 | p107<=p14]]]] & [A [[EX [1<=p2] & [AF [p73<=p15] | 1<=p47]] U ~ [AG [p57<=p61]]] | 1<=p8]]]
normalized: ~ [E [true U ~ [[[1<=p8 | [~ [EG [~ [E [true U ~ [p57<=p61]]]]] & ~ [E [~ [E [true U ~ [p57<=p61]]] U [~ [[[1<=p47 | ~ [EG [~ [p73<=p15]]]] & EX [1<=p2]]] & ~ [E [true U ~ [p57<=p61]]]]]]]] & ~ [EG [~ [[E [[p119<=p82 | p106<=0] U [p29<=0 | p107<=p14]] | E [true U [p34<=p11 & p70<=p19]]]]]]]]]]

abstracting: (p70<=p19)
states: 127,343,245,190 (11)
abstracting: (p34<=p11)
states: 136,789,251,433 (11)
abstracting: (p107<=p14)
states: 117,895,125,022 (11)
abstracting: (p29<=0)
states: 66,841,812,112 (10)
abstracting: (p106<=0)
states: 154,658,764,698 (11)
abstracting: (p119<=p82)
states: 213,738,285,626 (11)
.
EG iterations: 1
abstracting: (p57<=p61)
states: 222,155,691,981 (11)
abstracting: (1<=p2)
states: 24,376,824,884 (10)
.abstracting: (p73<=p15)
states: 153,991,033,161 (11)
.......................
before gc: list nodes free: 6667214

after gc: idd nodes used:2788056, unused:61211944; list nodes free:297273151
.MC time: 2m44.327sec

checking: AF [~ [[E [[E [1<=p21 U p7<=0] | AX [1<=p78]] U [~ [AG [p35<=p102]] & EG [p78<=1]]] | [[[EF [1<=p92] | [p18<=0 & [p104<=p131 | 1<=p85]]] & AX [A [p67<=p60 U p28<=p63]]] & p58<=p77]]]]
normalized: ~ [EG [[E [[~ [EX [~ [1<=p78]]] | E [1<=p21 U p7<=0]] U [EG [p78<=1] & E [true U ~ [p35<=p102]]]] | [p58<=p77 & [~ [EX [~ [[~ [EG [~ [p28<=p63]]] & ~ [E [~ [p28<=p63] U [~ [p28<=p63] & ~ [p67<=p60]]]]]]]] & [[p18<=0 & [p104<=p131 | 1<=p85]] | E [true U 1<=p92]]]]]]]

abstracting: (1<=p92)
states: 76,339,686,627 (10)
abstracting: (1<=p85)
states: 83,460,226,458 (10)
abstracting: (p104<=p131)
states: 165,351,561,009 (11)
abstracting: (p18<=0)
states: 164,160,205,640 (11)
abstracting: (p67<=p60)
states: 199,192,713,755 (11)
abstracting: (p28<=p63)
states: 188,041,562,887 (11)
abstracting: (p28<=p63)
states: 188,041,562,887 (11)
abstracting: (p28<=p63)
states: 188,041,562,887 (11)
....................
before gc: list nodes free: 6742191

after gc: idd nodes used:2462178, unused:61537822; list nodes free:299188160
....MC time: 2m31.044sec

checking: AX [[[AG [[[[p45<=p87 | p13<=p10] | [p111<=p129 & p100<=p33]] | 1<=p89]] | ~ [AF [[[p129<=p64 | p30<=0] & [1<=p118 & p55<=p64]]]]] | p112<=p19]]
normalized: ~ [EX [~ [[p112<=p19 | [EG [~ [[[1<=p118 & p55<=p64] & [p129<=p64 | p30<=0]]]] | ~ [E [true U ~ [[1<=p89 | [[p111<=p129 & p100<=p33] | [p45<=p87 | p13<=p10]]]]]]]]]]]

abstracting: (p13<=p10)
states: 176,198,428,366 (11)
abstracting: (p45<=p87)
states: 193,698,545,611 (11)
abstracting: (p100<=p33)
states: 199,970,047,653 (11)
abstracting: (p111<=p129)
states: 229,766,863,338 (11)
abstracting: (1<=p89)
states: 83,460,226,458 (10)
abstracting: (p30<=0)
states: 93,561,884,092 (10)
abstracting: (p129<=p64)
states: 221,777,594,917 (11)
abstracting: (p55<=p64)
states: 174,715,282,043 (11)
abstracting: (1<=p118)
states: 69,064,647,810 (10)
.................
before gc: list nodes free: 3349611

after gc: idd nodes used:2739701, unused:61260299; list nodes free:297591673
...MC time: 2m18.059sec

checking: E [E [~ [[~ [[1<=p45 | p66<=p123]] | A [1<=p114 U p104<=p50]]] U [[[EX [p64<=p24] | AF [p57<=1]] & 1<=p42] & [~ [[EG [1<=p13] | EG [1<=p52]]] | EX [EX [1<=p23]]]]] U ~ [A [[A [p83<=p133 U EF [1<=p125]] & AF [[p43<=p46 | 1<=p5]]] U EG [p86<=p9]]]]
normalized: E [E [~ [[[~ [EG [~ [p104<=p50]]] & ~ [E [~ [p104<=p50] U [~ [1<=p114] & ~ [p104<=p50]]]]] | ~ [[1<=p45 | p66<=p123]]]] U [[EX [EX [1<=p23]] | ~ [[EG [1<=p52] | EG [1<=p13]]]] & [1<=p42 & [~ [EG [~ [p57<=1]]] | EX [p64<=p24]]]]] U ~ [[~ [EG [~ [EG [p86<=p9]]]] & ~ [E [~ [EG [p86<=p9]] U [~ [[~ [EG [~ [[p43<=p46 | 1<=p5]]]] & [~ [EG [~ [E [true U 1<=p125]]]] & ~ [E [~ [E [true U 1<=p125]] U [~ [p83<=p133] & ~ [E [true U 1<=p125]]]]]]]] & ~ [EG [p86<=p9]]]]]]]]

abstracting: (p86<=p9)
states: 94,734,366,229 (10)
...................
before gc: list nodes free: 4174979

after gc: idd nodes used:2901090, unused:61098910; list nodes free:297137254
.MC time: 2m 7.382sec

checking: EF [[[[1<=p111 & [AX [[1<=p27 & 1<=p71]] | p60<=p62]] | [[EX [AG [p24<=p38]] | EF [~ [p57<=p67]]] | [[[p122<=1 | ~ [p0<=0]] & AX [p93<=0]] | A [[p30<=0 | 1<=p123] U p48<=p129]]]] & [1<=p38 | AX [[A [1<=p46 U 1<=p27] & [[p6<=p42 | p45<=p19] & 1<=p3]]]]]]
normalized: E [true U [[1<=p38 | ~ [EX [~ [[[1<=p3 & [p6<=p42 | p45<=p19]] & [~ [EG [~ [1<=p27]]] & ~ [E [~ [1<=p27] U [~ [1<=p46] & ~ [1<=p27]]]]]]]]]] & [[[[~ [EG [~ [p48<=p129]]] & ~ [E [~ [p48<=p129] U [~ [[p30<=0 | 1<=p123]] & ~ [p48<=p129]]]]] | [~ [EX [~ [p93<=0]]] & [p122<=1 | ~ [p0<=0]]]] | [E [true U ~ [p57<=p67]] | EX [~ [E [true U ~ [p24<=p38]]]]]] | [1<=p111 & [p60<=p62 | ~ [EX [~ [[1<=p27 & 1<=p71]]]]]]]]]

abstracting: (1<=p71)
states: 83,460,226,458 (10)
abstracting: (1<=p27)
states: 78,983,828,748 (10)
.abstracting: (p60<=p62)
states: 179,343,962,437 (11)
abstracting: (1<=p111)
states: 1,303,470,493 (9)
abstracting: (p24<=p38)
states: 143,625,201,123 (11)
.abstracting: (p57<=p67)
states: 222,155,691,981 (11)
abstracting: (p0<=0)
states: 230,998,451,324 (11)
abstracting: (p122<=1)
states: 230,998,451,325 (11)
abstracting: (p93<=0)
states: 90,812,996,624 (10)
.abstracting: (p48<=p129)
states: 125,011,863,553 (11)
abstracting: (1<=p123)
states: 53,896,923,826 (10)
abstracting: (p30<=0)
states: 93,561,884,092 (10)
abstracting: (p48<=p129)
states: 125,011,863,553 (11)
abstracting: (p48<=p129)
states: 125,011,863,553 (11)
.........................
before gc: list nodes free: 7003543

after gc: idd nodes used:2696490, unused:61303510; list nodes free:298140533
MC time: 2m 1.325sec

checking: [AG [p95<=p53] & A [AF [EX [AG [p59<=p118]]] U EX [~ [A [[1<=p17 | 1<=p34] U ~ [1<=p62]]]]]]
normalized: [[~ [EG [~ [EX [~ [[~ [EG [1<=p62]] & ~ [E [1<=p62 U [1<=p62 & ~ [[1<=p17 | 1<=p34]]]]]]]]]]] & ~ [E [~ [EX [~ [[~ [EG [1<=p62]] & ~ [E [1<=p62 U [1<=p62 & ~ [[1<=p17 | 1<=p34]]]]]]]]] U [EG [~ [EX [~ [E [true U ~ [p59<=p118]]]]]] & ~ [EX [~ [[~ [EG [1<=p62]] & ~ [E [1<=p62 U [1<=p62 & ~ [[1<=p17 | 1<=p34]]]]]]]]]]]]] & ~ [E [true U ~ [p95<=p53]]]]

abstracting: (p95<=p53)
states: 138,065,058,703 (11)
abstracting: (1<=p34)
states: 94,209,199,892 (10)
abstracting: (1<=p17)
states: 39,865,629,700 (10)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
...................
before gc: list nodes free: 3983225

after gc: idd nodes used:3272179, unused:60727821; list nodes free:295478586
..........
before gc: list nodes free: 3293156

after gc: idd nodes used:3344824, unused:60655176; list nodes free:295140879
..........
before gc: list nodes free: 4210943

after gc: idd nodes used:3283317, unused:60716683; list nodes free:295422343
.................
before gc: list nodes free: 1779650

after gc: idd nodes used:2725005, unused:61274995; list nodes free:297980218
.........................................................
EG iterations: 113
.abstracting: (p59<=p118)
states: 118,062,251,807 (11)
..........
before gc: list nodes free: 2271787

after gc: idd nodes used:2784446, unused:61215554; list nodes free:297395165
...................
before gc: list nodes free: 4267130

after gc: idd nodes used:2784952, unused:61215048; list nodes free:297689578
..........................................
EG iterations: 70
abstracting: (1<=p34)
states: 94,209,199,892 (10)
abstracting: (1<=p17)
states: 39,865,629,700 (10)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
abstracting: (1<=p62)
states: 147,538,224,866 (11)
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393916 kB
MemFree: 5894888 kB
After kill :
MemTotal: 16393916 kB
MemFree: 16181540 kB

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.000sec


iterations count:29402 (319), effective:3633 (39)

initing FirstDep: 0m 0.000sec


iterations count:2030 (22), effective:207 (2)

iterations count:7445 (80), effective:930 (10)

iterations count:5625 (61), effective:656 (7)

iterations count:92 (1), effective:0 (0)

iterations count:4922 (53), effective:559 (6)

iterations count:1172 (12), effective:127 (1)

iterations count:92 (1), effective:0 (0)

iterations count:7394 (80), effective:807 (8)

iterations count:2078 (22), effective:151 (1)

net_ddint.h:600: Timeout: after 273 sec


iterations count:425 (4), effective:46 (0)

net_ddint.h:600: Timeout: after 252 sec


iterations count:438 (4), effective:35 (0)

net_ddint.h:600: Timeout: after 233 sec


iterations count:297 (3), effective:31 (0)

net_ddint.h:600: Timeout: after 215 sec


iterations count:5293 (57), effective:569 (6)

iterations count:1643 (17), effective:122 (1)

net_ddint.h:600: Timeout: after 198 sec


net_ddint.h:600: Timeout: after 182 sec


iterations count:456 (4), effective:36 (0)

iterations count:106 (1), effective:3 (0)

iterations count:178 (1), effective:15 (0)

iterations count:103 (1), effective:2 (0)

iterations count:103 (1), effective:2 (0)

iterations count:1100 (11), effective:100 (1)

iterations count:103 (1), effective:2 (0)

iterations count:3036 (33), effective:253 (2)

iterations count:103 (1), effective:2 (0)

net_ddint.h:600: Timeout: after 178 sec


iterations count:3163 (34), effective:279 (3)

iterations count:178 (1), effective:15 (0)

iterations count:2523 (27), effective:207 (2)

net_ddint.h:600: Timeout: after 163 sec


iterations count:5114 (55), effective:576 (6)

iterations count:774 (8), effective:52 (0)

net_ddint.h:600: Timeout: after 150 sec


iterations count:9459 (102), effective:1091 (11)

net_ddint.h:600: Timeout: after 137 sec


net_ddint.h:600: Timeout: after 126 sec


iterations count:3963 (43), effective:441 (4)

iterations count:2523 (27), effective:207 (2)

iterations count:92 (1), effective:0 (0)

net_ddint.h:600: Timeout: after 115 sec


iterations count:7394 (80), effective:807 (8)

iterations count:2078 (22), effective:151 (1)

iterations count:1919 (20), effective:161 (1)

iterations count:2078 (22), effective:151 (1)

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-05a"
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"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# 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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-5348"
echo " Executing tool marcie"
echo " Input is DES-PT-05a, 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 r097-tall-167814469500393"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/DES-PT-05a.tgz
mv DES-PT-05a execution
cd execution
if [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "UpperBounds" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] || [ "CTLCardinality" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

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
elif [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLCardinality"
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 ;