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.r193-smll-167840340600433.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 HirschbergSinclair-PT-10, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r193-smll-167840340600433
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 624K
-rw-r--r-- 1 mcc users 8.1K Feb 26 02:16 CTLCardinality.txt
-rw-r--r-- 1 mcc users 60K Feb 26 02:16 CTLCardinality.xml
-rw-r--r-- 1 mcc users 8.5K Feb 26 02:15 CTLFireability.txt
-rw-r--r-- 1 mcc users 57K Feb 26 02:15 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.8K Feb 25 16:14 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Feb 25 16:14 LTLCardinality.xml
-rw-r--r-- 1 mcc users 3.4K Feb 25 16:15 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K Feb 25 16:15 LTLFireability.xml
-rw-r--r-- 1 mcc users 21K Feb 26 02:17 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 164K Feb 26 02:17 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 11K Feb 26 02:16 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 59K Feb 26 02:16 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.0K Feb 25 16:15 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.1K Feb 25 16:15 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 equiv_col
-rw-r--r-- 1 mcc users 3 Mar 5 18:22 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 iscolored
-rw-r--r-- 1 mcc users 136K 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 HirschbergSinclair-PT-10-CTLCardinality-00
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-01
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-02
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-03
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-04
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-05
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-06
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-07
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-08
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-09
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-10
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-11
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-12
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-13
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-14
FORMULA_NAME HirschbergSinclair-PT-10-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1679904835325

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=HirschbergSinclair-PT-10
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: HirschbergSinclair_PT_10
(NrP: 260 NrTr: 236 NrArc: 721)

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

net check time: 0m 0.000sec

init dd package: 0m 3.457sec


RS generation: 0m 6.176sec


-> reachability set: #nodes 76412 (7.6e+04) #states 6,959,447,840,118 (12)



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

checking: AX [AG [EF [1<=rcv_right_election_8_0_1_7]]]
normalized: ~ [EX [E [true U ~ [E [true U 1<=rcv_right_election_8_0_1_7]]]]]

abstracting: (1<=rcv_right_election_8_0_1_7)
states: 888,308,486,623 (11)
.-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-14 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m10.612sec

checking: AX [[election_10_3_7_to_left_4<=1 & EF [1<=election_10_3_6_to_left_5]]]
normalized: ~ [EX [~ [[election_10_3_7_to_left_4<=1 & E [true U 1<=election_10_3_6_to_left_5]]]]]

abstracting: (1<=election_10_3_6_to_left_5)
states: 150,583,713,128 (11)
abstracting: (election_10_3_7_to_left_4<=1)
states: 6,959,447,840,118 (12)
.-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-02 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 2.532sec

checking: EG [AG [AG [EF [~ [rcv_right_election_10_4_5_5<=rcv_left_election_4_0_1_5]]]]]
normalized: EG [~ [E [true U E [true U ~ [E [true U ~ [rcv_right_election_10_4_5_5<=rcv_left_election_4_0_1_5]]]]]]]

abstracting: (rcv_right_election_10_4_5_5<=rcv_left_election_4_0_1_5)
states: 6,911,255,034,070 (12)
.
EG iterations: 1
-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-13 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 7.926sec

checking: ~ [E [1<=rcv_right_reply_10_1_1 U AF [~ [rcv_left_reply_10_0_10<=reply_10_1_to_right_9]]]]
normalized: ~ [E [1<=rcv_right_reply_10_1_1 U ~ [EG [rcv_left_reply_10_0_10<=reply_10_1_to_right_9]]]]

abstracting: (rcv_left_reply_10_0_10<=reply_10_1_to_right_9)
states: 6,947,526,616,460 (12)
......................................................................
EG iterations: 70
abstracting: (1<=rcv_right_reply_10_1_1)
states: 34,257,238,708 (10)
-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-07 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m38.396sec

checking: AG [AF [[rcv_left_election_10_3_1_1<=init4 | AX [AF [election_10_4_1_to_right_10<=election_9_0_1_to_right_9]]]]]
normalized: ~ [E [true U EG [~ [[rcv_left_election_10_3_1_1<=init4 | ~ [EX [EG [~ [election_10_4_1_to_right_10<=election_9_0_1_to_right_9]]]]]]]]]

abstracting: (election_10_4_1_to_right_10<=election_9_0_1_to_right_9)
states: 6,895,627,881,757 (12)
.
EG iterations: 1
.abstracting: (rcv_left_election_10_3_1_1<=init4)
states: 6,843,792,906,250 (12)
.
EG iterations: 1
-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-06 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.912sec

