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.r394-oct2-167903717800385.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.......................
=====================================================================
Generated by BenchKit 2-5348
Executing tool marciexred
Input is ShieldPPPs-PT-003A, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r394-oct2-167903717800385
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 500K
-rw-r--r-- 1 mcc users 7.3K Feb 26 01:56 CTLCardinality.txt
-rw-r--r-- 1 mcc users 82K Feb 26 01:56 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.8K Feb 26 01:55 CTLFireability.txt
-rw-r--r-- 1 mcc users 55K Feb 26 01:55 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:41 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K Jan 29 11:41 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.7K Feb 25 16:58 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Feb 25 16:58 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.1K Feb 25 16:58 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Feb 25 16:58 LTLFireability.xml
-rw-r--r-- 1 mcc users 12K Feb 26 01:57 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 124K Feb 26 01:57 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 8.3K Feb 26 01:57 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 76K Feb 26 01:57 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 25 16:58 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Feb 25 16:58 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 equiv_col
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 27K Mar 5 18:23 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 ShieldPPPs-PT-003A-CTLCardinality-00
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-01
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-02
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-03
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-04
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-05
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-06
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-07
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-08
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-09
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-10
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-11
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-12
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-13
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-14
FORMULA_NAME ShieldPPPs-PT-003A-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1679508897135

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=marciexred
BK_EXAMINATION=CTLCardinality
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=3600
BK_INPUT=ShieldPPPs-PT-003A
Applying reductions before tool marcie
Invoking reducer
Running Version 202303021504
[2023-03-22 18:15:00] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -timeout, 360, -rebuildPNML]
[2023-03-22 18:15:00] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-22 18:15:00] [INFO ] Load time of PNML (sax parser for PT used): 65 ms
[2023-03-22 18:15:00] [INFO ] Transformed 96 places.
[2023-03-22 18:15:00] [INFO ] Transformed 81 transitions.
[2023-03-22 18:15:00] [INFO ] Found NUPN structural information;
[2023-03-22 18:15:00] [INFO ] Parsed PT model containing 96 places and 81 transitions and 306 arcs in 238 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 23 ms.
Support contains 68 out of 96 places. Attempting structural reductions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 14 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
// Phase 1: matrix 81 rows 96 cols
[2023-03-22 18:15:00] [INFO ] Computed 34 place invariants in 6 ms
[2023-03-22 18:15:01] [INFO ] Implicit Places using invariants in 537 ms returned []
[2023-03-22 18:15:01] [INFO ] Invariant cache hit.
[2023-03-22 18:15:01] [INFO ] Implicit Places using invariants and state equation in 324 ms returned []
Implicit Place search using SMT with State Equation took 914 ms to find 0 implicit places.
[2023-03-22 18:15:01] [INFO ] Invariant cache hit.
[2023-03-22 18:15:01] [INFO ] Dead Transitions using invariants and state equation in 480 ms found 0 transitions.
Finished structural reductions in LTL mode , in 1 iterations and 1411 ms. Remains : 96/96 places, 81/81 transitions.
Support contains 68 out of 96 places after structural reductions.
[2023-03-22 18:15:02] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 56 ms
[2023-03-22 18:15:02] [INFO ] Initial state reduction rules for CTL removed 2 formulas.
FORMULA ShieldPPPs-PT-003A-CTLCardinality-09 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldPPPs-PT-003A-CTLCardinality-04 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldPPPs-PT-003A-CTLCardinality-01 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 13 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Support contains 53 out of 96 places (down from 68) after GAL structural reductions.
FORMULA ShieldPPPs-PT-003A-CTLCardinality-11 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Finished random walk after 668 steps, including 2 resets, run visited all 40 properties in 112 ms. (steps per millisecond=5 )
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 22 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 64 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Computed a total of 1 stabilizing places and 1 stable transitions
Starting structural reductions in SI_CTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Reduce places removed 1 places and 1 transitions.
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 0 with 2 rules applied. Total rules applied 2 place count 94 transition count 79
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 0 with 2 rules applied. Total rules applied 4 place count 93 transition count 78
Applied a total of 4 rules in 18 ms. Remains 93 /96 variables (removed 3) and now considering 78/81 (removed 3) transitions.
Finished structural reductions in SI_CTL mode , in 1 iterations and 18 ms. Remains : 93/96 places, 78/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 78 transitions.
Finished random walk after 24 steps, including 0 resets, run visited all 1 properties in 2 ms. (steps per millisecond=12 )
FORMULA ShieldPPPs-PT-003A-CTLCardinality-00 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 2 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 2 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 2 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 2 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 2 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 2 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in SI_CTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Reduce places removed 1 places and 1 transitions.
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 0 with 2 rules applied. Total rules applied 2 place count 94 transition count 79
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 0 with 2 rules applied. Total rules applied 4 place count 93 transition count 78
Applied a total of 4 rules in 8 ms. Remains 93 /96 variables (removed 3) and now considering 78/81 (removed 3) transitions.
Finished structural reductions in SI_CTL mode , in 1 iterations and 8 ms. Remains : 93/96 places, 78/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 78 transitions.
Starting structural reductions in SI_CTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 0 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 0 with 4 rules applied. Total rules applied 4 place count 94 transition count 79
Applied a total of 4 rules in 5 ms. Remains 94 /96 variables (removed 2) and now considering 79/81 (removed 2) transitions.
Finished structural reductions in SI_CTL mode , in 1 iterations and 5 ms. Remains : 94/96 places, 79/81 transitions.
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:02] [INFO ] Input system was already deterministic with 79 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 1 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:03] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in LTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Applied a total of 0 rules in 1 ms. Remains 96 /96 variables (removed 0) and now considering 81/81 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 1 ms. Remains : 96/96 places, 81/81 transitions.
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:03] [INFO ] Input system was already deterministic with 81 transitions.
Starting structural reductions in SI_CTL mode, iteration 0 : 96/96 places, 81/81 transitions.
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 0 with 4 rules applied. Total rules applied 4 place count 94 transition count 79
Applied a total of 4 rules in 5 ms. Remains 94 /96 variables (removed 2) and now considering 79/81 (removed 2) transitions.
Finished structural reductions in SI_CTL mode , in 1 iterations and 5 ms. Remains : 94/96 places, 79/81 transitions.
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 4 ms
[2023-03-22 18:15:03] [INFO ] Input system was already deterministic with 79 transitions.
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:03] [INFO ] Flatten gal took : 5 ms
[2023-03-22 18:15:03] [INFO ] Export to MCC of 11 properties in file /home/mcc/execution/CTLCardinality.sr.xml took 2 ms.
[2023-03-22 18:15:03] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml of net with 96 places, 81 transitions and 306 arcs took 1 ms.
Total runtime 2962 ms.
There are residual formulas that ITS could not solve within timeout
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//../reducer/bin//../../marcie/bin/marcie --net-file=model.pnml --mcc-file=CTLCardinality.xml --memory=6 --mcc-mode

