About the Execution of M4M.full for DrinkVendingMachine-PT-10
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
8796.390 | 2345258.00 | 3732475.00 | 2953.80 | FTFT?FTFFTTF??TT | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Waiting for the VM to be ready (probing ssh)
.................
/home/mcc/execution
total 205M
-rw-r--r-- 1 mcc users 13K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 49K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 13M May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 34M May 15 18:54 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K May 15 18:50 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.1K May 15 18:50 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 6.1K May 15 18:54 LTLCardinality.txt
-rw-r--r-- 1 mcc users 21K May 15 18:54 LTLCardinality.xml
-rw-r--r-- 1 mcc users 464K May 15 18:54 LTLFireability.txt
-rw-r--r-- 1 mcc users 1.2M May 15 18:54 LTLFireability.xml
-rw-r--r-- 1 mcc users 13K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 46K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 116 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 354 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 6.5M May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 18M May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 3.9K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 9.1K May 15 18:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 15 18:50 equiv_col
-rw-r--r-- 1 mcc users 3 May 15 18:50 instance
-rw-r--r-- 1 mcc users 6 May 15 18:50 iscolored
-rw-r--r-- 1 mcc users 134M May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool mcc4mcc-full
Input is DrinkVendingMachine-PT-10, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r082-blw3-152649949700374
=====================================================================
--------------------
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 DrinkVendingMachine-PT-10-CTLCardinality-00
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-01
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-02
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-03
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-04
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-05
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-06
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-07
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-08
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-09
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-10
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-11
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-12
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-13
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-14
FORMULA_NAME DrinkVendingMachine-PT-10-CTLCardinality-15
=== Now, execution of the tool begins
BK_START 1527418159309
BK_STOP 1527420504567
--------------------
content from stderr:
Prefix is 65b80f64.
Reading known information in /usr/share/mcc4mcc/65b80f64-known.json.
Reading learned information in /usr/share/mcc4mcc/65b80f64-learned.json.
Reading value translations in /usr/share/mcc4mcc/65b80f64-values.json.
Using directory /home/mcc/execution for input, as it contains a model.pnml file.
Using DrinkVendingMachine-PT-10 as instance name.
Using DrinkVendingMachine as model name.
Using algorithm or tool bmdt.
Model characteristics are: {'Examination': 'CTLCardinality', 'Place/Transition': True, 'Colored': True, 'Relative-Time': 1, 'Relative-Memory': 1, 'Ordinary': False, 'Simple Free Choice': False, 'State Machine': False, 'Marked Graph': False, 'Extended Free Choice': False, 'Connected': True, 'Strongly Connected': True, 'Source Place': False, 'Sink Place': False, 'Source Transition': False, 'Sink Transition': False, 'Loop Free': True, 'Conservative': True, 'Sub-Conservative': True, 'Nested Units': False, 'Safe': True, 'Deadlock': False, 'Reversible': True, 'Quasi Live': None, 'Live': None}.
Known tools are: [{'Time': 3539921, 'Memory': 10061.1, 'Tool': 'lola'}, {'Time': 3540133, 'Memory': 9965.29, 'Tool': 'lola'}].
Learned tools are: [{'Tool': 'lola'}].
Learned tool lola is 1.0x far from the best tool lola.
CTLCardinality lola DrinkVendingMachine-PT-10...
Time: 3600 - MCC
----- Start make prepare stdout -----
----- Start make prepare stderr -----
===========================================================================================
DrinkVendingMachine-PT-10: translating PT Petri net model.pnml into LoLA format
===========================================================================================
translating PT Petri net complete
checking for too many tokens
===========================================================================================
DrinkVendingMachine-PT-10: translating PT formula CTLCardinality into LoLA format
===========================================================================================
translating formula complete
touch formulae;
----- Start make result stdout -----
CTLCardinality @ DrinkVendingMachine-PT-10 @ 3537 seconds
----- Start make result stderr -----
----- Start make result stdout -----
----- Start make result stderr -----
lola: LoLA will run for 3537 seconds at most (--timelimit)
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 111280/65536 symbol table entries, 66439 collisions
lola: preprocessing...
lola: finding significant places
lola: 120 places, 111160 transitions, 60 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 48320 transition conflict sets
lola: TASK
lola: reading formula from DrinkVendingMachine-PT-10-CTLCardinality.task
lola: ((3 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9) OR A (G (((productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1 <= ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40) AND (1 <= theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9) AND (productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1 <= 1))))) : (((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1) OR E (X (((optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10) AND (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1))))) OR ((A (G ((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10))) OR E (G ((1 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9)))) OR ((theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1) OR E (G ((1 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10)))))) : NOT(A (X (((optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9 <= 1) OR (ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40 <= wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9))))) : NOT(A (G ((2 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10)))) : E (F (A (G ((3 <= ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40))))) : A (F ((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10))) : E ((E (G (TRUE)) U (((2 <= theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9) AND (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9)) OR (theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9)))) : A (F (((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 + 1 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9) OR (theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10 + 1 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1) OR ((ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40 + 1 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1) AND (ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40 + 1 <= wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9))))) : E (F (A (G ((ready_33 <= 0))))) : A (X ((((theProducts_6 + 1 <= wait_3) OR (ready_4 <= 1)) AND ((ready_10 <= 1) OR (wait_14 + 1 <= wait_36))))) : NOT(NOT(NOT(A (F ((3 <= theOptions_9)))))) : (A (F (((ready_22 <= 2) AND (wait_26 + 1 <= productSlots_10)))) AND A (G (((theOptions_4 <= ready_22) OR (1 <= wait_4) OR (optionSlots_10 <= theOptions_3))))) : (A (G (((wait_30 <= 2) OR ((3 <= productSlots_9) AND (productSlots_4 <= ready_22))))) AND (((productSlots_8 <= wait_2) OR A (F ((wait_32 <= ready_40)))) OR A (F (((3 <= productSlots_4) OR (1 <= wait_14)))))) : (NOT(E (F ((1 <= ready_38)))) OR E (F (((2 <= theProducts_3) AND (1 <= wait_15))))) : A (X (E (((ready_26 <= theProducts_8) U (optionSlots_2 <= wait_21))))) : E (G (((ready_24 <= productSlots_7) AND (wait_25 <= wait_1))))
lola: computing a collection of formulas
lola: RUNNING
lola: subprocess 0 will run for 219 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: ((3 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9) OR A (G (((productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1 <= ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 0 will run for 219 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (3 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: (3 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9)
lola: processed formula length: 165
lola: 0 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 1 will run for 234 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (G (((productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1 <= ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 ... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 3 literals and 3 conjunctive subformulas
lola: state equation: write sara problem file to DrinkVendingMachine-PT-10-CTLCardinality.sara
lola: state equation: calling and running sara
sara: try reading problem file DrinkVendingMachine-PT-10-CTLCardinality.sara.
lola: sara is running 0 secs || 2 markings, 1 edges, 0 markings/sec, 0 secs
lola: SUBRESULT
lola: result: no
lola: produced by: state space
lola: The predicate is not invariant.
lola: 3 markings, 2 edges
lola: ========================================
lola: SUBRESULT
lola: result: no
lola: The Boolean predicate is false.
lola: ========================================
lola: subprocess 1 will run for 234 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= produ... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 1 will run for 234 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= product... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: (wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= product... (shortened)
lola: processed formula length: 562
lola: 2 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 2 will run for 250 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (X (((optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10) AND (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theO... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: EX(((optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10) AND (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOpti... (shortened)
lola: processed formula length: 655
lola: 3 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Formula contains EX or AX operators, stubborn sets not applicable
lola: RUNNING
lola: CTL formula contains 0 significant temporal operators and needs 0 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 0 markings, 0 edges, 3228173285975916544 markings/sec, 0 secs
lola: 0 markings, 0 edges, 0 markings/sec, 5 secs
lola: 0 markings, 0 edges, 0 markings/sec, 10 secs
lola: 0 markings, 0 edges, 0 markings/sec, 15 secs
lola: 0 markings, 0 edges, 0 markings/sec, 20 secs
lola: 0 markings, 0 edges, 0 markings/sec, 25 secs
lola: 0 markings, 0 edges, 0 markings/sec, 30 secs
lola: 0 markings, 0 edges, 0 markings/sec, 35 secs
lola: 0 markings, 0 edges, 0 markings/sec, 40 secs
lola: 0 markings, 0 edges, 0 markings/sec, 45 secs
lola: 0 markings, 0 edges, 0 markings/sec, 50 secs
lola: 0 markings, 0 edges, 0 markings/sec, 55 secs
lola: 0 markings, 0 edges, 0 markings/sec, 60 secs
lola: 0 markings, 0 edges, 0 markings/sec, 65 secs
lola: 0 markings, 0 edges, 0 markings/sec, 70 secs
lola: 0 markings, 0 edges, 0 markings/sec, 75 secs
lola: 0 markings, 0 edges, 0 markings/sec, 80 secs
lola: 0 markings, 0 edges, 0 markings/sec, 85 secs
lola: 0 markings, 0 edges, 0 markings/sec, 90 secs
lola: 0 markings, 0 edges, 0 markings/sec, 95 secs
lola: 0 markings, 0 edges, 0 markings/sec, 100 secs
lola: 0 markings, 0 edges, 0 markings/sec, 105 secs
lola: 0 markings, 0 edges, 0 markings/sec, 110 secs
lola: 0 markings, 0 edges, 0 markings/sec, 115 secs
lola: 0 markings, 0 edges, 0 markings/sec, 120 secs
lola: 0 markings, 0 edges, 0 markings/sec, 125 secs
lola: 0 markings, 0 edges, 0 markings/sec, 130 secs
lola: 0 markings, 0 edges, 0 markings/sec, 135 secs
lola: 0 markings, 0 edges, 0 markings/sec, 140 secs
lola: 0 markings, 0 edges, 0 markings/sec, 145 secs
lola: SUBRESULT
lola: result: no
lola: produced by: CTL model checker
lola: The net does not satisfy the given formula.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 3 will run for 258 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (G ((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= t... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: SUBRESULT
lola: result: no
lola: produced by: state space
lola: The predicate is not invariant.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 4 will run for 280 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (G ((1 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9)))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: NOT(A(TRUE U (optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9 <= 0)))
lola: processed formula length: 180
lola: 4 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 1 significant temporal operators and needs 5 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: SUBRESULT
lola: result: no
lola: produced by: CTL model checker
lola: The net does not satisfy the given formula.
lola: 1 markings, 0 edges
lola: ========================================
lola: subprocess 5 will run for 305 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1)
lola: processed formula length: 322
lola: 2 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 6 will run for 336 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (G ((1 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10)))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: NOT(A(TRUE U (theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10 <= 0)))
lola: processed formula length: 180
lola: 4 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 1 significant temporal operators and needs 5 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: SUBRESULT
lola: result: yes
lola: produced by: CTL model checker
lola: The net satisfies the given formula.
lola: 505 markings, 536 edges
lola: ========================================
lola: SUBRESULT
lola: result: yes
lola: The Boolean predicate is true.
lola: ========================================
lola: subprocess 2 will run for 240 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: NOT(A (X (((optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9 <= 1) OR (ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_2... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: EX(((2 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9) AND (wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_... (shortened)
lola: processed formula length: 1002
lola: 4 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Formula contains EX or AX operators, stubborn sets not applicable
lola: RUNNING
lola: CTL formula contains 0 significant temporal operators and needs 0 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 0 markings, 0 edges, 3689329903141912576 markings/sec, 0 secs
lola: 0 markings, 0 edges, 0 markings/sec, 5 secs
lola: 0 markings, 0 edges, 0 markings/sec, 10 secs
lola: 0 markings, 0 edges, 0 markings/sec, 15 secs
lola: 0 markings, 0 edges, 0 markings/sec, 20 secs
lola: 0 markings, 0 edges, 0 markings/sec, 25 secs
lola: 0 markings, 0 edges, 0 markings/sec, 30 secs
lola: 0 markings, 0 edges, 0 markings/sec, 35 secs
lola: 0 markings, 0 edges, 0 markings/sec, 40 secs
lola: 0 markings, 0 edges, 0 markings/sec, 45 secs
lola: 0 markings, 0 edges, 0 markings/sec, 50 secs
lola: 0 markings, 0 edges, 0 markings/sec, 55 secs
lola: 0 markings, 0 edges, 0 markings/sec, 60 secs
lola: 0 markings, 0 edges, 0 markings/sec, 65 secs
lola: 0 markings, 0 edges, 0 markings/sec, 70 secs
lola: 0 markings, 0 edges, 0 markings/sec, 75 secs
lola: 0 markings, 0 edges, 0 markings/sec, 80 secs
lola: 0 markings, 0 edges, 0 markings/sec, 85 secs
lola: 0 markings, 0 edges, 0 markings/sec, 90 secs
lola: 0 markings, 0 edges, 0 markings/sec, 95 secs
lola: 0 markings, 0 edges, 0 markings/sec, 100 secs
lola: 0 markings, 0 edges, 0 markings/sec, 105 secs
lola: 0 markings, 0 edges, 0 markings/sec, 110 secs
lola: 0 markings, 0 edges, 0 markings/sec, 115 secs
lola: 0 markings, 0 edges, 0 markings/sec, 120 secs
lola: 0 markings, 0 edges, 0 markings/sec, 125 secs
lola: 0 markings, 0 edges, 0 markings/sec, 130 secs
lola: SUBRESULT
lola: result: no
lola: produced by: CTL model checker
lola: The net does not satisfy the given formula.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 3 will run for 248 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: NOT(A (G ((2 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10))))
lola: ========================================
lola: SUBTASK
lola: checking reachability
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation: write sara problem file to DrinkVendingMachine-PT-10-CTLCardinality-3.sara
lola: state equation: calling and running sara
sara: try reading problem file DrinkVendingMachine-PT-10-CTLCardinality-3.sara.
lola: sara is running 0 secs || 2 markings, 1 edges, 0 markings/sec, 0 secs
lola: SUBRESULT
lola: result: yes
lola: produced by: state space
lola: The predicate is reachable.
lola: 10 markings, 9 edges
lola: ========================================
lola: subprocess 4 will run for 268 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (F (A (G ((3 <= ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking possible invariance
lola: possible invariance not yet implemented, converting to CTL...
lola: processed formula: E(TRUE U NOT(E(TRUE U (ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + r... (shortened)
lola: processed formula length: 460
lola: 3 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 2 significant temporal operators and needs 9 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 11203 markings, 24678 edges, 3225232092371615744 markings/sec, 0 secs
lola: 19331 markings, 55318 edges, 1626 markings/sec, 5 secs
lola: 26650 markings, 77150 edges, 1464 markings/sec, 10 secs
lola: 33604 markings, 102175 edges, 1391 markings/sec, 15 secs
lola: 40547 markings, 127339 edges, 1389 markings/sec, 20 secs
lola: 48225 markings, 153756 edges, 1536 markings/sec, 25 secs
lola: 54672 markings, 174741 edges, 1289 markings/sec, 30 secs
lola: 61597 markings, 194939 edges, 1385 markings/sec, 35 secs
lola: 68310 markings, 216262 edges, 1343 markings/sec, 40 secs
lola: 75355 markings, 240996 edges, 1409 markings/sec, 45 secs
lola: 83151 markings, 267572 edges, 1559 markings/sec, 50 secs
lola: 90553 markings, 289541 edges, 1480 markings/sec, 55 secs
lola: 97378 markings, 318556 edges, 1365 markings/sec, 60 secs
lola: 104338 markings, 339602 edges, 1392 markings/sec, 65 secs
lola: 111527 markings, 361052 edges, 1438 markings/sec, 70 secs
lola: 118130 markings, 382496 edges, 1321 markings/sec, 75 secs
lola: 125180 markings, 407070 edges, 1410 markings/sec, 80 secs
lola: 132098 markings, 431873 edges, 1384 markings/sec, 85 secs
lola: 138652 markings, 452235 edges, 1311 markings/sec, 90 secs
lola: 145010 markings, 472432 edges, 1272 markings/sec, 95 secs
lola: 151379 markings, 496354 edges, 1274 markings/sec, 100 secs
lola: 157760 markings, 516295 edges, 1276 markings/sec, 105 secs
lola: 164172 markings, 532295 edges, 1282 markings/sec, 110 secs
lola: 170604 markings, 556590 edges, 1286 markings/sec, 115 secs
lola: 177936 markings, 578231 edges, 1466 markings/sec, 120 secs
lola: 184863 markings, 603435 edges, 1385 markings/sec, 125 secs
lola: 191750 markings, 624917 edges, 1377 markings/sec, 130 secs
lola: 198557 markings, 653293 edges, 1361 markings/sec, 135 secs
lola: 205363 markings, 674119 edges, 1361 markings/sec, 140 secs
lola: 212226 markings, 690913 edges, 1373 markings/sec, 145 secs
lola: 218676 markings, 715287 edges, 1290 markings/sec, 150 secs
lola: 225200 markings, 739546 edges, 1305 markings/sec, 155 secs
lola: 231644 markings, 759781 edges, 1289 markings/sec, 160 secs
lola: 239121 markings, 1137950 edges, 1495 markings/sec, 165 secs
lola: 245124 markings, 1157417 edges, 1201 markings/sec, 170 secs
lola: 251502 markings, 1177265 edges, 1276 markings/sec, 175 secs
lola: 258180 markings, 1197824 edges, 1336 markings/sec, 180 secs
lola: 264513 markings, 1221822 edges, 1267 markings/sec, 185 secs
lola: 270892 markings, 1241896 edges, 1276 markings/sec, 190 secs
lola: 277166 markings, 1265773 edges, 1255 markings/sec, 195 secs
lola: 284175 markings, 1286921 edges, 1402 markings/sec, 200 secs
lola: 291268 markings, 1308276 edges, 1419 markings/sec, 205 secs
lola: 298218 markings, 1333446 edges, 1390 markings/sec, 210 secs
lola: 305104 markings, 1358616 edges, 1377 markings/sec, 215 secs
lola: 312145 markings, 1379800 edges, 1408 markings/sec, 220 secs
lola: 318772 markings, 1400456 edges, 1325 markings/sec, 225 secs
lola: 325048 markings, 1424229 edges, 1255 markings/sec, 230 secs
lola: 331397 markings, 1444280 edges, 1270 markings/sec, 235 secs
lola: 337719 markings, 1464247 edges, 1264 markings/sec, 240 secs
lola: 343988 markings, 1484067 edges, 1254 markings/sec, 245 secs
lola: 350284 markings, 1508086 edges, 1259 markings/sec, 250 secs
lola: 357312 markings, 1526164 edges, 1406 markings/sec, 255 secs
lola: 364056 markings, 1546817 edges, 1349 markings/sec, 260 secs
lola: local time limit reached - aborting
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 5 will run for 268 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (F ((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= t... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking LTL
lola: transforming LTL-Formula into a B\xfcchi-Automaton
lola: processed formula: A (F ((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10)))
lola: processed formula: A (F ((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 <= t... (shortened)
lola: processed formula length: 560
lola: 0 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: the resulting B\xfcchi automaton has 1 states
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 3 unused bits
lola: using a prefix tree store (--store=prefix)
lola: using ltl preserving stubborn set method (--stubborn)
lola: SEARCH
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: LTL model checker
lola: The net does not satisfy the given formula (language of the product automaton is nonempty).
lola: 190 markings, 190 edges
lola: ========================================
lola: subprocess 6 will run for 294 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E ((E (G (TRUE)) U (((2 <= theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9) AND (theOptions_10 + theOptions_1 + theOptions_2 + theOptions_3 + theOptions_4 + theOptions_5 + theOptions_6 + theOptions_7 + theOptions_8 + theOptions_9 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + o... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking reachability
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 3 literals and 2 conjunctive subformulas
lola: state equation: write sara problem file to DrinkVendingMachine-PT-10-CTLCardinality-6.sara
lola: state equation: calling and running sara
sara: try reading problem file DrinkVendingMachine-PT-10-CTLCardinality-6.sara.
lola: sara is running 0 secs || 1 markings, 0 edges, 0 markings/sec, 0 secs
lola: SUBRESULT
lola: result: yes
lola: produced by: state space
lola: The predicate is reachable.
lola: 3 markings, 2 edges
lola: ========================================
lola: subprocess 7 will run for 327 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (F (((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 + 1... (shortened)
lola: ========================================
lola: SUBTASK
lola: checking LTL
lola: transforming LTL-Formula into a B\xfcchi-Automaton
lola: processed formula: A (F (((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 + 1 <= optionSlots_10 + optionSlots_1 + optionSlots_2 + optionSlots_3 + optionSlots_4 + optionSlots_5 + optionSlots_6 + optionSlots_7 + optionSlots_8 + optionSlots_9) OR (theProducts_1 + theProducts_2 + theProducts_3 + theProducts_4 + theProducts_5 + theProducts_6 + theProducts_7 + theProducts_8 + theProducts_9 + theProducts_10 + 1 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1) OR ((ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40 + 1 <= productSlots_10 + productSlots_9 + productSlots_8 + productSlots_7 + productSlots_6 + productSlots_5 + productSlots_4 + productSlots_3 + productSlots_2 + productSlots_1) AND (ready_9 + ready_8 + ready_7 + ready_6 + ready_5 + ready_4 + ready_3 + ready_2 + ready_1 + ready_10 + ready_11 + ready_12 + ready_13 + ready_14 + ready_15 + ready_16 + ready_17 + ready_18 + ready_19 + ready_20 + ready_21 + ready_22 + ready_23 + ready_24 + ready_25 + ready_26 + ready_27 + ready_28 + ready_29 + ready_30 + ready_31 + ready_32 + ready_33 + ready_34 + ready_35 + ready_36 + ready_37 + ready_38 + ready_39 + ready_40 + 1 <= wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9)))))
lola: processed formula: A (F (((wait_10 + wait_11 + wait_12 + wait_13 + wait_14 + wait_15 + wait_16 + wait_17 + wait_18 + wait_19 + wait_20 + wait_21 + wait_22 + wait_23 + wait_24 + wait_25 + wait_26 + wait_27 + wait_28 + wait_29 + wait_30 + wait_31 + wait_32 + wait_33 + wait_34 + wait_35 + wait_36 + wait_37 + wait_38 + wait_39 + wait_40 + wait_1 + wait_2 + wait_3 + wait_4 + wait_5 + wait_6 + wait_7 + wait_8 + wait_9 + 1... (shortened)
lola: processed formula length: 2351
lola: 0 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: the resulting B\xfcchi automaton has 1 states
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 3 unused bits
lola: using a prefix tree store (--store=prefix)
lola: using ltl preserving stubborn set method (--stubborn)
lola: SEARCH
lola: RUNNING
lola: 3452 markings, 9671 edges, 690 markings/sec, 0 secs
lola: 6775 markings, 20681 edges, 665 markings/sec, 5 secs
lola: 9840 markings, 29935 edges, 613 markings/sec, 10 secs
lola: 12845 markings, 38965 edges, 601 markings/sec, 15 secs
lola: 15708 markings, 48774 edges, 573 markings/sec, 20 secs
lola: 18714 markings, 56944 edges, 601 markings/sec, 25 secs
lola: 21323 markings, 64689 edges, 522 markings/sec, 30 secs
lola: 23769 markings, 74873 edges, 489 markings/sec, 35 secs
lola: 26527 markings, 81837 edges, 552 markings/sec, 40 secs
lola: 29202 markings, 91487 edges, 535 markings/sec, 45 secs
lola: 31792 markings, 96359 edges, 518 markings/sec, 50 secs
lola: 34888 markings, 113469 edges, 619 markings/sec, 55 secs
lola: 38124 markings, 123055 edges, 647 markings/sec, 60 secs
lola: 41201 markings, 134738 edges, 615 markings/sec, 65 secs
lola: SUBRESULT
lola: result: no
lola: produced by: LTL model checker
lola: The net does not satisfy the given formula (language of the product automaton is nonempty).
lola: 42571 markings, 136541 edges
lola: ========================================
lola: subprocess 8 will run for 358 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (F (A (G ((ready_33 <= 0)))))
lola: ========================================
lola: SUBTASK
lola: checking possible invariance
lola: possible invariance not yet implemented, converting to CTL...
lola: processed formula: E(TRUE U NOT(E(TRUE U (1 <= ready_33))))
lola: processed formula length: 40
lola: 3 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 2 significant temporal operators and needs 9 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 2362 markings, 6772 edges, 3689320832170983424 markings/sec, 0 secs
lola: 4474 markings, 12953 edges, 422 markings/sec, 5 secs
lola: 6651 markings, 19728 edges, 435 markings/sec, 10 secs
lola: 8841 markings, 26935 edges, 438 markings/sec, 15 secs
lola: 11256 markings, 36605 edges, 483 markings/sec, 20 secs
lola: 13724 markings, 48128 edges, 494 markings/sec, 25 secs
lola: 16025 markings, 63327 edges, 460 markings/sec, 30 secs
lola: 18265 markings, 111623 edges, 448 markings/sec, 35 secs
lola: 20228 markings, 119355 edges, 393 markings/sec, 40 secs
lola: 22206 markings, 127297 edges, 396 markings/sec, 45 secs
lola: 24143 markings, 135396 edges, 387 markings/sec, 50 secs
lola: 26485 markings, 145528 edges, 468 markings/sec, 55 secs
lola: 29136 markings, 158912 edges, 530 markings/sec, 60 secs
lola: 31831 markings, 174781 edges, 539 markings/sec, 65 secs
lola: 34648 markings, 200421 edges, 563 markings/sec, 70 secs
lola: SUBRESULT
lola: result: no
lola: produced by: CTL model checker
lola: The net does not satisfy the given formula.
lola: 36324 markings, 247832 edges
lola: ========================================
lola: subprocess 9 will run for 398 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (X ((((theProducts_6 + 1 <= wait_3) OR (ready_4 <= 1)) AND ((ready_10 <= 1) OR (wait_14 + 1 <= wait_36)))))
lola: ========================================
lola: SUBTASK
lola: checking LTL
lola: transforming LTL-Formula into a B\xfcchi-Automaton
lola: processed formula: A (X ((((theProducts_6 + 1 <= wait_3) OR (ready_4 <= 1)) AND ((ready_10 <= 1) OR (wait_14 + 1 <= wait_36)))))
lola: processed formula: A (X ((((theProducts_6 + 1 <= wait_3) OR (ready_4 <= 1)) AND ((ready_10 <= 1) OR (wait_14 + 1 <= wait_36)))))
lola: processed formula length: 111
lola: 0 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: the resulting B\xfcchi automaton has 3 states
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 2 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Formula contains X operator; stubborn sets not applicable
lola: SEARCH
lola: RUNNING
lola: 1849 markings, 1908 edges, 370 markings/sec, 0 secs
lola: 3718 markings, 3917 edges, 374 markings/sec, 5 secs
lola: 5602 markings, 6214 edges, 377 markings/sec, 10 secs
lola: 7422 markings, 8599 edges, 364 markings/sec, 15 secs
lola: 9226 markings, 11767 edges, 361 markings/sec, 20 secs
lola: 11059 markings, 16198 edges, 367 markings/sec, 25 secs
lola: 12919 markings, 21445 edges, 372 markings/sec, 30 secs
lola: 14673 markings, 28708 edges, 351 markings/sec, 35 secs
lola: 16506 markings, 47606 edges, 367 markings/sec, 40 secs
lola: SUBRESULT
lola: result: yes
lola: produced by: LTL model checker
lola: The net satisfies the given formula (language of the product automaton is empty).
lola: 17601 markings, 82100 edges
lola: ========================================
lola: subprocess 10 will run for 457 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: NOT(NOT(NOT(A (F ((3 <= theOptions_9))))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: NOT(A(TRUE U (3 <= theOptions_9)))
lola: processed formula length: 34
lola: 11 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 1 significant temporal operators and needs 5 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: SUBRESULT
lola: result: yes
lola: produced by: CTL model checker
lola: The net satisfies the given formula.
lola: 9 markings, 9 edges
lola: ========================================
lola: subprocess 11 will run for 548 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (A (F (((ready_22 <= 2) AND (wait_26 + 1 <= productSlots_10)))) AND A (G (((theOptions_4 <= ready_22) OR (1 <= wait_4) OR (optionSlots_10 <= theOptions_3)))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 11 will run for 548 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (F (((ready_22 <= 2) AND (wait_26 + 1 <= productSlots_10))))
lola: ========================================
lola: SUBTASK
lola: checking LTL
lola: transforming LTL-Formula into a B\xfcchi-Automaton
lola: processed formula: A (F (((ready_22 <= 2) AND (wait_26 + 1 <= productSlots_10))))
lola: processed formula: A (F (((ready_22 <= 2) AND (wait_26 + 1 <= productSlots_10))))
lola: processed formula length: 62
lola: 0 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: the resulting B\xfcchi automaton has 1 states
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 3 unused bits
lola: using a prefix tree store (--store=prefix)
lola: using ltl preserving stubborn set method (--stubborn)
lola: SEARCH
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: LTL model checker
lola: The net does not satisfy the given formula (language of the product automaton is nonempty).
lola: 5 markings, 5 edges
lola: ========================================
lola: SUBRESULT
lola: result: no
lola: The Boolean predicate is false.
lola: ========================================
lola: subprocess 12 will run for 686 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (A (G (((wait_30 <= 2) OR ((3 <= productSlots_9) AND (productSlots_4 <= ready_22))))) AND (((productSlots_8 <= wait_2) OR A (F ((wait_32 <= ready_40)))) OR A (F (((3 <= productSlots_4) OR (1 <= wait_14))))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 12 will run for 686 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (G (((wait_30 <= 2) OR ((3 <= productSlots_9) AND (productSlots_4 <= ready_22)))))
lola: ========================================
lola: SUBTASK
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 4 literals and 2 conjunctive subformulas
lola: state equation: write sara problem file to DrinkVendingMachine-PT-10-CTLCardinality-12.sara
lola: state equation: calling and running sara
sara: try reading problem file DrinkVendingMachine-PT-10-CTLCardinality-12.sara.
lola: sara is running 0 secs || 1 markings, 0 edges, 0 markings/sec, 0 secs
lola: sara is running 5 secs || 687 markings, 1234 edges, 137 markings/sec, 5 secs
lola: sara is running 10 secs || 3260 markings, 12908 edges, 515 markings/sec, 10 secs
lola: sara is running 15 secs || 5303 markings, 29255 edges, 409 markings/sec, 15 secs
lola: sara is running 20 secs || 7294 markings, 46085 edges, 398 markings/sec, 20 secs
lola: sara is running 25 secs || 9390 markings, 65984 edges, 419 markings/sec, 25 secs
lola: sara is running 30 secs || 11313 markings, 85018 edges, 385 markings/sec, 30 secs
lola: sara is running 35 secs || 13158 markings, 103744 edges, 369 markings/sec, 35 secs
lola: sara is running 40 secs || 14902 markings, 124521 edges, 349 markings/sec, 40 secs
lola: sara is running 45 secs || 17004 markings, 143585 edges, 420 markings/sec, 45 secs
lola: sara is running 50 secs || 18913 markings, 165749 edges, 382 markings/sec, 50 secs
lola: sara is running 55 secs || 20747 markings, 189924 edges, 367 markings/sec, 55 secs
lola: sara is running 60 secs || 22477 markings, 212658 edges, 346 markings/sec, 60 secs
lola: sara is running 65 secs || 23982 markings, 236045 edges, 301 markings/sec, 65 secs
lola: sara is running 70 secs || 25581 markings, 258942 edges, 320 markings/sec, 70 secs
lola: sara is running 75 secs || 27130 markings, 280639 edges, 310 markings/sec, 75 secs
lola: sara is running 80 secs || 28845 markings, 300680 edges, 343 markings/sec, 80 secs
lola: sara is running 85 secs || 30525 markings, 327247 edges, 336 markings/sec, 85 secs
lola: sara is running 90 secs || 32138 markings, 352992 edges, 323 markings/sec, 90 secs
lola: sara is running 95 secs || 33695 markings, 379580 edges, 311 markings/sec, 95 secs
lola: sara is running 100 secs || 35314 markings, 406784 edges, 324 markings/sec, 100 secs
lola: sara is running 105 secs || 36822 markings, 433013 edges, 302 markings/sec, 105 secs
lola: sara is running 110 secs || 38259 markings, 458280 edges, 287 markings/sec, 110 secs
lola: sara is running 115 secs || 39778 markings, 483230 edges, 304 markings/sec, 115 secs
lola: sara is running 120 secs || 41429 markings, 505393 edges, 330 markings/sec, 120 secs
lola: sara is running 125 secs || 42884 markings, 529569 edges, 291 markings/sec, 125 secs
lola: sara is running 130 secs || 44889 markings, 547531 edges, 401 markings/sec, 130 secs
lola: sara is running 135 secs || 46486 markings, 574422 edges, 319 markings/sec, 135 secs
lola: sara is running 140 secs || 47913 markings, 601535 edges, 285 markings/sec, 140 secs
lola: sara is running 145 secs || 49459 markings, 628087 edges, 309 markings/sec, 145 secs
lola: sara is running 150 secs || 50989 markings, 656438 edges, 306 markings/sec, 150 secs
lola: sara is running 155 secs || 52512 markings, 689084 edges, 305 markings/sec, 155 secs
lola: sara is running 160 secs || 54211 markings, 720469 edges, 340 markings/sec, 160 secs
lola: sara is running 165 secs || 55761 markings, 752696 edges, 310 markings/sec, 165 secs
lola: sara is running 170 secs || 57324 markings, 783674 edges, 313 markings/sec, 170 secs
lola: sara is running 175 secs || 58826 markings, 812500 edges, 300 markings/sec, 175 secs
lola: sara is running 180 secs || 60176 markings, 841107 edges, 270 markings/sec, 180 secs
lola: sara is running 185 secs || 61642 markings, 871821 edges, 293 markings/sec, 185 secs
lola: sara is running 190 secs || 63320 markings, 899984 edges, 336 markings/sec, 190 secs
lola: sara is running 195 secs || 64734 markings, 931890 edges, 283 markings/sec, 195 secs
lola: sara is running 200 secs || 66279 markings, 965917 edges, 309 markings/sec, 200 secs
lola: sara is running 205 secs || 67558 markings, 997754 edges, 256 markings/sec, 205 secs
lola: sara is running 210 secs || 69095 markings, 1025390 edges, 307 markings/sec, 210 secs
lola: sara is running 215 secs || 70622 markings, 1059399 edges, 305 markings/sec, 215 secs
lola: sara is running 220 secs || 73032 markings, 1084744 edges, 482 markings/sec, 220 secs
lola: sara is running 225 secs || 74928 markings, 1108883 edges, 379 markings/sec, 225 secs
lola: sara is running 230 secs || 76482 markings, 1131175 edges, 311 markings/sec, 230 secs
lola: sara is running 235 secs || 78035 markings, 1156101 edges, 311 markings/sec, 235 secs
lola: sara is running 240 secs || 79700 markings, 1184650 edges, 333 markings/sec, 240 secs
lola: sara is running 245 secs || 81293 markings, 1219331 edges, 319 markings/sec, 245 secs
lola: sara is running 250 secs || 82873 markings, 1252003 edges, 316 markings/sec, 250 secs
lola: sara is running 255 secs || 84580 markings, 1288662 edges, 341 markings/sec, 255 secs
lola: sara is running 260 secs || 86361 markings, 1327279 edges, 356 markings/sec, 260 secs
lola: sara is running 265 secs || 88042 markings, 1365667 edges, 336 markings/sec, 265 secs
lola: sara is running 270 secs || 89792 markings, 1403664 edges, 350 markings/sec, 270 secs
lola: sara is running 275 secs || 91286 markings, 1439159 edges, 299 markings/sec, 275 secs
lola: sara is running 280 secs || 92704 markings, 1468682 edges, 284 markings/sec, 280 secs
lola: sara is running 285 secs || 94030 markings, 1501560 edges, 265 markings/sec, 285 secs
lola: sara is running 290 secs || 95853 markings, 1530017 edges, 365 markings/sec, 290 secs
lola: sara is running 295 secs || 97123 markings, 1563856 edges, 254 markings/sec, 295 secs
lola: sara is running 300 secs || 98132 markings, 1591720 edges, 202 markings/sec, 300 secs
lola: sara is running 305 secs || 99129 markings, 1619721 edges, 199 markings/sec, 305 secs
lola: sara is running 310 secs || 100519 markings, 1648032 edges, 278 markings/sec, 310 secs
lola: sara is running 315 secs || 102001 markings, 1680722 edges, 296 markings/sec, 315 secs
lola: sara is running 320 secs || 103283 markings, 1715260 edges, 256 markings/sec, 320 secs
lola: sara is running 325 secs || 104851 markings, 1749700 edges, 314 markings/sec, 325 secs
lola: sara is running 330 secs || 106390 markings, 1781819 edges, 308 markings/sec, 330 secs
lola: sara is running 335 secs || 107857 markings, 1817566 edges, 293 markings/sec, 335 secs
lola: sara is running 340 secs || 109253 markings, 1855366 edges, 279 markings/sec, 340 secs
lola: sara is running 345 secs || 110750 markings, 1888130 edges, 299 markings/sec, 345 secs
lola: sara is running 350 secs || 112216 markings, 1922315 edges, 293 markings/sec, 350 secs
lola: sara is running 355 secs || 113366 markings, 1959203 edges, 230 markings/sec, 355 secs
lola: sara is running 360 secs || 114903 markings, 1994752 edges, 307 markings/sec, 360 secs
lola: sara is running 365 secs || 116501 markings, 2031812 edges, 320 markings/sec, 365 secs
lola: sara is running 370 secs || 117856 markings, 2067947 edges, 271 markings/sec, 370 secs
lola: sara is running 375 secs || 119403 markings, 2103730 edges, 309 markings/sec, 375 secs
lola: sara is running 380 secs || 120689 markings, 2135063 edges, 257 markings/sec, 380 secs
lola: sara is running 385 secs || 121988 markings, 2166267 edges, 260 markings/sec, 385 secs
lola: sara is running 390 secs || 123248 markings, 2197594 edges, 252 markings/sec, 390 secs
lola: sara is running 395 secs || 124731 markings, 2229738 edges, 297 markings/sec, 395 secs
lola: sara is running 400 secs || 125937 markings, 2265149 edges, 241 markings/sec, 400 secs
lola: sara is running 405 secs || 127297 markings, 2296970 edges, 272 markings/sec, 405 secs
lola: sara is running 410 secs || 128739 markings, 2323852 edges, 288 markings/sec, 410 secs
lola: sara is running 415 secs || 130118 markings, 2355228 edges, 276 markings/sec, 415 secs
lola: sara is running 420 secs || 132323 markings, 2381172 edges, 441 markings/sec, 420 secs
lola: sara is running 425 secs || 133992 markings, 2406320 edges, 334 markings/sec, 425 secs
lola: sara is running 430 secs || 135495 markings, 2433109 edges, 301 markings/sec, 430 secs
lola: sara is running 435 secs || 136982 markings, 2460702 edges, 297 markings/sec, 435 secs
lola: sara is running 440 secs || 138685 markings, 2483874 edges, 341 markings/sec, 440 secs
lola: sara is running 445 secs || 140252 markings, 2510079 edges, 313 markings/sec, 445 secs
lola: sara is running 450 secs || 141702 markings, 2543160 edges, 290 markings/sec, 450 secs
lola: sara is running 455 secs || 142934 markings, 2577866 edges, 246 markings/sec, 455 secs
lola: sara is running 460 secs || 144245 markings, 2610751 edges, 262 markings/sec, 460 secs
lola: sara is running 465 secs || 145590 markings, 2646606 edges, 269 markings/sec, 465 secs
lola: sara is running 470 secs || 146802 markings, 2684555 edges, 242 markings/sec, 470 secs
lola: sara is running 475 secs || 148385 markings, 2711684 edges, 317 markings/sec, 475 secs
lola: sara is running 480 secs || 149604 markings, 2746777 edges, 244 markings/sec, 480 secs
lola: sara is running 485 secs || 150916 markings, 2781848 edges, 262 markings/sec, 485 secs
lola: sara is running 490 secs || 152257 markings, 2810668 edges, 268 markings/sec, 490 secs
lola: sara is running 495 secs || 153678 markings, 2845228 edges, 284 markings/sec, 495 secs
lola: sara is running 500 secs || 155100 markings, 2880763 edges, 284 markings/sec, 500 secs
lola: sara is running 505 secs || 156555 markings, 2913540 edges, 291 markings/sec, 505 secs
lola: sara is running 510 secs || 158257 markings, 2942475 edges, 340 markings/sec, 510 secs
lola: sara is running 515 secs || 159972 markings, 2967057 edges, 343 markings/sec, 515 secs
lola: sara is running 520 secs || 161392 markings, 3000493 edges, 284 markings/sec, 520 secs
lola: sara is running 525 secs || 162707 markings, 3034962 edges, 263 markings/sec, 525 secs
lola: sara is running 530 secs || 163897 markings, 3070540 edges, 238 markings/sec, 530 secs
lola: sara is running 535 secs || 165252 markings, 3105746 edges, 271 markings/sec, 535 secs
lola: sara is running 540 secs || 166581 markings, 3140074 edges, 266 markings/sec, 540 secs
lola: sara is running 545 secs || 168062 markings, 3167737 edges, 296 markings/sec, 545 secs
lola: sara is running 550 secs || 169420 markings, 3198510 edges, 272 markings/sec, 550 secs
lola: sara is running 555 secs || 170647 markings, 3232913 edges, 245 markings/sec, 555 secs
lola: sara is running 560 secs || 171887 markings, 3268909 edges, 248 markings/sec, 560 secs
lola: sara is running 565 secs || 173267 markings, 3301502 edges, 276 markings/sec, 565 secs
lola: sara is running 570 secs || 174887 markings, 3329643 edges, 324 markings/sec, 570 secs
lola: sara is running 575 secs || 176063 markings, 3366497 edges, 235 markings/sec, 575 secs
lola: sara is running 580 secs || 177309 markings, 3401201 edges, 249 markings/sec, 580 secs
lola: sara is running 585 secs || 178421 markings, 3436927 edges, 222 markings/sec, 585 secs
lola: sara is running 590 secs || 179636 markings, 3473765 edges, 243 markings/sec, 590 secs
lola: sara is running 595 secs || 180951 markings, 3508040 edges, 263 markings/sec, 595 secs
lola: sara is running 600 secs || 182318 markings, 3544724 edges, 273 markings/sec, 600 secs
lola: sara is running 605 secs || 183618 markings, 3579397 edges, 260 markings/sec, 605 secs
lola: sara is running 610 secs || 184948 markings, 3611061 edges, 266 markings/sec, 610 secs
lola: sara is running 615 secs || 186220 markings, 3646912 edges, 254 markings/sec, 615 secs
lola: sara is running 620 secs || 187537 markings, 3684918 edges, 263 markings/sec, 620 secs
lola: sara is running 625 secs || 188949 markings, 3725379 edges, 282 markings/sec, 625 secs
lola: sara is running 630 secs || 190554 markings, 3760404 edges, 321 markings/sec, 630 secs
lola: sara is running 635 secs || 192129 markings, 3796154 edges, 315 markings/sec, 635 secs
lola: sara is running 640 secs || 193544 markings, 3834962 edges, 283 markings/sec, 640 secs
lola: sara is running 645 secs || 194895 markings, 3874687 edges, 270 markings/sec, 645 secs
lola: sara is running 650 secs || 196139 markings, 3909761 edges, 249 markings/sec, 650 secs
lola: sara is running 655 secs || 197356 markings, 3940127 edges, 243 markings/sec, 655 secs
lola: sara is running 660 secs || 199046 markings, 3972144 edges, 338 markings/sec, 660 secs
lola: sara is running 665 secs || 200493 markings, 4006292 edges, 289 markings/sec, 665 secs
lola: sara is running 670 secs || 201712 markings, 4043789 edges, 244 markings/sec, 670 secs
lola: sara is running 675 secs || 203021 markings, 4077579 edges, 262 markings/sec, 675 secs
lola: sara is running 680 secs || 204388 markings, 4112764 edges, 273 markings/sec, 680 secs
lola: local time limit reached - aborting
lola: caught signal User defined signal 1 - aborting LoLA
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 13 will run for 686 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (NOT(E (F ((1 <= ready_38)))) OR E (F (((2 <= theProducts_3) AND (1 <= wait_15)))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 13 will run for 686 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (G ((ready_38 <= 0)))
lola: ========================================
lola: SUBTASK
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation: write sara problem file to DrinkVendingMachine-PT-10-CTLCardinality-13.sara
lola: state equation: calling and running sara
sara: try reading problem file DrinkVendingMachine-PT-10-CTLCardinality-13.sara.
lola: SUBRESULT
lola: result: no
lola: produced by: state space
lola: The predicate is not invariant.
lola: 2 markings, 1 edges
lola: ========================================
lola: subprocess 14 will run for 1026 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (F (((2 <= theProducts_3) AND (1 <= wait_15))))
lola: ========================================
lola: SUBTASK
lola: checking reachability
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: RUNNING
lola: state equation: Generated DNF with 2 literals and 1 conjunctive subformulas
lola: state equation: write sara problem file to DrinkVendingMachine-PT-10-CTLCardinality-14.sara
lola: state equation: calling and running sara
sara: try reading problem file DrinkVendingMachine-PT-10-CTLCardinality-14.sara.
lola: sara is running 0 secs || 3 markings, 2 edges, 1 markings/sec, 0 secs
lola: sara is running 5 secs || 1692 markings, 3646 edges, 338 markings/sec, 5 secs
lola: sara is running 10 secs || 7887 markings, 22814 edges, 1239 markings/sec, 10 secs
lola: sara is running 15 secs || 13035 markings, 40058 edges, 1030 markings/sec, 15 secs
lola: sara is running 20 secs || 19445 markings, 63554 edges, 1282 markings/sec, 20 secs
lola: sara is running 25 secs || 25260 markings, 86196 edges, 1163 markings/sec, 25 secs
lola: sara is running 30 secs || 29963 markings, 106488 edges, 941 markings/sec, 30 secs
lola: sara is running 35 secs || 35661 markings, 129952 edges, 1140 markings/sec, 35 secs
lola: sara is running 40 secs || 40507 markings, 151196 edges, 969 markings/sec, 40 secs
lola: sara is running 45 secs || 45521 markings, 172256 edges, 1003 markings/sec, 45 secs
lola: sara is running 50 secs || 50290 markings, 192410 edges, 954 markings/sec, 50 secs
lola: sara is running 55 secs || 55087 markings, 213452 edges, 959 markings/sec, 55 secs
lola: sara is running 60 secs || 60532 markings, 237049 edges, 1089 markings/sec, 60 secs
lola: sara is running 65 secs || 65647 markings, 263707 edges, 1023 markings/sec, 65 secs
lola: sara is running 70 secs || 70477 markings, 287103 edges, 966 markings/sec, 70 secs
lola: sara is running 75 secs || 74996 markings, 311285 edges, 904 markings/sec, 75 secs
lola: sara is running 80 secs || 80521 markings, 335443 edges, 1105 markings/sec, 80 secs
lola: sara is running 85 secs || 85241 markings, 359458 edges, 944 markings/sec, 85 secs
lola: sara is running 90 secs || 91534 markings, 383349 edges, 1259 markings/sec, 90 secs
lola: sara is running 95 secs || 97770 markings, 405947 edges, 1247 markings/sec, 95 secs
lola: sara is running 100 secs || 102502 markings, 429058 edges, 946 markings/sec, 100 secs
lola: sara is running 105 secs || 107499 markings, 452805 edges, 999 markings/sec, 105 secs
lola: sara is running 110 secs || 111573 markings, 475698 edges, 815 markings/sec, 110 secs
lola: sara is running 115 secs || 115139 markings, 496539 edges, 713 markings/sec, 115 secs
lola: sara is running 120 secs || 119849 markings, 516144 edges, 942 markings/sec, 120 secs
lola: sara is running 125 secs || 126766 markings, 540600 edges, 1383 markings/sec, 125 secs
lola: sara is running 130 secs || 131931 markings, 567979 edges, 1033 markings/sec, 130 secs
lola: sara is running 135 secs || 137200 markings, 590542 edges, 1054 markings/sec, 135 secs
lola: sara is running 140 secs || 142356 markings, 613485 edges, 1031 markings/sec, 140 secs
lola: sara is running 145 secs || 147266 markings, 636730 edges, 982 markings/sec, 145 secs
lola: sara is running 150 secs || 152556 markings, 664101 edges, 1058 markings/sec, 150 secs
lola: sara is running 155 secs || 156537 markings, 684720 edges, 796 markings/sec, 155 secs
lola: sara is running 160 secs || 160906 markings, 707885 edges, 874 markings/sec, 160 secs
lola: sara is running 165 secs || 165672 markings, 732204 edges, 953 markings/sec, 165 secs
lola: sara is running 170 secs || 169683 markings, 758614 edges, 802 markings/sec, 170 secs
lola: sara is running 175 secs || 172689 markings, 777877 edges, 601 markings/sec, 175 secs
lola: sara is running 180 secs || 177463 markings, 805262 edges, 955 markings/sec, 180 secs
lola: sara is running 185 secs || 182231 markings, 831573 edges, 954 markings/sec, 185 secs
lola: sara is running 190 secs || 187053 markings, 860043 edges, 964 markings/sec, 190 secs
lola: sara is running 195 secs || 191623 markings, 891611 edges, 914 markings/sec, 195 secs
lola: sara is running 200 secs || 196067 markings, 920463 edges, 889 markings/sec, 200 secs
lola: sara is running 205 secs || 200927 markings, 949610 edges, 972 markings/sec, 205 secs
lola: sara is running 210 secs || 206036 markings, 978639 edges, 1022 markings/sec, 210 secs
lola: sara is running 215 secs || 210973 markings, 1008941 edges, 987 markings/sec, 215 secs
lola: sara is running 220 secs || 214761 markings, 1039000 edges, 758 markings/sec, 220 secs
lola: sara is running 225 secs || 219413 markings, 1064890 edges, 930 markings/sec, 225 secs
lola: sara is running 230 secs || 224182 markings, 1097195 edges, 954 markings/sec, 230 secs
lola: sara is running 235 secs || 229043 markings, 1128802 edges, 972 markings/sec, 235 secs
lola: sara is running 240 secs || 233991 markings, 1158760 edges, 990 markings/sec, 240 secs
lola: sara is running 245 secs || 240467 markings, 1185776 edges, 1295 markings/sec, 245 secs
lola: sara is running 250 secs || 246040 markings, 1213173 edges, 1115 markings/sec, 250 secs
lola: sara is running 255 secs || 251684 markings, 1242508 edges, 1129 markings/sec, 255 secs
lola: sara is running 260 secs || 256765 markings, 1273051 edges, 1016 markings/sec, 260 secs
lola: sara is running 265 secs || 261944 markings, 1301642 edges, 1036 markings/sec, 265 secs
lola: sara is running 270 secs || 266776 markings, 1331595 edges, 966 markings/sec, 270 secs
lola: sara is running 275 secs || 271109 markings, 1356949 edges, 867 markings/sec, 275 secs
lola: sara is running 280 secs || 275322 markings, 1387229 edges, 843 markings/sec, 280 secs
lola: sara is running 285 secs || 280783 markings, 1416452 edges, 1092 markings/sec, 285 secs
lola: sara is running 290 secs || 285188 markings, 1447998 edges, 881 markings/sec, 290 secs
lola: sara is running 295 secs || 288796 markings, 1479764 edges, 722 markings/sec, 295 secs
lola: sara is running 300 secs || 293029 markings, 1511478 edges, 847 markings/sec, 300 secs
lola: sara is running 305 secs || 298671 markings, 1542781 edges, 1128 markings/sec, 305 secs
lola: sara is running 310 secs || 303184 markings, 1571226 edges, 903 markings/sec, 310 secs
lola: sara is running 315 secs || 310556 markings, 1597944 edges, 1474 markings/sec, 315 secs
lola: sara is running 320 secs || 316493 markings, 1625071 edges, 1187 markings/sec, 320 secs
lola: sara is running 325 secs || 322218 markings, 1650517 edges, 1145 markings/sec, 325 secs
lola: sara is running 330 secs || 327275 markings, 1676182 edges, 1011 markings/sec, 330 secs
lola: sara is running 335 secs || 331904 markings, 1702132 edges, 926 markings/sec, 335 secs
lola: sara is running 340 secs || 336915 markings, 1731649 edges, 1002 markings/sec, 340 secs
lola: sara is running 345 secs || 341231 markings, 1761421 edges, 863 markings/sec, 345 secs
lola: sara is running 350 secs || 346310 markings, 1791250 edges, 1016 markings/sec, 350 secs
lola: sara is running 355 secs || 350812 markings, 1822409 edges, 900 markings/sec, 355 secs
lola: sara is running 360 secs || 355698 markings, 1852112 edges, 977 markings/sec, 360 secs
lola: sara is running 365 secs || 360596 markings, 1880562 edges, 980 markings/sec, 365 secs
lola: sara is running 370 secs || 366988 markings, 1905919 edges, 1278 markings/sec, 370 secs
lola: sara is running 375 secs || 371659 markings, 1934608 edges, 934 markings/sec, 375 secs
lola: sara is running 380 secs || 376609 markings, 1962932 edges, 990 markings/sec, 380 secs
lola: sara is running 385 secs || 380600 markings, 1992199 edges, 798 markings/sec, 385 secs
lola: sara is running 390 secs || 384179 markings, 2021148 edges, 716 markings/sec, 390 secs
lola: sara is running 395 secs || 388113 markings, 2047965 edges, 787 markings/sec, 395 secs
lola: sara is running 400 secs || 393177 markings, 2073038 edges, 1013 markings/sec, 400 secs
lola: sara is running 405 secs || 397965 markings, 2101818 edges, 958 markings/sec, 405 secs
lola: sara is running 410 secs || 405327 markings, 2128598 edges, 1472 markings/sec, 410 secs
lola: sara is running 415 secs || 411320 markings, 2156537 edges, 1199 markings/sec, 415 secs
lola: sara is running 420 secs || 417381 markings, 2187220 edges, 1212 markings/sec, 420 secs
lola: sara is running 425 secs || 422362 markings, 2217182 edges, 996 markings/sec, 425 secs
lola: sara is running 430 secs || 427324 markings, 2247593 edges, 992 markings/sec, 430 secs
lola: sara is running 435 secs || 433181 markings, 2274735 edges, 1171 markings/sec, 435 secs
lola: sara is running 440 secs || 437887 markings, 2304038 edges, 941 markings/sec, 440 secs
lola: sara is running 445 secs || 442040 markings, 2336098 edges, 831 markings/sec, 445 secs
lola: sara is running 450 secs || 447196 markings, 2363141 edges, 1031 markings/sec, 450 secs
lola: sara is running 455 secs || 451525 markings, 2392520 edges, 866 markings/sec, 455 secs
lola: sara is running 460 secs || 456425 markings, 2423792 edges, 980 markings/sec, 460 secs
lola: sara is running 465 secs || 461174 markings, 2453164 edges, 950 markings/sec, 465 secs
lola: sara is running 470 secs || 465898 markings, 2483002 edges, 945 markings/sec, 470 secs
lola: sara is running 475 secs || 470408 markings, 2513262 edges, 902 markings/sec, 475 secs
lola: sara is running 480 secs || 474503 markings, 2543430 edges, 819 markings/sec, 480 secs
lola: sara is running 485 secs || 478803 markings, 2574235 edges, 860 markings/sec, 485 secs
lola: sara is running 490 secs || 482892 markings, 2606934 edges, 818 markings/sec, 490 secs
lola: sara is running 495 secs || 487613 markings, 2636812 edges, 944 markings/sec, 495 secs
lola: sara is running 500 secs || 491945 markings, 2666611 edges, 866 markings/sec, 500 secs
lola: sara is running 505 secs || 496816 markings, 2698465 edges, 974 markings/sec, 505 secs
lola: sara is running 510 secs || 500970 markings, 2731334 edges, 831 markings/sec, 510 secs
lola: sara is running 515 secs || 505869 markings, 2761912 edges, 980 markings/sec, 515 secs
lola: sara is running 520 secs || 510093 markings, 2791653 edges, 845 markings/sec, 520 secs
lola: sara is running 525 secs || 515854 markings, 2817776 edges, 1152 markings/sec, 525 secs
lola: sara is running 530 secs || 520299 markings, 2847477 edges, 889 markings/sec, 530 secs
lola: sara is running 535 secs || 524827 markings, 2877927 edges, 906 markings/sec, 535 secs
lola: sara is running 540 secs || 529114 markings, 2909045 edges, 857 markings/sec, 540 secs
lola: sara is running 545 secs || 533487 markings, 2942775 edges, 875 markings/sec, 545 secs
lola: sara is running 550 secs || 537979 markings, 2970965 edges, 898 markings/sec, 550 secs
lola: sara is running 555 secs || 541914 markings, 3002011 edges, 787 markings/sec, 555 secs
lola: sara is running 560 secs || 547108 markings, 3030607 edges, 1039 markings/sec, 560 secs
lola: sara is running 565 secs || 554237 markings, 3055336 edges, 1426 markings/sec, 565 secs
lola: sara is running 570 secs || 559747 markings, 3082700 edges, 1102 markings/sec, 570 secs
lola: sara is running 575 secs || 565958 markings, 3109308 edges, 1242 markings/sec, 575 secs
lola: sara is running 580 secs || 571321 markings, 3138382 edges, 1073 markings/sec, 580 secs
lola: sara is running 585 secs || 575980 markings, 3166503 edges, 932 markings/sec, 585 secs
lola: sara is running 590 secs || 581184 markings, 3195876 edges, 1041 markings/sec, 590 secs
lola: sara is running 595 secs || 585767 markings, 3227161 edges, 917 markings/sec, 595 secs
lola: sara is running 600 secs || 590597 markings, 3256315 edges, 966 markings/sec, 600 secs
lola: sara is running 605 secs || 594742 markings, 3285570 edges, 829 markings/sec, 605 secs
lola: sara is running 610 secs || 599011 markings, 3316595 edges, 854 markings/sec, 610 secs
lola: sara is running 615 secs || 603702 markings, 3346546 edges, 938 markings/sec, 615 secs
lola: sara is running 620 secs || 607952 markings, 3379393 edges, 850 markings/sec, 620 secs
lola: sara is running 625 secs || 611880 markings, 3410065 edges, 786 markings/sec, 625 secs
lola: sara is running 630 secs || 616321 markings, 3444852 edges, 888 markings/sec, 630 secs
lola: sara is running 635 secs || 620461 markings, 3475665 edges, 828 markings/sec, 635 secs
lola: sara is running 640 secs || 624955 markings, 3504410 edges, 899 markings/sec, 640 secs
lola: sara is running 645 secs || 629363 markings, 3536182 edges, 882 markings/sec, 645 secs
lola: sara is running 650 secs || 633143 markings, 3566338 edges, 756 markings/sec, 650 secs
lola: sara is running 655 secs || 637848 markings, 3596023 edges, 941 markings/sec, 655 secs
lola: sara is running 660 secs || 643589 markings, 3628678 edges, 1148 markings/sec, 660 secs
lola: sara is running 665 secs || 647348 markings, 3660157 edges, 752 markings/sec, 665 secs
lola: sara is running 670 secs || 651834 markings, 3691242 edges, 897 markings/sec, 670 secs
lola: sara is running 675 secs || 656690 markings, 3726030 edges, 971 markings/sec, 675 secs
lola: local time limit reached - aborting
lola: caught signal User defined signal 1 - aborting LoLA
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 14 will run for 686 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (X (E (((ready_26 <= theProducts_8) U (optionSlots_2 <= wait_21)))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: AX(E((ready_26 <= theProducts_8) U (optionSlots_2 <= wait_21)))
lola: processed formula length: 63
lola: 2 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Formula contains EX or AX operators, stubborn sets not applicable
lola: RUNNING
lola: CTL formula contains 1 significant temporal operators and needs 5 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 2888 markings, 2991 edges, 3689339798746562560 markings/sec, 0 secs
lola: 5707 markings, 6179 edges, 564 markings/sec, 5 secs
lola: 8033 markings, 9281 edges, 465 markings/sec, 10 secs
lola: 9908 markings, 12496 edges, 375 markings/sec, 15 secs
lola: 11259 markings, 15615 edges, 270 markings/sec, 20 secs
lola: 12515 markings, 18835 edges, 251 markings/sec, 25 secs
lola: 13645 markings, 21953 edges, 226 markings/sec, 30 secs
lola: 14443 markings, 25039 edges, 160 markings/sec, 35 secs
lola: 15299 markings, 28195 edges, 171 markings/sec, 40 secs
lola: 15839 markings, 31323 edges, 108 markings/sec, 45 secs
lola: 16283 markings, 34470 edges, 89 markings/sec, 50 secs
lola: 16577 markings, 37618 edges, 59 markings/sec, 55 secs
lola: 16877 markings, 40747 edges, 60 markings/sec, 60 secs
lola: 17102 markings, 43872 edges, 45 markings/sec, 65 secs
lola: 17324 markings, 47011 edges, 44 markings/sec, 70 secs
lola: 17539 markings, 50148 edges, 43 markings/sec, 75 secs
lola: 17694 markings, 53256 edges, 31 markings/sec, 80 secs
lola: 17821 markings, 56392 edges, 25 markings/sec, 85 secs
lola: 17989 markings, 59532 edges, 34 markings/sec, 90 secs
lola: 18122 markings, 62663 edges, 27 markings/sec, 95 secs
lola: 18251 markings, 65794 edges, 26 markings/sec, 100 secs
lola: 18388 markings, 68928 edges, 27 markings/sec, 105 secs
lola: 18442 markings, 72080 edges, 11 markings/sec, 110 secs
lola: 18484 markings, 75178 edges, 8 markings/sec, 115 secs
lola: 18560 markings, 78292 edges, 15 markings/sec, 120 secs
lola: 18590 markings, 81175 edges, 6 markings/sec, 125 secs
lola: SUBRESULT
lola: result: yes
lola: produced by: CTL model checker
lola: The net satisfies the given formula.
lola: 18621 markings, 83209 edges
lola: ========================================
lola: subprocess 15 will run for 1238 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (G (((ready_24 <= productSlots_7) AND (wait_25 <= wait_1))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: NOT(A(TRUE U ((productSlots_7 + 1 <= ready_24) OR (wait_1 + 1 <= wait_25))))
lola: processed formula length: 77
lola: 2 rewrites
lola: formula mentions 0 of 120 places; total mentions: 0
lola: closed formula file DrinkVendingMachine-PT-10-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 8 bytes per marking, with 4 unused bits
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 1 significant temporal operators and needs 5 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: SUBRESULT
lola: result: yes
lola: produced by: CTL model checker
lola: The net satisfies the given formula.
lola: 5 markings, 5 edges
lola: ========================================
lola: RESULT
lola:
SUMMARY: no yes no yes unknown no yes no no yes yes no unknown unknown yes yes
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-0 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-1 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-2 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-3 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-4 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-5 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-6 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-7 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-8 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-9 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-10 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-11 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-12 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-13 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-14 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA DrinkVendingMachine-PT-10-CTLCardinality-15 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
----- Kill lola and sara stdout -----
----- Kill lola and sara stderr -----
----- Finished stderr -----
----- Finished stdout -----
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="DrinkVendingMachine-PT-10"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="mcc4mcc-full"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
# this is specific to your benchmark or test
export BIN_DIR="$HOME/BenchKit/bin"
# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi
tar xzf /home/mcc/BenchKit/INPUTS/DrinkVendingMachine-PT-10.tgz
mv DrinkVendingMachine-PT-10 execution
cd execution
pwd
ls -lh
# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3637"
echo " Executing tool mcc4mcc-full"
echo " Input is DrinkVendingMachine-PT-10, 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 r082-blw3-152649949700374"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '
echo "FORMULA_NAME $x"
done
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;