checking: EF [[~ [EX [[AX [rcv_left_election_10_1_1_1<=rcv_left_election_8_0_1_9] | [AG [1<=rcv_left_reply_10_2_7] & 1<=election_7_0_1_to_right_7]]]] & election_6_0_1_to_right_6<=1]]
normalized: E [true U [election_6_0_1_to_right_6<=1 & ~ [EX [[[1<=election_7_0_1_to_right_7 & ~ [E [true U ~ [1<=rcv_left_reply_10_2_7]]]] | ~ [EX [~ [rcv_left_election_10_1_1_1<=rcv_left_election_8_0_1_9]]]]]]]]

abstracting: (rcv_left_election_10_1_1_1<=rcv_left_election_8_0_1_9)
states: 6,933,025,048,302 (12)
.abstracting: (1<=rcv_left_reply_10_2_7)
states: 39,347,085,840 (10)
abstracting: (1<=election_7_0_1_to_right_7)
states: 2,694,507,877,707 (12)
.abstracting: (election_6_0_1_to_right_6<=1)
states: 6,959,447,840,118 (12)
-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-09 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m10.189sec

checking: [EG [AG [[EF [~ [1<=election_10_3_6_to_left_5]] | EG [[rcv_right_reply_10_0_10<=reply_10_0_right10 & rcv_left_election_10_4_1_1<=0]]]]] | EG [EG [1<=rcv_right_election_4_0_1_3]]]
normalized: [EG [~ [E [true U ~ [[EG [[rcv_right_reply_10_0_10<=reply_10_0_right10 & rcv_left_election_10_4_1_1<=0]] | E [true U ~ [1<=election_10_3_6_to_left_5]]]]]]] | EG [EG [1<=rcv_right_election_4_0_1_3]]]

abstracting: (1<=rcv_right_election_4_0_1_3)
states: 892,262,676,343 (11)
.......................
before gc: list nodes free: 988613

after gc: idd nodes used:1313924, unused:62686076; list nodes free:281729391
.............................................................................
EG iterations: 100
.
EG iterations: 1
abstracting: (1<=election_10_3_6_to_left_5)
states: 150,583,713,128 (11)
abstracting: (rcv_left_election_10_4_1_1<=0)
states: 6,882,981,827,986 (12)
abstracting: (rcv_right_reply_10_0_10<=reply_10_0_right10)
states: 6,948,205,257,176 (12)
.............
before gc: list nodes free: 6811357

after gc: idd nodes used:393942, unused:63606058; list nodes free:285618864
.........................................................
EG iterations: 70

EG iterations: 0
-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-12 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 5m18.575sec

checking: [AF [~ [EF [E [EX [rcv_right_election_5_0_1_4<=rcv_left_reply_10_2_10] U E [reply_10_2_to_left_1<=1 U election_10_4_1_to_right_10<=reply_10_3_to_right_8]]]]] | AG [rcv_left_reply_10_3_3<=1]]
normalized: [~ [E [true U ~ [rcv_left_reply_10_3_3<=1]]] | ~ [EG [E [true U E [EX [rcv_right_election_5_0_1_4<=rcv_left_reply_10_2_10] U E [reply_10_2_to_left_1<=1 U election_10_4_1_to_right_10<=reply_10_3_to_right_8]]]]]]

abstracting: (election_10_4_1_to_right_10<=reply_10_3_to_right_8)
states: 6,856,741,353,062 (12)
abstracting: (reply_10_2_to_left_1<=1)
states: 6,959,447,840,118 (12)
abstracting: (rcv_right_election_5_0_1_4<=rcv_left_reply_10_2_10)
states: 6,069,090,484,477 (12)
..
EG iterations: 1
abstracting: (rcv_left_reply_10_3_3<=1)
states: 6,959,447,840,118 (12)
-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-15 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m13.273sec

checking: AG [[~ [AX [1<=rcv_left_reply_10_2_9]] & A [~ [[EG [rcv_right_election_10_2_3_7<=1] | ~ [reply_10_3_left10<=0]]] U E [[~ [1<=rcv_right_reply_10_3_5] & [rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10 | reply_10_0_to_left_1<=0]] U AX [1<=election_10_3_1_to_right_10]]]]]
normalized: ~ [E [true U ~ [[[~ [EG [~ [E [[[rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10 | reply_10_0_to_left_1<=0] & ~ [1<=rcv_right_reply_10_3_5]] U ~ [EX [~ [1<=election_10_3_1_to_right_10]]]]]]] & ~ [E [~ [E [[[rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10 | reply_10_0_to_left_1<=0] & ~ [1<=rcv_right_reply_10_3_5]] U ~ [EX [~ [1<=election_10_3_1_to_right_10]]]]] U [[~ [reply_10_3_left10<=0] | EG [rcv_right_election_10_2_3_7<=1]] & ~ [E [[[rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10 | reply_10_0_to_left_1<=0] & ~ [1<=rcv_right_reply_10_3_5]] U ~ [EX [~ [1<=election_10_3_1_to_right_10]]]]]]]]] & EX [~ [1<=rcv_left_reply_10_2_9]]]]]]