parse successfull
net created successfully

Net: Petri
(NrP: 96 NrTr: 81 NrArc: 306)

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

net check time: 0m 0.008sec

init dd package: 0m 2.883sec


RS generation: 0m33.165sec


-> reachability set: #nodes 13607 (1.4e+04) #states 61,292,908,391,850 (13)



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

checking: AG [[[p58<=0 & 0<=p58] | EG [AF [~ [[p3<=0 & 0<=p3]]]]]]
normalized: ~ [E [true U ~ [[EG [~ [EG [[p3<=0 & 0<=p3]]]] | [p58<=0 & 0<=p58]]]]]

abstracting: (0<=p58)
states: 61,292,908,391,850 (13)
abstracting: (p58<=0)
states: 45,986,374,649,358 (13)
abstracting: (0<=p3)
states: 61,292,908,391,850 (13)
abstracting: (p3<=0)
states: 31,065,469,568,533 (13)
.........................
before gc: list nodes free: 19668

after gc: idd nodes used:939378, unused:63060622; list nodes free:291421107
................
before gc: list nodes free: 1371900

after gc: idd nodes used:1381592, unused:62618408; list nodes free:289445104
............
before gc: list nodes free: 1988151

after gc: idd nodes used:2200470, unused:61799530; list nodes free:285741047
.......
before gc: list nodes free: 2134320

after gc: idd nodes used:2650432, unused:61349568; list nodes free:283689909
MC time: 5m25.590sec

checking: EG [AF [EX [[[p19<=0 & 0<=p19] | [[p58<=0 & 0<=p58] & [p70<=1 & 1<=p70]]]]]]
normalized: EG [~ [EG [~ [EX [[[[p70<=1 & 1<=p70] & [p58<=0 & 0<=p58]] | [p19<=0 & 0<=p19]]]]]]]

