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.r225-tall-167856407100097.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 IBMB2S565S3960-PT-none, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r225-tall-167856407100097
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 496K
-rw-r--r-- 1 mcc users 9.3K Feb 26 05:47 CTLCardinality.txt
-rw-r--r-- 1 mcc users 64K Feb 26 05:47 CTLCardinality.xml
-rw-r--r-- 1 mcc users 8.0K Feb 26 05:46 CTLFireability.txt
-rw-r--r-- 1 mcc users 45K Feb 26 05:46 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:40 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.4K Jan 29 11:40 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 6.1K Feb 25 16:17 LTLCardinality.txt
-rw-r--r-- 1 mcc users 28K Feb 25 16:17 LTLCardinality.xml
-rw-r--r-- 1 mcc users 3.9K Feb 25 16:17 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K Feb 25 16:17 LTLFireability.xml
-rw-r--r-- 1 mcc users 12K Feb 26 05:47 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 65K Feb 26 05:47 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 11K Feb 26 05:47 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 44K Feb 26 05:47 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.2K Feb 25 16:17 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.3K Feb 25 16:17 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 equiv_col
-rw-r--r-- 1 mcc users 5 Mar 5 18:22 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 iscolored
-rw-r--r-- 1 mcc users 127K 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 IBMB2S565S3960-PT-none-CTLCardinality-00
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-01
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-02
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-03
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-04
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-05
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-06
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-07
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-08
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-09
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-10
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-11
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-12
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-13
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-14
FORMULA_NAME IBMB2S565S3960-PT-none-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1678606120702

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=IBMB2S565S3960-PT-none
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: IBMB2S565S3960_PT_none
(NrP: 273 NrTr: 179 NrArc: 572)

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

net check time: 0m 0.000sec

init dd package: 0m 2.831sec


RS generation: 5m42.135sec


-> reachability set: #nodes 4000871 (4.0e+06) #states 15,510,635,947,410,534 (16)



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

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

abstracting: (callToTask_s00003975_input_s00001052<=1)
states: 14,792,621,964,775,882 (16)

before gc: list nodes free: 1384513

after gc: idd nodes used:7614866, unused:56385134; list nodes free:340420864

before gc: list nodes free: 34421466

after gc: idd nodes used:7904054, unused:56095946; list nodes free:339469258
MC time: 3m25.274sec

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

abstracting: (1<=fork_s00001403_input_s00001066)
states: 40,178,155,437,452 (13)

before gc: list nodes free: 8605905

after gc: idd nodes used:9778544, unused:54221456; list nodes free:322979261

before gc: list nodes free: 17920750

after gc: idd nodes used:11255637, unused:52744363; list nodes free:317260740
MC time: 3m12.622sec

checking: AX [EX [AF [EF [~ [callToTask_s00003908_output_s00001054<=1]]]]]
normalized: ~ [EX [~ [EX [~ [EG [~ [E [true U ~ [callToTask_s00003908_output_s00001054<=1]]]]]]]]]

abstracting: (callToTask_s00003908_output_s00001054<=1)
states: 15,425,106,017,266,363 (16)

before gc: list nodes free: 37690255

after gc: idd nodes used:9274332, unused:54725668; list nodes free:330156729
MC time: 3m 0.101sec

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

abstracting: (1<=merge_s00001161_input_s00001068)
states: 550,156,149,617,229 (14)

before gc: list nodes free: 18848742

after gc: idd nodes used:10252321, unused:53747679; list nodes free:324379272
MC time: 2m47.525sec

checking: ~ [EX [EG [EF [E [1<=callToTask_s00003966_inputCriterion_s00001053_used U fork_s00002500_input_s00001052<=1]]]]]
normalized: ~ [EX [EG [E [true U E [1<=callToTask_s00003966_inputCriterion_s00001053_used U fork_s00002500_input_s00001052<=1]]]]]

abstracting: (fork_s00002500_input_s00001052<=1)
states: 15,494,505,311,465,598 (16)
abstracting: (1<=callToTask_s00003966_inputCriterion_s00001053_used)
states: 3,366,191,446,370,177 (15)

before gc: list nodes free: 46020738

after gc: idd nodes used:9928101, unused:54071899; list nodes free:325698342
MC time: 2m39.410sec