abstracting: (1<=rcv_left_reply_10_2_9)
states: 45,541,614,960 (10)
.abstracting: (1<=election_10_3_1_to_right_10)
states: 148,249,123,304 (11)
.abstracting: (1<=rcv_right_reply_10_3_5)
states: 68,832,644,816 (10)
abstracting: (reply_10_0_to_left_1<=0)
states: 6,933,911,942,433 (12)
abstracting: (rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10)
states: 6,905,088,879,902 (12)
abstracting: (rcv_right_election_10_2_3_7<=1)
states: 6,959,447,840,118 (12)

EG iterations: 0
abstracting: (reply_10_3_left10<=0)
states: 6,808,864,126,990 (12)
abstracting: (1<=election_10_3_1_to_right_10)
states: 148,249,123,304 (11)
.abstracting: (1<=rcv_right_reply_10_3_5)
states: 68,832,644,816 (10)
abstracting: (reply_10_0_to_left_1<=0)
states: 6,933,911,942,433 (12)
abstracting: (rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10)
states: 6,905,088,879,902 (12)
abstracting: (1<=election_10_3_1_to_right_10)
states: 148,249,123,304 (11)
.abstracting: (1<=rcv_right_reply_10_3_5)
states: 68,832,644,816 (10)
abstracting: (reply_10_0_to_left_1<=0)
states: 6,933,911,942,433 (12)
abstracting: (rcv_right_election_10_3_2_8<=rcv_right_election_1_0_1_10)
states: 6,905,088,879,902 (12)
.....................................................
before gc: list nodes free: 4079873

after gc: idd nodes used:1314447, unused:62685553; list nodes free:281692554
......................................................
EG iterations: 107
-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-01 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 3m23.696sec

checking: EX [[AG [rcv_right_reply_10_3_7<=0] | ~ [[[AG [1<=rcv_left_reply_10_3_8] | [AX [reply_10_3_to_right_9<=0] | ~ [elected_10_to_left_2<=0]]] | [AG [1<=election_10_4_8_to_right_7] | [rcv_left_reply_10_3_5<=0 | reply_10_0_to_right_9<=reply_10_3_right10]]]]]]
normalized: EX [[~ [[[[rcv_left_reply_10_3_5<=0 | reply_10_0_to_right_9<=reply_10_3_right10] | ~ [E [true U ~ [1<=election_10_4_8_to_right_7]]]] | [[~ [elected_10_to_left_2<=0] | ~ [EX [~ [reply_10_3_to_right_9<=0]]]] | ~ [E [true U ~ [1<=rcv_left_reply_10_3_8]]]]]] | ~ [E [true U ~ [rcv_right_reply_10_3_7<=0]]]]]

abstracting: (rcv_right_reply_10_3_7<=0)
states: 6,890,609,885,350 (12)
abstracting: (1<=rcv_left_reply_10_3_8)
states: 71,851,661,552 (10)
abstracting: (reply_10_3_to_right_9<=0)
states: 6,808,864,126,990 (12)
.abstracting: (elected_10_to_left_2<=0)
states: 6,959,026,816,374 (12)
abstracting: (1<=election_10_4_8_to_right_7)
states: 102,706,487,056 (11)
abstracting: (reply_10_0_to_right_9<=reply_10_3_right10)
states: 6,932,554,661,001 (12)
abstracting: (rcv_left_reply_10_3_5<=0)
states: 6,889,337,886,790 (12)
.-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-03 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 7.510sec

checking: [[AG [AG [E [~ [1<=rcv_right_reply_10_3_4] U [rcv_right_election_6_0_1_5<=reply_10_1_to_right_8 & rcv_right_election_9_0_1_8<=rcv_left_reply_10_0_10]]]] | EX [~ [rcv_left_reply_3_0_3<=0]]] & A [AF [EG [~ [[reply_10_2_to_right_9<=1 | newmsg6<=reply_10_2_left10]]]] U EX [1<=reply_10_2_to_right_9]]]
normalized: [[~ [E [~ [EX [1<=reply_10_2_to_right_9]] U [~ [EX [1<=reply_10_2_to_right_9]] & EG [~ [EG [~ [[reply_10_2_to_right_9<=1 | newmsg6<=reply_10_2_left10]]]]]]]] & ~ [EG [~ [EX [1<=reply_10_2_to_right_9]]]]] & [EX [~ [rcv_left_reply_3_0_3<=0]] | ~ [E [true U E [true U ~ [E [~ [1<=rcv_right_reply_10_3_4] U [rcv_right_election_6_0_1_5<=reply_10_1_to_right_8 & rcv_right_election_9_0_1_8<=rcv_left_reply_10_0_10]]]]]]]]