abstracting: (0<=p19)
states: 61,292,908,391,850 (13)
abstracting: (p19<=0)
states: 36,970,174,191,740 (13)
abstracting: (0<=p58)
states: 61,292,908,391,850 (13)
abstracting: (p58<=0)
states: 45,986,374,649,358 (13)
abstracting: (1<=p70)
states: 24,607,689,445,730 (13)
abstracting: (p70<=1)
states: 61,292,908,391,850 (13)
...............................
before gc: list nodes free: 1479591

after gc: idd nodes used:1058787, unused:62941213; list nodes free:290876230
......................................
before gc: list nodes free: 2102502

after gc: idd nodes used:1256309, unused:62743691; list nodes free:289963198
..............................................................................................
before gc: list nodes free: 1044746

after gc: idd nodes used:253248, unused:63746752; list nodes free:294529798
....................................................
EG iterations: 214
..................MC time: 4m55.017sec

checking: EG [[AG [AF [[[p35<=0 & 0<=p35] | [p63<=1 & 1<=p63]]]] | [p75<=0 & 0<=p75]]]
normalized: EG [[[p75<=0 & 0<=p75] | ~ [E [true U EG [~ [[[p63<=1 & 1<=p63] | [p35<=0 & 0<=p35]]]]]]]]

abstracting: (0<=p35)
states: 61,292,908,391,850 (13)
abstracting: (p35<=0)
states: 30,423,260,095,064 (13)
abstracting: (1<=p63)
states: 15,228,868,363,664 (13)
abstracting: (p63<=1)
states: 61,292,908,391,850 (13)
..........................
before gc: list nodes free: 1873755

after gc: idd nodes used:999956, unused:63000044; list nodes free:293150563
.............
before gc: list nodes free: 1433598

after gc: idd nodes used:1981992, unused:62018008; list nodes free:288612436
........
before gc: list nodes free: 989785

after gc: idd nodes used:2359366, unused:61640634; list nodes free:286834628
MC time: 4m29.767sec

checking: EG [E [[[p7<=0 & 0<=p7] | [p93<=1 & 1<=p93]] U A [[p87<=1 & 1<=p87] U EG [AX [[p66<=1 & 1<=p66]]]]]]
normalized: EG [E [[[p93<=1 & 1<=p93] | [p7<=0 & 0<=p7]] U [~ [EG [~ [EG [~ [EX [~ [[p66<=1 & 1<=p66]]]]]]]] & ~ [E [~ [EG [~ [EX [~ [[p66<=1 & 1<=p66]]]]]] U [~ [[p87<=1 & 1<=p87]] & ~ [EG [~ [EX [~ [[p66<=1 & 1<=p66]]]]]]]]]]]]

abstracting: (1<=p66)
states: 30,827,535,994,102 (13)
abstracting: (p66<=1)
states: 61,292,908,391,850 (13)
............................
before gc: list nodes free: 1725935

after gc: idd nodes used:1961304, unused:62038696; list nodes free:288762003
......
before gc: list nodes free: 914414

after gc: idd nodes used:3046690, unused:60953310; list nodes free:283741951
.MC time: 4m 4.692sec

checking: [EG [[[p74<=0 & 0<=p74] | [p6<=1 & 1<=p6]]] | AX [[[p46<=0 & 0<=p46] & [p63<=1 & 1<=p63]]]]
normalized: [~ [EX [~ [[[p63<=1 & 1<=p63] & [p46<=0 & 0<=p46]]]]] | EG [[[p6<=1 & 1<=p6] | [p74<=0 & 0<=p74]]]]

abstracting: (0<=p74)
states: 61,292,908,391,850 (13)
abstracting: (p74<=0)
states: 36,737,966,188,351 (13)
abstracting: (1<=p6)
states: 24,434,177,099,409 (13)
abstracting: (p6<=1)
states: 61,292,908,391,850 (13)
.............................................
before gc: list nodes free: 2367528

after gc: idd nodes used:863589, unused:63136411; list nodes free:293857167
..........................
before gc: list nodes free: 3586856

after gc: idd nodes used:1015414, unused:62984586; list nodes free:293158110
..MC time: 3m41.047sec