checking: E [merge_s00001160_input_s00001166<=callToTask_s00001360_output_s00001054 U EX [EX [EG [EX [decision_s00001840_activated<=1]]]]]
normalized: E [merge_s00001160_input_s00001166<=callToTask_s00001360_output_s00001054 U EX [EX [EG [EX [decision_s00001840_activated<=1]]]]]

abstracting: (decision_s00001840_activated<=1)
states: 15,425,106,017,266,363 (16)

before gc: list nodes free: 2866356

after gc: idd nodes used:13948694, unused:50051306; list nodes free:304544997
MC time: 2m30.434sec

checking: ~ [E [fork_s00001298_input_s00001052<=callToTask_s00003980_output_s00001054 U [AF [AF [1<=callToTask_s00003975_input_s00001066]] & callToProcess_s00003957_inputCriterion_s00001053_used<=0]]]
normalized: ~ [E [fork_s00001298_input_s00001052<=callToTask_s00003980_output_s00001054 U [callToProcess_s00003957_inputCriterion_s00001053_used<=0 & ~ [EG [EG [~ [1<=callToTask_s00003975_input_s00001066]]]]]]]

abstracting: (1<=callToTask_s00003975_input_s00001066)
states: 3,677,145,448,665,316 (15)

before gc: list nodes free: 9274225

after gc: idd nodes used:13630174, unused:50369826; list nodes free:303316150
MC time: 2m18.785sec

checking: [AF [AG [~ [A [EF [callToTask_s00003967_inputCriterion_s00001053_used<=callToTask_s00003913_output_s00001077] U 1<=merge_s00002240_activated]]]] | EF [AX [EX [~ [[fork_s00001298_input_s00001066<=1 & decision_s00002948_activated<=callToTask_s00003963_output_s00001077]]]]]]
normalized: [E [true U ~ [EX [~ [EX [~ [[fork_s00001298_input_s00001066<=1 & decision_s00002948_activated<=callToTask_s00003963_output_s00001077]]]]]]] | ~ [EG [E [true U [~ [EG [~ [1<=merge_s00002240_activated]]] & ~ [E [~ [1<=merge_s00002240_activated] U [~ [E [true U callToTask_s00003967_inputCriterion_s00001053_used<=callToTask_s00003913_output_s00001077]] & ~ [1<=merge_s00002240_activated]]]]]]]]]

abstracting: (1<=merge_s00002240_activated)
states: 550,156,149,617,229 (14)
abstracting: (callToTask_s00003967_inputCriterion_s00001053_used<=callToTask_s00003913_output_s00001077)
states: 15,088,712,375,274,614 (16)

before gc: list nodes free: 13949490

after gc: idd nodes used:16062229, unused:47937771; list nodes free:288598448
MC time: 2m14.125sec

checking: ~ [[AF [EF [[A [process_s00000565__s00003960_output_s00001249<=callToTask_s00003962_inputCriterion_s00001053_used U 1<=merge_s00002239_activated] | AF [callToTask_s00003969_output_s00001080<=fork_s00002500_input_s00001066]]]] & EG [callToTask_s00003965_output_s00001054<=1]]]
normalized: ~ [[EG [callToTask_s00003965_output_s00001054<=1] & ~ [EG [~ [E [true U [~ [EG [~ [callToTask_s00003969_output_s00001080<=fork_s00002500_input_s00001066]]] | [~ [EG [~ [1<=merge_s00002239_activated]]] & ~ [E [~ [1<=merge_s00002239_activated] U [~ [process_s00000565__s00003960_output_s00001249<=callToTask_s00003962_inputCriterion_s00001053_used] & ~ [1<=merge_s00002239_activated]]]]]]]]]]]]

abstracting: (1<=merge_s00002239_activated)
states: 323,644,936,551,575 (14)
abstracting: (process_s00000565__s00003960_output_s00001249<=callToTask_s00003962_inputCriterion_s00001053_used)
states: 6,143,711,916,769,463 (15)
abstracting: (1<=merge_s00002239_activated)
states: 323,644,936,551,575 (14)
MC time: 2m 5.332sec