abstracting: (rcv_right_election_9_0_1_8<=rcv_left_reply_10_0_10)
states: 6,090,833,252,034 (12)
abstracting: (rcv_right_election_6_0_1_5<=reply_10_1_to_right_8)
states: 6,064,564,833,060 (12)
abstracting: (1<=rcv_right_reply_10_3_4)
states: 68,834,054,096 (10)
abstracting: (rcv_left_reply_3_0_3<=0)
states: 6,068,490,906,618 (12)
.abstracting: (1<=reply_10_2_to_right_9)
states: 81,099,427,160 (10)
..............................................
before gc: list nodes free: 7469198

after gc: idd nodes used:1118428, unused:62881572; list nodes free:282500292
.........................................................................
EG iterations: 118
abstracting: (newmsg6<=reply_10_2_left10)
states: 3,841,914,196,683 (12)
abstracting: (reply_10_2_to_right_9<=1)
states: 6,959,447,840,118 (12)
.
EG iterations: 1

EG iterations: 0
abstracting: (1<=reply_10_2_to_right_9)
states: 81,099,427,160 (10)
.abstracting: (1<=reply_10_2_to_right_9)
states: 81,099,427,160 (10)
.-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-10 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 3m22.586sec

checking: AF [[[A [[A [rcv_left_reply_6_0_6<=0 U rcv_left_reply_2_0_2<=1] & A [1<=rcv_right_election_10_2_3_7 U 1<=newmsg9]] U 1<=reply_5_0_to_right_4] & 1<=elected_10_to_left_4] | ~ [[~ [[election_4_0_1_to_left_4<=rcv_right_election_10_4_1_9 & reply_10_2_right10<=0]] | AG [EF [reply_10_3_to_right_7<=reply_10_3_to_left_8]]]]]]
normalized: ~ [EG [~ [[~ [[~ [E [true U ~ [E [true U reply_10_3_to_right_7<=reply_10_3_to_left_8]]]] | ~ [[election_4_0_1_to_left_4<=rcv_right_election_10_4_1_9 & reply_10_2_right10<=0]]]] | [1<=elected_10_to_left_4 & [~ [EG [~ [1<=reply_5_0_to_right_4]]] & ~ [E [~ [1<=reply_5_0_to_right_4] U [~ [[[~ [EG [~ [1<=newmsg9]]] & ~ [E [~ [1<=newmsg9] U [~ [1<=rcv_right_election_10_2_3_7] & ~ [1<=newmsg9]]]]] & [~ [EG [~ [rcv_left_reply_2_0_2<=1]]] & ~ [E [~ [rcv_left_reply_2_0_2<=1] U [~ [rcv_left_reply_6_0_6<=0] & ~ [rcv_left_reply_2_0_2<=1]]]]]]] & ~ [1<=reply_5_0_to_right_4]]]]]]]]]]

abstracting: (1<=reply_5_0_to_right_4)
states: 1,714,476,715,748 (12)
abstracting: (rcv_left_reply_2_0_2<=1)
states: 6,959,447,840,118 (12)
abstracting: (rcv_left_reply_6_0_6<=0)
states: 6,066,645,815,546 (12)
abstracting: (rcv_left_reply_2_0_2<=1)
states: 6,959,447,840,118 (12)
abstracting: (rcv_left_reply_2_0_2<=1)
states: 6,959,447,840,118 (12)
.
EG iterations: 1
abstracting: (1<=newmsg9)
states: 3,553,598,486,393 (12)
abstracting: (1<=rcv_right_election_10_2_3_7)
states: 39,814,754,120 (10)
abstracting: (1<=newmsg9)
states: 3,553,598,486,393 (12)
abstracting: (1<=newmsg9)
states: 3,553,598,486,393 (12)
.................
before gc: list nodes free: 2552405

after gc: idd nodes used:1373989, unused:62626011; list nodes free:281447737
..............................
before gc: list nodes free: 9975205