checking: AX [[~ [A [[[p36<=1 & 1<=p36] | [p50<=1 & 1<=p50]] U AF [[p4<=1 & 1<=p4]]]] & [EX [[p0<=1 & 1<=p0]] | EG [[p53<=0 & 0<=p53]]]]]
normalized: ~ [EX [~ [[[EG [[p53<=0 & 0<=p53]] | EX [[p0<=1 & 1<=p0]]] & ~ [[~ [EG [EG [~ [[p4<=1 & 1<=p4]]]]] & ~ [E [EG [~ [[p4<=1 & 1<=p4]]] U [~ [[[p50<=1 & 1<=p50] | [p36<=1 & 1<=p36]]] & EG [~ [[p4<=1 & 1<=p4]]]]]]]]]]]]

abstracting: (1<=p4)
states: 31,065,469,568,532 (13)
abstracting: (p4<=1)
states: 61,292,908,391,850 (13)
.........................
before gc: list nodes free: 3677680

after gc: idd nodes used:993572, unused:63006428; list nodes free:293154448
................
before gc: list nodes free: 3567877

after gc: idd nodes used:1442243, unused:62557757; list nodes free:291247610
.MC time: 3m21.512sec

checking: AG [AF [EG [A [[[[p31<=0 & 0<=p31] | [p6<=1 & 1<=p6]] | [[p37<=0 & 0<=p37] | [p5<=1 & 1<=p5]]] U [p20<=1 & 1<=p20]]]]]
normalized: ~ [E [true U EG [~ [EG [[~ [EG [~ [[p20<=1 & 1<=p20]]]] & ~ [E [~ [[p20<=1 & 1<=p20]] U [~ [[[[p5<=1 & 1<=p5] | [p37<=0 & 0<=p37]] | [[p6<=1 & 1<=p6] | [p31<=0 & 0<=p31]]]] & ~ [[p20<=1 & 1<=p20]]]]]]]]]]]

abstracting: (1<=p20)
states: 15,597,788,779,200 (13)
abstracting: (p20<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p31)
states: 61,292,908,391,850 (13)
abstracting: (p31<=0)
states: 45,954,200,323,071 (13)
abstracting: (1<=p6)
states: 24,434,177,099,409 (13)
abstracting: (p6<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p37)
states: 61,292,908,391,850 (13)
abstracting: (p37<=0)
states: 36,723,514,204,053 (13)
abstracting: (1<=p5)
states: 12,285,897,063,095 (13)
abstracting: (p5<=1)
states: 61,292,908,391,850 (13)
abstracting: (1<=p20)
states: 15,597,788,779,200 (13)
abstracting: (p20<=1)
states: 61,292,908,391,850 (13)
abstracting: (1<=p20)
states: 15,597,788,779,200 (13)
abstracting: (p20<=1)
states: 61,292,908,391,850 (13)
..........................................
before gc: list nodes free: 2266611

after gc: idd nodes used:671901, unused:63328099; list nodes free:294668958
.................................................MC time: 3m 3.018sec

checking: EF [AX [~ [A [[[[p87<=0 & 0<=p87] | [p84<=1 & 1<=p84]] | [[p66<=1 & 1<=p66] | AF [[[p46<=0 & 0<=p46] | [p14<=1 & 1<=p14]]]]] U EG [[p87<=0 & 0<=p87]]]]]]
normalized: E [true U ~ [EX [[~ [EG [~ [EG [[p87<=0 & 0<=p87]]]]] & ~ [E [~ [EG [[p87<=0 & 0<=p87]]] U [~ [[[[p84<=1 & 1<=p84] | [p87<=0 & 0<=p87]] | [~ [EG [~ [[[p14<=1 & 1<=p14] | [p46<=0 & 0<=p46]]]]] | [p66<=1 & 1<=p66]]]] & ~ [EG [[p87<=0 & 0<=p87]]]]]]]]]]

abstracting: (0<=p87)
states: 61,292,908,391,850 (13)
abstracting: (p87<=0)
states: 30,827,535,994,103 (13)
.........
before gc: list nodes free: 2551097

after gc: idd nodes used:269420, unused:63730580; list nodes free:296550757
...................
before gc: list nodes free: 1964074

after gc: idd nodes used:2270258, unused:61729742; list nodes free:287298851
.MC time: 2m46.361sec