checking: AG [AX [[EF [[1<=callToProcess_s00003876_inputCriterion_s00001053_used & [callToTask_s00003981_output_s00001054<=callToTask_s00003962_output_s00001077 | merge_s00001161_activated<=1]]] & EF [[[1<=callToTask_s00003970_input_s00001066 & 1<=merge_s00002238_input_s00001066] | AF [1<=callToTask_s00003980_output_s00001083]]]]]]
normalized: ~ [E [true U EX [~ [[E [true U [~ [EG [~ [1<=callToTask_s00003980_output_s00001083]]] | [1<=callToTask_s00003970_input_s00001066 & 1<=merge_s00002238_input_s00001066]]] & E [true U [1<=callToProcess_s00003876_inputCriterion_s00001053_used & [callToTask_s00003981_output_s00001054<=callToTask_s00003962_output_s00001077 | merge_s00001161_activated<=1]]]]]]]]

abstracting: (merge_s00001161_activated<=1)
states: 15,494,505,311,465,598 (16)
abstracting: (callToTask_s00003981_output_s00001054<=callToTask_s00003962_output_s00001077)
states: 15,169,221,778,070,564 (16)
abstracting: (1<=callToProcess_s00003876_inputCriterion_s00001053_used)
states: 40,178,155,437,452 (13)

before gc: list nodes free: 28428905

after gc: idd nodes used:24641679, unused:39358321; list nodes free:241933675
MC time: 1m53.502sec

checking: [~ [AX [AX [EG [[1<=join_s00002243_activated_s00001062 | join_s00001164_activated_s00001062<=callToTask_s00003977_output_s00001054]]]]] & AX [E [AX [~ [A [1<=callToTask_s00003979_output_s00001054 U callToTask_s00003963_output_s00001054<=merge_s00001061_input_s00001052]]] U A [EF [callToTask_s00003974_inputCriterion_s00001053_used<=1] U A [1<=callToTask_s00003974_inputCriterion_s00001053_used U 1<=callToTask_s00003973_output_s00001077]]]]]
normalized: [~ [EX [~ [E [~ [EX [[~ [EG [~ [callToTask_s00003963_output_s00001054<=merge_s00001061_input_s00001052]]] & ~ [E [~ [callToTask_s00003963_output_s00001054<=merge_s00001061_input_s00001052] U [~ [1<=callToTask_s00003979_output_s00001054] & ~ [callToTask_s00003963_output_s00001054<=merge_s00001061_input_s00001052]]]]]]] U [~ [EG [~ [[~ [EG [~ [1<=callToTask_s00003973_output_s00001077]]] & ~ [E [~ [1<=callToTask_s00003973_output_s00001077] U [~ [1<=callToTask_s00003974_inputCriterion_s00001053_used] & ~ [1<=callToTask_s00003973_output_s00001077]]]]]]]] & ~ [E [~ [[~ [EG [~ [1<=callToTask_s00003973_output_s00001077]]] & ~ [E [~ [1<=callToTask_s00003973_output_s00001077] U [~ [1<=callToTask_s00003974_inputCriterion_s00001053_used] & ~ [1<=callToTask_s00003973_output_s00001077]]]]]] U [~ [E [true U callToTask_s00003974_inputCriterion_s00001053_used<=1]] & ~ [[~ [EG [~ [1<=callToTask_s00003973_output_s00001077]]] & ~ [E [~ [1<=callToTask_s00003973_output_s00001077] U [~ [1<=callToTask_s00003974_inputCriterion_s00001053_used] & ~ [1<=callToTask_s00003973_output_s00001077]]]]]]]]]]]]]] & EX [EX [~ [EG [[1<=join_s00002243_activated_s00001062 | join_s00001164_activated_s00001062<=callToTask_s00003977_output_s00001054]]]]]]

abstracting: (join_s00001164_activated_s00001062<=callToTask_s00003977_output_s00001054)
states: 14,640,704,339,763,497 (16)
abstracting: (1<=join_s00002243_activated_s00001062)
states: 2,401,168,201,466,721 (15)

before gc: list nodes free: 1043345

after gc: idd nodes used:30502422, unused:33497578; list nodes free:207737560
MC time: 1m48.508sec