after gc: idd nodes used:2448659, unused:61551341; list nodes free:276918317
..............................................................
EG iterations: 109
abstracting: (1<=reply_5_0_to_right_4)
states: 1,714,476,715,748 (12)
abstracting: (1<=reply_5_0_to_right_4)
states: 1,714,476,715,748 (12)
.................
before gc: list nodes free: 12074535

after gc: idd nodes used:1100037, unused:62899963; list nodes free:282603132
...................MC time: 9m15.003sec

checking: EG [E [EX [[rcv_right_reply_10_2_3<=reply_10_3_to_left_1 | [1<=election_10_4_10_to_right_9 & AF [reply_7_0_to_right_6<=reply_10_3_to_right_8]]]] U AG [[[[election_10_1_2_to_right_1<=1 | election_10_4_1_to_left_10<=rcv_left_election_7_0_1_8] | AG [rcv_left_election_10_2_2_2<=rcv_left_reply_10_3_4]] | 1<=election_10_3_4_to_right_3]]]]
normalized: EG [E [EX [[rcv_right_reply_10_2_3<=reply_10_3_to_left_1 | [1<=election_10_4_10_to_right_9 & ~ [EG [~ [reply_7_0_to_right_6<=reply_10_3_to_right_8]]]]]] U ~ [E [true U ~ [[1<=election_10_3_4_to_right_3 | [~ [E [true U ~ [rcv_left_election_10_2_2_2<=rcv_left_reply_10_3_4]]] | [election_10_1_2_to_right_1<=1 | election_10_4_1_to_left_10<=rcv_left_election_7_0_1_8]]]]]]]]

abstracting: (election_10_4_1_to_left_10<=rcv_left_election_7_0_1_8)
states: 6,880,252,019,958 (12)
abstracting: (election_10_1_2_to_right_1<=1)
states: 6,959,447,840,118 (12)
abstracting: (rcv_left_election_10_2_2_2<=rcv_left_reply_10_3_4)
states: 6,920,210,387,158 (12)
abstracting: (1<=election_10_3_4_to_right_3)
states: 148,249,123,304 (11)
abstracting: (reply_7_0_to_right_6<=reply_10_3_to_right_8)
states: 5,275,397,781,049 (12)
......................................
before gc: list nodes free: 6636300

after gc: idd nodes used:1302620, unused:62697380; list nodes free:281712582
................................................................
before gc: list nodes free: 5406495

after gc: idd nodes used:942020, unused:63057980; list nodes free:283259068
..........................................................................
EG iterations: 176
abstracting: (1<=election_10_4_10_to_right_9)
states: 102,706,487,056 (11)
abstracting: (rcv_right_reply_10_2_3<=reply_10_3_to_left_1)
states: 6,921,391,559,718 (12)
.
EG iterations: 0
-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-04 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 5m45.577sec

checking: ~ [AG [[EF [~ [[[1<=rcv_left_election_10_4_10_10 | 1<=election_4_0_1_to_left_4] & [reply_10_1_to_left_1<=0 & rcv_right_election_10_2_2_8<=0]]]] | [~ [[1<=rcv_left_reply_7_0_7 | A [election_10_2_3_to_right_2<=rcv_left_election_4_0_1_5 U election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3]]] | EG [[E [rcv_right_election_10_2_2_8<=rcv_left_election_10_4_6_6 U 1<=rcv_left_election_10_1_1_1] | ~ [1<=rcv_right_election_10_4_3_7]]]]]]]
normalized: E [true U ~ [[[EG [[~ [1<=rcv_right_election_10_4_3_7] | E [rcv_right_election_10_2_2_8<=rcv_left_election_10_4_6_6 U 1<=rcv_left_election_10_1_1_1]]] | ~ [[1<=rcv_left_reply_7_0_7 | [~ [EG [~ [election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3]]] & ~ [E [~ [election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3] U [~ [election_10_2_3_to_right_2<=rcv_left_election_4_0_1_5] & ~ [election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3]]]]]]]] | E [true U ~ [[[reply_10_1_to_left_1<=0 & rcv_right_election_10_2_2_8<=0] & [1<=rcv_left_election_10_4_10_10 | 1<=election_4_0_1_to_left_4]]]]]]]