checking: [EF [~ [E [[[p73<=0 & 0<=p73] | [p37<=1 & 1<=p37]] U [p39<=1 & 1<=p39]]]] & [AF [[[[[p64<=0 & 0<=p64] & [p10<=0 & 0<=p10]] | EG [[p9<=1 & 1<=p9]]] & AG [[p16<=0 & 0<=p16]]]] | AX [EX [[[p25<=0 & 0<=p25] | [p81<=1 & 1<=p81]]]]]]
normalized: [[~ [EX [~ [EX [[[p81<=1 & 1<=p81] | [p25<=0 & 0<=p25]]]]]] | ~ [EG [~ [[~ [E [true U ~ [[p16<=0 & 0<=p16]]]] & [EG [[p9<=1 & 1<=p9]] | [[p10<=0 & 0<=p10] & [p64<=0 & 0<=p64]]]]]]]] & E [true U ~ [E [[[p37<=1 & 1<=p37] | [p73<=0 & 0<=p73]] U [p39<=1 & 1<=p39]]]]]

abstracting: (1<=p39)
states: 24,611,300,530,507 (13)
abstracting: (p39<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p73)
states: 61,292,908,391,850 (13)
abstracting: (p73<=0)
states: 36,857,426,289,251 (13)
abstracting: (1<=p37)
states: 24,569,394,187,797 (13)
abstracting: (p37<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p64)
states: 61,292,908,391,850 (13)
abstracting: (p64<=0)
states: 46,047,753,216,248 (13)
abstracting: (0<=p10)
states: 61,292,908,391,850 (13)
abstracting: (p10<=0)
states: 49,107,644,932,441 (13)
abstracting: (1<=p9)
states: 24,190,187,735,607 (13)
abstracting: (p9<=1)
states: 61,292,908,391,850 (13)
........................
before gc: list nodes free: 767471

after gc: idd nodes used:800805, unused:63199195; list nodes free:294129585
...................MC time: 2m31.023sec

checking: E [[p25<=1 & 1<=p25] U [AF [[[[p90<=0 & 0<=p90] | [p12<=1 & 1<=p12]] & EX [~ [[p77<=0 & 0<=p77]]]]] & [~ [AX [A [[p40<=1 & 1<=p40] U [p87<=1 & 1<=p87]]]] | [EG [[[[[p51<=0 & 0<=p51] | [p67<=1 & 1<=p67]] | [[p21<=0 & 0<=p21] | [p45<=1 & 1<=p45]]] & AX [[[p59<=0 & 0<=p59] | [p71<=1 & 1<=p71]]]]] | EG [AF [[p67<=1 & 1<=p67]]]]]]]
normalized: E [[p25<=1 & 1<=p25] U [[[EG [~ [EG [~ [[p67<=1 & 1<=p67]]]]] | EG [[~ [EX [~ [[[p71<=1 & 1<=p71] | [p59<=0 & 0<=p59]]]]] & [[[p45<=1 & 1<=p45] | [p21<=0 & 0<=p21]] | [[p67<=1 & 1<=p67] | [p51<=0 & 0<=p51]]]]]] | EX [~ [[~ [EG [~ [[p87<=1 & 1<=p87]]]] & ~ [E [~ [[p87<=1 & 1<=p87]] U [~ [[p40<=1 & 1<=p40]] & ~ [[p87<=1 & 1<=p87]]]]]]]]] & ~ [EG [~ [[EX [~ [[p77<=0 & 0<=p77]]] & [[p12<=1 & 1<=p12] | [p90<=0 & 0<=p90]]]]]]]]

abstracting: (0<=p90)
states: 61,292,908,391,850 (13)
abstracting: (p90<=0)
states: 46,139,018,789,404 (13)
abstracting: (1<=p12)
states: 24,489,206,062,761 (13)
abstracting: (p12<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p77)
states: 61,292,908,391,850 (13)
abstracting: (p77<=0)
states: 48,962,745,197,170 (13)
.................................
before gc: list nodes free: 2696606

after gc: idd nodes used:396354, unused:63603646; list nodes free:295979304
................................................................
before gc: list nodes free: 3417464

after gc: idd nodes used:617816, unused:63382184; list nodes free:294968862
.MC time: 2m17.095sec