checking: EX [EG [[EX [E [callToProcess_s00003876_input_s00001066<=0 U callToTask_s00003975_output_s00001054<=merge_s00001162_input_s00001052]] & [A [~ [1<=decision_s00002948_activated] U [merge_s00001160_input_s00001066<=1 | callToTask_s00003908_output_s00001077<=fork_s00002755_activated_s00001073]] & callToTask_s00003969_output_s00001080<=callToTask_s00003972_output_s00001077]]]]
normalized: EX [EG [[[callToTask_s00003969_output_s00001080<=callToTask_s00003972_output_s00001077 & [~ [EG [~ [[merge_s00001160_input_s00001066<=1 | callToTask_s00003908_output_s00001077<=fork_s00002755_activated_s00001073]]]] & ~ [E [~ [[merge_s00001160_input_s00001066<=1 | callToTask_s00003908_output_s00001077<=fork_s00002755_activated_s00001073]] U [1<=decision_s00002948_activated & ~ [[merge_s00001160_input_s00001066<=1 | callToTask_s00003908_output_s00001077<=fork_s00002755_activated_s00001073]]]]]]] & EX [E [callToProcess_s00003876_input_s00001066<=0 U callToTask_s00003975_output_s00001054<=merge_s00001162_input_s00001052]]]]]

abstracting: (callToTask_s00003975_output_s00001054<=merge_s00001162_input_s00001052)
states: 11,891,723,250,162,826 (16)
abstracting: (callToProcess_s00003876_input_s00001066<=0)
states: 14,125,931,747,086,596 (16)
MC time: 1m40.006sec

checking: A [[AX [[[~ [AX [callToTask_s00003908_output_s00001083<=1]] | ~ [callToTask_s00003908_output_s00001054<=1]] | ~ [EG [1<=callToTask_s00003978_output_s00001077]]]] | ~ [[[[AF [callToTask_s00003976_input_s00001066<=callToTask_s00003969_output_s00001080] | EG [decision_s00001126_activated<=callToTask_s00003975_input_s00001052]] | [AF [decision_s00001159_activated<=merge_s00001160_activated] & EF [1<=callToProcess_s00003859_input_s00001052]]] & fork_s00001298_activated_s00001073<=0]]] U 1<=merge_s00001061_input_s00001066]
normalized: [~ [EG [~ [1<=merge_s00001061_input_s00001066]]] & ~ [E [~ [1<=merge_s00001061_input_s00001066] U [~ [[~ [[fork_s00001298_activated_s00001073<=0 & [[E [true U 1<=callToProcess_s00003859_input_s00001052] & ~ [EG [~ [decision_s00001159_activated<=merge_s00001160_activated]]]] | [EG [decision_s00001126_activated<=callToTask_s00003975_input_s00001052] | ~ [EG [~ [callToTask_s00003976_input_s00001066<=callToTask_s00003969_output_s00001080]]]]]]] | ~ [EX [~ [[~ [EG [1<=callToTask_s00003978_output_s00001077]] | [~ [callToTask_s00003908_output_s00001054<=1] | EX [~ [callToTask_s00003908_output_s00001083<=1]]]]]]]]] & ~ [1<=merge_s00001061_input_s00001066]]]]]

abstracting: (1<=merge_s00001061_input_s00001066)
states: 550,156,149,617,229 (14)
abstracting: (callToTask_s00003908_output_s00001083<=1)
states: 15,425,106,017,266,363 (16)

before gc: list nodes free: 12829607

after gc: idd nodes used:38500690, unused:25499310; list nodes free:164020956
MC time: 1m33.927sec

checking: ~ [[~ [[A [A [callToTask_s00003975_output_s00001080<=1 U 1<=callToProcess_s00003876_output_s00001054] U [callToProcess_s00003957_output_s00001077<=join_s00001164_input_s00001127 & callToTask_s00003972_input_s00001066<=decision_s00002760_activated]] | [EF [merge_s00001160_input_s00001127<=merge_s00001161_input_s00001066] & E [join_s00001164_input_s00001127<=process_s00000565__s00003960_input_s00001052 U callToTask_s00003970_input_s00001052<=0]]]] | ~ [EF [[EX [alpha<=1] & 1<=callToTask_s00003980_input_s00001127]]]]]
normalized: ~ [[~ [E [true U [1<=callToTask_s00003980_input_s00001127 & EX [alpha<=1]]]] | ~ [[[~ [EG [~ [[callToProcess_s00003957_output_s00001077<=join_s00001164_input_s00001127 & callToTask_s00003972_input_s00001066<=decision_s00002760_activated]]]] & ~ [E [~ [[callToProcess_s00003957_output_s00001077<=join_s00001164_input_s00001127 & callToTask_s00003972_input_s00001066<=decision_s00002760_activated]] U [~ [[callToProcess_s00003957_output_s00001077<=join_s00001164_input_s00001127 & callToTask_s00003972_input_s00001066<=decision_s00002760_activated]] & ~ [[~ [EG [~ [1<=callToProcess_s00003876_output_s00001054]]] & ~ [E [~ [1<=callToProcess_s00003876_output_s00001054] U [~ [callToTask_s00003975_output_s00001080<=1] & ~ [1<=callToProcess_s00003876_output_s00001054]]]]]]]]]] | [E [join_s00001164_input_s00001127<=process_s00000565__s00003960_input_s00001052 U callToTask_s00003970_input_s00001052<=0] & E [true U merge_s00001160_input_s00001127<=merge_s00001161_input_s00001066]]]]]]