abstracting: (1<=election_4_0_1_to_left_4)
states: 1,724,356,567,916 (12)
abstracting: (1<=rcv_left_election_10_4_10_10)
states: 49,866,859,332 (10)
abstracting: (rcv_right_election_10_2_2_8<=0)
states: 6,919,184,654,518 (12)
abstracting: (reply_10_1_to_left_1<=0)
states: 6,915,574,061,726 (12)
abstracting: (election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3)
states: 6,856,741,353,062 (12)
abstracting: (election_10_2_3_to_right_2<=rcv_left_election_4_0_1_5)
states: 6,898,867,448,534 (12)
abstracting: (election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3)
states: 6,856,741,353,062 (12)
abstracting: (election_10_4_1_to_left_10<=rcv_left_election_10_2_3_3)
states: 6,856,741,353,062 (12)
.
EG iterations: 1
abstracting: (1<=rcv_left_reply_7_0_7)
states: 886,390,652,074 (11)
abstracting: (1<=rcv_left_election_10_1_1_1)
states: 34,550,685,196 (10)
abstracting: (rcv_right_election_10_2_2_8<=rcv_left_election_10_4_6_6)
states: 6,919,184,654,518 (12)
abstracting: (1<=rcv_right_election_10_4_3_7)
states: 47,648,471,456 (10)
.
EG iterations: 1
-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-08 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m14.343sec

checking: [~ [EF [[1<=rcv_left_election_10_2_1_1 & E [[AF [newmsg4<=1] | [election_10_1_1_to_right_10<=rcv_left_election_10_4_1_1 | election_10_1_2_to_right_1<=rcv_right_reply_10_3_7]] U reply_9_0_left9<=reply_10_3_to_left_7]]]] | [E [~ [EX [AF [rcv_left_election_10_2_3_3<=1]]] U reply_10_2_right10<=0] & ~ [[EG [AX [EG [election_10_4_2_to_left_9<=1]]] & EF [[EF [1<=rcv_right_election_10_4_8_2] | [~ [rcv_left_election_10_3_1_1<=election_10_1_1_to_right_10] | E [1<=election_4_0_1_to_left_4 U reply_10_3_to_right_4<=0]]]]]]]]
normalized: [~ [E [true U [1<=rcv_left_election_10_2_1_1 & E [[~ [EG [~ [newmsg4<=1]]] | [election_10_1_1_to_right_10<=rcv_left_election_10_4_1_1 | election_10_1_2_to_right_1<=rcv_right_reply_10_3_7]] U reply_9_0_left9<=reply_10_3_to_left_7]]]] | [~ [[EG [~ [EX [~ [EG [election_10_4_2_to_left_9<=1]]]]] & E [true U [[~ [rcv_left_election_10_3_1_1<=election_10_1_1_to_right_10] | E [1<=election_4_0_1_to_left_4 U reply_10_3_to_right_4<=0]] | E [true U 1<=rcv_right_election_10_4_8_2]]]]] & E [~ [EX [~ [EG [~ [rcv_left_election_10_2_3_3<=1]]]]] U reply_10_2_right10<=0]]]

abstracting: (reply_10_2_right10<=0)
states: 6,881,024,553,406 (12)
abstracting: (rcv_left_election_10_2_3_3<=1)
states: 6,959,447,840,118 (12)
.
EG iterations: 1
.abstracting: (1<=rcv_right_election_10_4_8_2)
states: 48,990,762,032 (10)
abstracting: (reply_10_3_to_right_4<=0)
states: 6,808,864,126,990 (12)
abstracting: (1<=election_4_0_1_to_left_4)
states: 1,724,356,567,916 (12)
abstracting: (rcv_left_election_10_3_1_1<=election_10_1_1_to_right_10)
states: 6,843,792,906,250 (12)
abstracting: (election_10_4_2_to_left_9<=1)
states: 6,959,447,840,118 (12)

EG iterations: 0
.
EG iterations: 0
abstracting: (reply_9_0_left9<=reply_10_3_to_left_7)
states: 5,302,468,939,510 (12)
abstracting: (election_10_1_2_to_right_1<=rcv_right_reply_10_3_7)
states: 6,915,280,615,238 (12)
abstracting: (election_10_1_1_to_right_10<=rcv_left_election_10_4_1_1)
states: 6,915,280,615,238 (12)
abstracting: (newmsg4<=1)
states: 6,959,447,840,118 (12)
.
EG iterations: 1
abstracting: (1<=rcv_left_election_10_2_1_1)
states: 62,142,260,468 (10)
-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-05 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m21.775sec