checking: EG [[[E [~ [AG [[[p34<=0 & 0<=p34] | [p58<=1 & 1<=p58]]]] U AX [~ [[[p70<=0 & 0<=p70] | [p48<=1 & 1<=p48]]]]] | [EF [AG [[p89<=0 & 0<=p89]]] & ~ [E [[[p59<=0 & 0<=p59] | [[0<=p90 & p90<=0] | [p45<=1 & 1<=p45]]] U [[p79<=1 & 1<=p79] | [p30<=1 & 1<=p30]]]]]] & [AG [[[[p86<=1 & 1<=p86] & [[p22<=0 & 0<=p22] & [p44<=1 & 1<=p44]]] | [p49<=1 & 1<=p49]]] | [[p50<=0 & 0<=p50] | [p7<=1 & 1<=p7]]]]]
normalized: EG [[[[[p7<=1 & 1<=p7] | [p50<=0 & 0<=p50]] | ~ [E [true U ~ [[[p49<=1 & 1<=p49] | [[[p44<=1 & 1<=p44] & [p22<=0 & 0<=p22]] & [p86<=1 & 1<=p86]]]]]]] & [[~ [E [[[[p45<=1 & 1<=p45] | [0<=p90 & p90<=0]] | [p59<=0 & 0<=p59]] U [[p30<=1 & 1<=p30] | [p79<=1 & 1<=p79]]]] & E [true U ~ [E [true U ~ [[p89<=0 & 0<=p89]]]]]] | E [E [true U ~ [[[p58<=1 & 1<=p58] | [p34<=0 & 0<=p34]]]] U ~ [EX [[[p48<=1 & 1<=p48] | [p70<=0 & 0<=p70]]]]]]]]

abstracting: (0<=p70)
states: 61,292,908,391,850 (13)
abstracting: (p70<=0)
states: 36,685,218,946,120 (13)
abstracting: (1<=p48)
states: 24,419,000,269,014 (13)
abstracting: (p48<=1)
states: 61,292,908,391,850 (13)
.abstracting: (0<=p34)
states: 61,292,908,391,850 (13)
abstracting: (p34<=0)
states: 30,869,648,296,787 (13)
abstracting: (1<=p58)
states: 15,306,533,742,492 (13)
abstracting: (p58<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p89)
states: 61,292,908,391,850 (13)
abstracting: (p89<=0)
states: 45,961,130,282,080 (13)
abstracting: (1<=p79)
states: 24,428,021,100,901 (13)
abstracting: (p79<=1)
states: 61,292,908,391,850 (13)
abstracting: (1<=p30)
states: 15,793,824,722,124 (13)
abstracting: (p30<=1)
states: 61,292,908,391,850 (13)
abstracting: (0<=p59)
states: 61,292,908,391,850 (13)
abstracting: (p59<=0)
states: 46,134,020,952,657 (13)
abstracting: (p90<=0)
states: 46,139,018,789,404 (13)
abstracting: (0<=p90)
states: 61,292,908,391,850 (13)
abstracting: (1<=p45)
states: 24,391,967,742,963 (13)
abstracting: (p45<=1)
states: 61,292,908,391,850 (13)
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393220 kB
MemFree: 6060024 kB
After kill :
MemTotal: 16393220 kB
MemFree: 16101616 kB

BK_TIME_CONFINEMENT_REACHED

--------------------
content from stderr:

+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
+ VERSION=202303021504
+ echo 'Running Version 202303021504'
+ /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/its-tools -pnfolder /home/mcc/execution -examination CTLCardinality -timeout 360 -rebuildPNML
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

82879 33423 26287 21294
iterations count:408982 (5049), effective:77392 (955)

initing FirstDep: 0m 0.000sec


net_ddint.h:600: Timeout: after 324 sec


net_ddint.h:600: Timeout: after 294 sec


net_ddint.h:600: Timeout: after 267 sec


net_ddint.h:600: Timeout: after 243 sec


net_ddint.h:600: Timeout: after 220 sec


ctl_mc.icc:221: Timeout: after 200 sec


iterations count:4283 (52), effective:654 (8)

net_ddint.h:600: Timeout: after 182 sec


net_ddint.h:600: Timeout: after 165 sec


iterations count:3813 (47), effective:572 (7)

iterations count:15431 (190), effective:2549 (31)

net_ddint.h:600: Timeout: after 150 sec


net_ddint.h:600: Timeout: after 136 sec


iterations count:8187 (101), effective:1472 (18)

iterations count:45144 (557), effective:8883 (109)

iterations count:12122 (149), effective:2062 (25)

iterations count:37623 (464), effective:6917 (85)

sat_reach.icc:155: Timeout: after 124 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="ShieldPPPs-PT-003A"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="marciexred"
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 marciexred"
echo " Input is ShieldPPPs-PT-003A, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r394-oct2-167903717800385"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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