abstracting: (merge_s00001160_input_s00001127<=merge_s00001161_input_s00001066)
states: 14,976,239,834,719,983 (16)

before gc: list nodes free: 25751079

after gc: idd nodes used:37361444, unused:26638556; list nodes free:173950406
MC time: 1m29.877sec

checking: A [~ [[E [[[endNode_s00002053_input_default<=callToTask_s00003968_output_s00001077 & 1<=endNode_s00001402_input_default] | EG [join_s00002243_activated_s00001062<=callToTask_s00003963_input_s00001052]] U [~ [1<=join_s00002243_activated_s00001065] | EG [1<=merge_s00001162_input_s00001165]]] | A [~ [AG [1<=merge_s00001162_input_s00001129]] U AG [callToTask_s00003970_input_s00001068<=callToTask_s00003968_output_s00001080]]]] U [EF [[1<=process_s00000565__s00003960_output_s00001249 & decision_s00001841_activated<=callToTask_s00003973_output_s00001077]] & EG [callToTask_s00003970_input_s00001052<=callToTask_s00003977_output_s00001054]]]
normalized: [~ [EG [~ [[EG [callToTask_s00003970_input_s00001052<=callToTask_s00003977_output_s00001054] & E [true U [1<=process_s00000565__s00003960_output_s00001249 & decision_s00001841_activated<=callToTask_s00003973_output_s00001077]]]]]] & ~ [E [~ [[EG [callToTask_s00003970_input_s00001052<=callToTask_s00003977_output_s00001054] & E [true U [1<=process_s00000565__s00003960_output_s00001249 & decision_s00001841_activated<=callToTask_s00003973_output_s00001077]]]] U [[[~ [EG [E [true U ~ [callToTask_s00003970_input_s00001068<=callToTask_s00003968_output_s00001080]]]] & ~ [E [E [true U ~ [callToTask_s00003970_input_s00001068<=callToTask_s00003968_output_s00001080]] U [~ [E [true U ~ [1<=merge_s00001162_input_s00001129]]] & E [true U ~ [callToTask_s00003970_input_s00001068<=callToTask_s00003968_output_s00001080]]]]]] | E [[EG [join_s00002243_activated_s00001062<=callToTask_s00003963_input_s00001052] | [endNode_s00002053_input_default<=callToTask_s00003968_output_s00001077 & 1<=endNode_s00001402_input_default]] U [EG [1<=merge_s00001162_input_s00001165] | ~ [1<=join_s00002243_activated_s00001065]]]] & ~ [[EG [callToTask_s00003970_input_s00001052<=callToTask_s00003977_output_s00001054] & E [true U [1<=process_s00000565__s00003960_output_s00001249 & decision_s00001841_activated<=callToTask_s00003973_output_s00001077]]]]]]]]

abstracting: (decision_s00001841_activated<=callToTask_s00003973_output_s00001077)
states: 14,311,029,364,469,157 (16)
abstracting: (1<=process_s00000565__s00003960_output_s00001249)
states: 9,526,266,036,558,385 (15)
MC time: 1m23.342sec