checking: E [[[~ [AF [~ [[election_10_3_4_to_right_3<=reply_10_2_to_left_2 | rcv_left_election_10_4_6_6<=0]]]] | [~ [EX [[rcv_right_election_10_0_1_9<=rcv_right_election_10_2_4_6 & rcv_right_reply_10_0_10<=election_10_2_2_to_left_9]]] & 1<=election_6_0_1_to_right_6]] | [~ [[~ [reply_10_2_to_left_1<=reply_10_2_to_left_2] & AF [reply_10_1_left10<=reply_3_0_left3]]] & reply_2_0_left2<=0]] U ~ [E [A [EF [1<=init10] U rcv_right_election_10_4_3_7<=reply_10_2_to_left_3] U 1<=rcv_left_reply_10_3_8]]]
normalized: E [[[reply_2_0_left2<=0 & ~ [[~ [EG [~ [reply_10_1_left10<=reply_3_0_left3]]] & ~ [reply_10_2_to_left_1<=reply_10_2_to_left_2]]]] | [[1<=election_6_0_1_to_right_6 & ~ [EX [[rcv_right_election_10_0_1_9<=rcv_right_election_10_2_4_6 & rcv_right_reply_10_0_10<=election_10_2_2_to_left_9]]]] | EG [[election_10_3_4_to_right_3<=reply_10_2_to_left_2 | rcv_left_election_10_4_6_6<=0]]]] U ~ [E [[~ [EG [~ [rcv_right_election_10_4_3_7<=reply_10_2_to_left_3]]] & ~ [E [~ [rcv_right_election_10_4_3_7<=reply_10_2_to_left_3] U [~ [E [true U 1<=init10]] & ~ [rcv_right_election_10_4_3_7<=reply_10_2_to_left_3]]]]] U 1<=rcv_left_reply_10_3_8]]]

abstracting: (1<=rcv_left_reply_10_3_8)
states: 71,851,661,552 (10)
abstracting: (rcv_right_election_10_4_3_7<=reply_10_2_to_left_3)
states: 6,911,799,368,662 (12)
abstracting: (1<=init10)
states: 917,151,071 (8)
abstracting: (rcv_right_election_10_4_3_7<=reply_10_2_to_left_3)
states: 6,911,799,368,662 (12)
abstracting: (rcv_right_election_10_4_3_7<=reply_10_2_to_left_3)
states: 6,911,799,368,662 (12)
............................................................
EG iterations: 60
abstracting: (rcv_left_election_10_4_6_6<=0)
states: 6,911,430,965,974 (12)
abstracting: (election_10_3_4_to_right_3<=reply_10_2_to_left_2)
states: 6,811,198,716,814 (12)

EG iterations: 0
abstracting: (rcv_right_reply_10_0_10<=election_10_2_2_to_left_9)
states: 6,948,205,257,176 (12)
abstracting: (rcv_right_election_10_0_1_9<=rcv_right_election_10_2_4_6)
states: 6,944,265,576,731 (12)
.abstracting: (1<=election_6_0_1_to_right_6)
states: 2,698,578,185,018 (12)
abstracting: (reply_10_2_to_left_1<=reply_10_2_to_left_2)
states: 6,881,024,553,406 (12)
abstracting: (reply_10_1_left10<=reply_3_0_left3)
states: 6,924,143,753,846 (12)
...................................................................
EG iterations: 67
abstracting: (reply_2_0_left2<=0)
states: 5,384,425,917,566 (12)
-> the formula is TRUE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-11 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m48.504sec

checking: AF [[[A [[A [rcv_left_reply_6_0_6<=0 U rcv_left_reply_2_0_2<=1] & A [1<=rcv_right_election_10_2_3_7 U 1<=newmsg9]] U 1<=reply_5_0_to_right_4] & 1<=elected_10_to_left_4] | ~ [[~ [[election_4_0_1_to_left_4<=rcv_right_election_10_4_1_9 & reply_10_2_right10<=0]] | AG [EF [reply_10_3_to_right_7<=reply_10_3_to_left_8]]]]]]
normalized: ~ [EG [~ [[~ [[~ [E [true U ~ [E [true U reply_10_3_to_right_7<=reply_10_3_to_left_8]]]] | ~ [[election_4_0_1_to_left_4<=rcv_right_election_10_4_1_9 & reply_10_2_right10<=0]]]] | [1<=elected_10_to_left_4 & [~ [EG [~ [1<=reply_5_0_to_right_4]]] & ~ [E [~ [1<=reply_5_0_to_right_4] U [~ [[[~ [EG [~ [1<=newmsg9]]] & ~ [E [~ [1<=newmsg9] U [~ [1<=rcv_right_election_10_2_3_7] & ~ [1<=newmsg9]]]]] & [~ [EG [~ [rcv_left_reply_2_0_2<=1]]] & ~ [E [~ [rcv_left_reply_2_0_2<=1] U [~ [rcv_left_reply_6_0_6<=0] & ~ [rcv_left_reply_2_0_2<=1]]]]]]] & ~ [1<=reply_5_0_to_right_4]]]]]]]]]]

abstracting: (1<=reply_5_0_to_right_4)
states: 1,714,476,715,748 (12)
abstracting: (rcv_left_reply_2_0_2<=1)
states: 6,959,447,840,118 (12)
abstracting: (rcv_left_reply_6_0_6<=0)
states: 6,066,645,815,546 (12)
abstracting: (rcv_left_reply_2_0_2<=1)
states: 6,959,447,840,118 (12)
abstracting: (rcv_left_reply_2_0_2<=1)
states: 6,959,447,840,118 (12)
.
EG iterations: 1
abstracting: (1<=newmsg9)
states: 3,553,598,486,393 (12)
abstracting: (1<=rcv_right_election_10_2_3_7)
states: 39,814,754,120 (10)
abstracting: (1<=newmsg9)
states: 3,553,598,486,393 (12)
abstracting: (1<=newmsg9)
states: 3,553,598,486,393 (12)
...................
before gc: list nodes free: 8099830

after gc: idd nodes used:1901014, unused:62098986; list nodes free:279190755
.............................
before gc: list nodes free: 10126543

after gc: idd nodes used:2623861, unused:61376139; list nodes free:276127097
.............................................................
EG iterations: 109
abstracting: (1<=reply_5_0_to_right_4)
states: 1,714,476,715,748 (12)
abstracting: (1<=reply_5_0_to_right_4)
states: 1,714,476,715,748 (12)
.................
before gc: list nodes free: 12084297

after gc: idd nodes used:1505579, unused:62494421; list nodes free:280806340
.....................................................................................
EG iterations: 102
abstracting: (1<=elected_10_to_left_4)
states: 2,010,811,392 (9)
abstracting: (reply_10_2_right10<=0)
states: 6,881,024,553,406 (12)
abstracting: (election_4_0_1_to_left_4<=rcv_right_election_10_4_1_9)
states: 5,247,878,857,962 (12)
abstracting: (reply_10_3_to_right_7<=reply_10_3_to_left_8)
states: 6,814,796,226,846 (12)

before gc: list nodes free: 6236057

after gc: idd nodes used:932958, unused:63067042; list nodes free:283294308
...................................
EG iterations: 35
-> the formula is FALSE

FORMULA HirschbergSinclair-PT-10-CTLCardinality-00 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 12m23.118sec

totally nodes used: 818335706 (8.2e+08)
number of garbage collections: 13
fire ops cache: hits/miss/sum: 607477931 3076176693 3683654624
used/not used/entry size/cache size: 14368012 52740852 16 1024MB
basic ops cache: hits/miss/sum: 29097345 131811494 160908839
used/not used/entry size/cache size: 922304 15854912 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: 298585 1572151 1870736
used/not used/entry size/cache size: 0 8388608 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 63232350
1 3277738
2 487567
3 93306
4 15467
5 2125
6 280
7 27
8 4
9 0
>= 10 0

Total processing time: 42m37.115sec


BK_STOP 1679907392539

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


iterations count:14019 (59), effective:486 (2)

initing FirstDep: 0m 0.000sec


iterations count:436 (1), effective:13 (0)

iterations count:445 (1), effective:14 (0)

iterations count:3050 (12), effective:150 (0)

iterations count:6150 (26), effective:320 (1)

iterations count:6290 (26), effective:321 (1)

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

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

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

iterations count:10424 (44), effective:497 (2)

iterations count:314 (1), effective:6 (0)

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

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

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

iterations count:9064 (38), effective:435 (1)

iterations count:9064 (38), effective:435 (1)

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

iterations count:9064 (38), effective:435 (1)

iterations count:7895 (33), effective:383 (1)

iterations count:3595 (15), effective:187 (0)

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

iterations count:312 (1), effective:5 (0)

iterations count:997 (4), effective:38 (0)

iterations count:4352 (18), effective:215 (0)

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

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

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

iterations count:6689 (28), effective:337 (1)

net_ddint.h:600: Timeout: after 554 sec


iterations count:1310 (5), effective:61 (0)

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

iterations count:700 (2), effective:25 (0)

iterations count:733 (3), effective:22 (0)

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

iterations count:6546 (27), effective:338 (1)

iterations count:558 (2), effective:6 (0)

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

iterations count:3476 (14), effective:179 (0)

iterations count:1266 (5), effective:56 (0)

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

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

iterations count:3984 (16), effective:199 (0)

iterations count:4004 (16), effective:200 (0)

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

iterations count:6689 (28), effective:337 (1)

iterations count:335 (1), effective:5 (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="HirschbergSinclair-PT-10"
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 HirschbergSinclair-PT-10, 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 r193-smll-167840340600433"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/HirschbergSinclair-PT-10.tgz
mv HirschbergSinclair-PT-10 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 ;