checking: E [[[[A [EF [1<=fork_s00001298_input_s00001068] U callToTask_s00003978_output_s00001077<=0] & ~ [[EG [callToTask_s00001360_output_s00001054<=0] | ~ [1<=join_s00002243_input_s00001167]]]] | [~ [[AG [callToProcess_s00003884_input_s00001068<=1] & EG [callToTask_s00003977_output_s00001054<=1]]] | AX [~ [AG [callToProcess_s00003872_output_s00001077<=0]]]]] | [[E [EX [callToProcess_s00003876_input_s00001066<=merge_s00002238_input_s00001052] U EX [1<=callToTask_s00003979_inputCriterion_s00001053_used]] & AF [AF [decision_s00002762_activated<=1]]] | [~ [E [merge_s00002238_input_s00001066<=merge_s00001061_input_s00001166 U 1<=callToTask_s00003981_output_s00001054]] | 1<=callToTask_s00003963_output_s00001077]]] U [EG [EG [[AG [1<=callToTask_s00003979_output_s00001054] | callToTask_s00003908_input_s00001052<=1]]] | E [[~ [A [1<=callToTask_s00003980_inputCriterion_s00001053_used U callToTask_s00001360_output_s00001077<=0]] & AF [A [callToTask_s00003962_inputCriterion_s00001053_used<=0 U callToTask_s00003961_output_s00001080<=callToTask_s00003971_input_s00001066]]] U EG [EF [join_s00001164_input_s00001052<=callToTask_s00003962_input_s00001068]]]]]
normalized: E [[[[E [EX [callToProcess_s00003876_input_s00001066<=merge_s00002238_input_s00001052] U EX [1<=callToTask_s00003979_inputCriterion_s00001053_used]] & ~ [EG [EG [~ [decision_s00002762_activated<=1]]]]] | [1<=callToTask_s00003963_output_s00001077 | ~ [E [merge_s00002238_input_s00001066<=merge_s00001061_input_s00001166 U 1<=callToTask_s00003981_output_s00001054]]]] | [[~ [[~ [E [true U ~ [callToProcess_s00003884_input_s00001068<=1]]] & EG [callToTask_s00003977_output_s00001054<=1]]] | ~ [EX [~ [E [true U ~ [callToProcess_s00003872_output_s00001077<=0]]]]]] | [~ [[~ [1<=join_s00002243_input_s00001167] | EG [callToTask_s00001360_output_s00001054<=0]]] & [~ [E [~ [callToTask_s00003978_output_s00001077<=0] U [~ [E [true U 1<=fork_s00001298_input_s00001068]] & ~ [callToTask_s00003978_output_s00001077<=0]]]] & ~ [EG [~ [callToTask_s00003978_output_s00001077<=0]]]]]]] U [E [[~ [[~ [E [~ [callToTask_s00001360_output_s00001077<=0] U [~ [1<=callToTask_s00003980_inputCriterion_s00001053_used] & ~ [callToTask_s00001360_output_s00001077<=0]]]] & ~ [EG [~ [callToTask_s00001360_output_s00001077<=0]]]]] & ~ [EG [~ [[~ [E [~ [callToTask_s00003961_output_s00001080<=callToTask_s00003971_input_s00001066] U [~ [callToTask_s00003961_output_s00001080<=callToTask_s00003971_input_s00001066] & ~ [callToTask_s00003962_inputCriterion_s00001053_used<=0]]]] & ~ [EG [~ [callToTask_s00003961_output_s00001080<=callToTask_s00003971_input_s00001066]]]]]]]] U EG [E [true U join_s00001164_input_s00001052<=callToTask_s00003962_input_s00001068]]] | EG [EG [[callToTask_s00003908_input_s00001052<=1 | ~ [E [true U ~ [1<=callToTask_s00003979_output_s00001054]]]]]]]]

abstracting: (1<=callToTask_s00003979_output_s00001054)
states: 233,831,352,060,018 (14)
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393932 kB
MemFree: 4572804 kB
After kill :
MemTotal: 16393932 kB
MemFree: 16181764 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.003sec


iterations count:8948 (49), effective:1199 (6)

initing FirstDep: 0m 0.001sec


net_ddint.h:600: Timeout: after 203 sec


net_ddint.h:600: Timeout: after 190 sec


sat_reach.icc:155: Timeout: after 178 sec


net_ddint.h:600: Timeout: after 166 sec


sat_reach.icc:155: Timeout: after 156 sec


net_ddint.h:600: Timeout: after 146 sec


net_ddint.h:600: Timeout: after 137 sec


sat_reach.icc:155: Timeout: after 128 sec


sat_reach.icc:155: Timeout: after 120 sec


sat_reach.icc:155: Timeout: after 112 sec


net_ddint.h:600: Timeout: after 105 sec


sat_reach.icc:155: Timeout: after 98 sec


net_ddint.h:600: Timeout: after 92 sec


sat_reach.icc:155: Timeout: after 86 sec


sat_reach.icc:155: Timeout: after 80 sec


sat_reach.icc:155: Timeout: after 75 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="IBMB2S565S3960-PT-none"
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 IBMB2S565S3960-PT-none, 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 r225-tall-167856407100097"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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