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 2.2M
-rw-r--r-- 1 mcc users 4.3K May 15 18:54 CTLCardinality.txt
-rw-r--r-- 1 mcc users 21K May 15 18:54 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.8K May 15 18:54 CTLFireability.txt
-rw-r--r-- 1 mcc users 21K 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.4K May 15 18:50 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 2.9K May 15 18:54 LTLCardinality.txt
-rw-r--r-- 1 mcc users 11K May 15 18:54 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K May 15 18:54 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.2K May 15 18:54 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.1K May 15 18:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 18K May 15 18:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 110 May 15 18:54 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 348 May 15 18:54 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 3.1K May 15 18:54 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 14K May 15 18:54 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K May 15 18:54 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K May 15 18:54 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 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 2.0M May 15 18:50 model.pnml
=====================================================================
Generated by BenchKit 2-3637
Executing tool mcc4mcc-structural
Input is SimpleLoadBal-PT-20, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r179-smll-152708748900171
=====================================================================

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

=== Now, execution of the tool begins

BK_START 1527220235499


BK_STOP 1527221330238

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

Prefix is 75f5f979.
Reading known information in /usr/share/mcc4mcc/75f5f979-known.json.
Reading learned information in /usr/share/mcc4mcc/75f5f979-learned.json.
Reading value translations in /usr/share/mcc4mcc/75f5f979-values.json.
Using directory /home/mcc/execution for input, as it contains a model.pnml file.
Using SimpleLoadBal-PT-20 as instance name.
Using SimpleLoadBal as model name.
Using algorithm or tool bmdt.
Model characteristics are: {'Examination': 'CTLCardinality', 'Place/Transition': True, 'Colored': False, 'Relative-Time': 1, 'Relative-Memory': 1, 'Ordinary': True, 'Simple Free Choice': False, 'Extended Free Choice': False, 'State Machine': False, 'Marked Graph': False, 'Connected': True, 'Strongly Connected': True, 'Source Place': False, 'Sink Place': False, 'Source Transition': False, 'Sink Transition': False, 'Loop Free': False, 'Conservative': False, 'Sub-Conservative': False, 'Nested Units': False, 'Safe': True, 'Deadlock': False, 'Reversible': False, 'Quasi Live': None, 'Live': None}.
Known tools are: [{'Time': 292210, 'Memory': 15935.41, 'Tool': 'lola'}, {'Time': 565034, 'Memory': 15950.54, 'Tool': 'lola'}].
Learned tools are: [{'Tool': 'lola'}].
Learned tool lola is 1.0x far from the best tool lola.
CTLCardinality lola SimpleLoadBal-PT-20...

Time: 3600 - MCC
----- Start make prepare stdout -----
----- Start make prepare stderr -----
===========================================================================================
SimpleLoadBal-PT-20: translating PT Petri net model.pnml into LoLA format
===========================================================================================
translating PT Petri net complete


checking for too many tokens
===========================================================================================
SimpleLoadBal-PT-20: translating PT formula CTLCardinality into LoLA format
===========================================================================================
translating formula complete
touch formulae;
----- Start make result stderr -----
----- Start make result stdout -----
CTLCardinality @ SimpleLoadBal-PT-20 @ 3540 seconds
make: [verify] Error 134 (ignored)
Makefile:222: recipe for target 'verify' failed
----- Start make result stdout -----
----- Start make result stderr -----
lola: LoLA will run for 3540 seconds at most (--timelimit)
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 2399/65536 symbol table entries, 194 collisions
lola: preprocessing...
lola: finding significant places
lola: 194 places, 2205 transitions, 145 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 3571 transition conflict sets
lola: TASK
lola: reading formula from SimpleLoadBal-PT-20-CTLCardinality.task
lola: (E (G (((2 <= P-client_ack_11) OR (P-client_ack_4 <= P-lb_load_1_12)))) OR (P-client_idle_20 <= P-client_request_2)) : A (F (E (X (((3 <= P-client_waiting_13) AND (P-client_waiting_13 <= P-lb_load_1_14)))))) : A (G ((P-lb_load_2_7 <= P-client_request_14))) : E ((((P-lb_load_2_12 + 1 <= P-client_request_9) AND (P-lb_load_2_19 <= P-client_idle_9)) U E (F ((3 <= P-lb_routing_1_8))))) : E (F ((3 <= P-server_request_3_2))) : NOT(A (G (A (F ((P-lb_load_2_17 <= P-client_request_15)))))) : E (F (((P-client_request_7 <= P-lb_load_2_8) AND (P-lb_load_1_14 <= P-client_ack_12) AND ((P-client_request_12 <= P-client_ack_2) OR (1 <= P-client_waiting_17)) AND (P-client_request_17 <= 1) AND (P-client_idle_19 + 1 <= P-lb_load_1_17)))) : A (G (E (F (((P-client_waiting_16 <= P-client_request_15) OR (3 <= P-lb_load_1_12)))))) : A (G (E (((P-client_request_8 <= P-client_ack_20) U (1 <= P-server_idle_1))))) : E (F (A (((2 <= P-client_request_2) U (1 <= P-server_processed_2))))) : A (F ((A (G ((P-server_processed_1 <= P-lb_routing_1_16))) AND (P-lb_routing_1_3 + 1 <= P-lb_load_1_13)))) : E (G (E (X ((P-server_request_8_1 + 1 <= P-client_request_9))))) : (((1 <= P-client_ack_14) AND ((P-client_request_1 <= P-server_processed_1) AND A (X ((3 <= P-lb_load_1_6))))) OR (E (G (((P-lb_load_2_18 <= P-server_waiting_1) AND (P-lb_load_1_10 <= P-client_request_12)))) AND ((P-server_request_8_1 + 1 <= P-client_request_12) OR ((P-client_ack_5 <= 2) AND (P-client_request_19 <= 2))))) : (A (F (A (G ((P-server_request_11_2 <= P-server_request_14_2))))) OR ((2 <= P-client_waiting_1) OR (1 <= P-client_ack_18) OR (P-client_idle_17 + 1 <= P-client_waiting_18) OR ((P-client_idle_7 <= P-lb_load_2_20) AND (P-client_ack_6 <= P-server_waiting_2) AND (2 <= P-client_waiting_4)) OR (1 <= P-lb_load_1_7))) : E (G (A (F ((P-client_request_8 <= 1))))) : ((E (((3 <= P-lb_load_2_8) U (3 <= P-lb_routing_1_13))) AND E (X ((1 <= P-client_idle_12)))) OR (E (G ((P-lb_load_1_20 + 1 <= P-server_waiting_2))) OR A (((P-server_processed_1 <= P-server_request_4_1) U (1 <= P-server_request_1_1)))))
lola: computing a collection of formulas
lola: RUNNING
lola: subprocess 0 will run for 221 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: (E (G (((2 <= P-client_ack_11) OR (P-client_ack_4 <= P-lb_load_1_12)))) OR (P-client_idle_20 <= P-client_request_2))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 0 will run for 221 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (G (((2 <= P-client_ack_11) OR (P-client_ack_4 <= P-lb_load_1_12))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: NOT(A(TRUE U ((P-client_ack_11 <= 1) AND (P-lb_load_1_12 + 1 <= P-client_ack_4))))
lola: processed formula length: 82
lola: 2 rewrites
lola: formula mentions 0 of 194 places; total mentions: 0
lola: closed formula file SimpleLoadBal-PT-20-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 20 bytes per marking, with 15 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: 68 markings, 68 edges
lola: ========================================
lola: SUBRESULT
lola: result: yes
lola: The Boolean predicate is true.
lola: ========================================
lola: subprocess 1 will run for 236 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (F (E (X (((3 <= P-client_waiting_13) AND (P-client_waiting_13 <= P-lb_load_1_14))))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: A(TRUE U EX(((3 <= P-client_waiting_13) AND (P-client_waiting_13 <= P-lb_load_1_14))))
lola: processed formula length: 86
lola: 2 rewrites
lola: formula mentions 0 of 194 places; total mentions: 0
lola: closed formula file SimpleLoadBal-PT-20-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 20 bytes per marking, with 15 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: SUBRESULT
lola: result: no
lola: produced by: CTL model checker
lola: The net does not satisfy the given formula.
lola: 68 markings, 68 edges
lola: ========================================
lola: subprocess 2 will run for 252 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: A (G ((P-lb_load_2_7 <= P-client_request_14)))
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 20 bytes per marking, with 15 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 SimpleLoadBal-PT-20-CTLCardinality-2.sara
lola: state equation: calling and running sara
lola: SUBRESULT
lola: result: no
lola: produced by: state space
lola: The predicate is not invariant.
lola: 43 markings, 42 edges
lola: ========================================
lola: subprocess 3 will run for 272 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E ((((P-lb_load_2_12 + 1 <= P-client_request_9) AND (P-lb_load_2_19 <= P-client_idle_9)) U E (F ((3 <= P-lb_routing_1_8)))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: E(((P-lb_load_2_12 + 1 <= P-client_request_9) AND (P-lb_load_2_19 <= P-client_idle_9)) U E(TRUE U (3 <= P-lb_routing_1_8)))
lola: processed formula length: 123
lola: 2 rewrites
lola: formula mentions 0 of 194 places; total mentions: 0
lola: closed formula file SimpleLoadBal-PT-20-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 20 bytes per marking, with 15 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: 902685 markings, 1202418 edges, 3689320832170983424 markings/sec, 0 secs
lola: 1812514 markings, 2414812 edges, 181966 markings/sec, 5 secs
lola: 2712610 markings, 3638120 edges, 180019 markings/sec, 10 secs
lola: 3638274 markings, 4933167 edges, 185133 markings/sec, 15 secs
lola: 4539053 markings, 6174985 edges, 180156 markings/sec, 20 secs
lola: 5490044 markings, 7510419 edges, 190198 markings/sec, 25 secs
lola: 6437399 markings, 8847259 edges, 189471 markings/sec, 30 secs
lola: 7329548 markings, 10041499 edges, 178430 markings/sec, 35 secs
lola: 8260926 markings, 11344526 edges, 186276 markings/sec, 40 secs
lola: 9197275 markings, 12649826 edges, 187270 markings/sec, 45 secs
lola: 10120055 markings, 13936498 edges, 184556 markings/sec, 50 secs
lola: 11061309 markings, 15259082 edges, 188251 markings/sec, 55 secs
lola: 12014552 markings, 16602151 edges, 190649 markings/sec, 60 secs
lola: 12954016 markings, 17906899 edges, 187893 markings/sec, 65 secs
lola: 13884057 markings, 19210949 edges, 186008 markings/sec, 70 secs
lola: 14819691 markings, 20514755 edges, 187127 markings/sec, 75 secs
lola: 15766048 markings, 21856195 edges, 189271 markings/sec, 80 secs
lola: 16706270 markings, 23173394 edges, 188044 markings/sec, 85 secs
lola: 17596162 markings, 24354310 edges, 177978 markings/sec, 90 secs
lola: 18519108 markings, 25634132 edges, 184589 markings/sec, 95 secs
lola: 19427594 markings, 26888134 edges, 181697 markings/sec, 100 secs
lola: 20336776 markings, 28139480 edges, 181836 markings/sec, 105 secs
lola: 21259137 markings, 29421685 edges, 184472 markings/sec, 110 secs
lola: 22178837 markings, 30710244 edges, 183940 markings/sec, 115 secs
lola: 23102572 markings, 31997091 edges, 184747 markings/sec, 120 secs
lola: 24014332 markings, 33261066 edges, 182352 markings/sec, 125 secs
lola: 24947050 markings, 34561761 edges, 186544 markings/sec, 130 secs
lola: 25868395 markings, 35798847 edges, 184269 markings/sec, 135 secs
lola: 26756603 markings, 36967180 edges, 177642 markings/sec, 140 secs
lola: 27604400 markings, 38098879 edges, 169559 markings/sec, 145 secs
lola: 28561092 markings, 39432614 edges, 191338 markings/sec, 150 secs
lola: 29553567 markings, 40809908 edges, 198495 markings/sec, 155 secs
lola: 30513490 markings, 42121764 edges, 191985 markings/sec, 160 secs
lola: 31440051 markings, 43422386 edges, 185312 markings/sec, 165 secs
lola: 32358226 markings, 44708662 edges, 183635 markings/sec, 170 secs
lola: 33267176 markings, 45989552 edges, 181790 markings/sec, 175 secs
lola: 34192205 markings, 47299414 edges, 185006 markings/sec, 180 secs
lola: 35136471 markings, 48628021 edges, 188853 markings/sec, 185 secs
lola: 36068527 markings, 49922196 edges, 186411 markings/sec, 190 secs
lola: 37001466 markings, 51220460 edges, 186588 markings/sec, 195 secs
lola: 37944986 markings, 52520042 edges, 188704 markings/sec, 200 secs
lola: 38884247 markings, 53822725 edges, 187852 markings/sec, 205 secs
lola: 39816238 markings, 55118427 edges, 186398 markings/sec, 210 secs
lola: 40722879 markings, 56372413 edges, 181328 markings/sec, 215 secs
lola: 41633546 markings, 57628634 edges, 182133 markings/sec, 220 secs
lola: 42596780 markings, 58959862 edges, 192647 markings/sec, 225 secs
lola: 43494442 markings, 60205460 edges, 179532 markings/sec, 230 secs
lola: 44418577 markings, 61487263 edges, 184827 markings/sec, 235 secs
lola: 45374438 markings, 62809014 edges, 191172 markings/sec, 240 secs
lola: 46345362 markings, 64150098 edges, 194185 markings/sec, 245 secs
lola: 47315404 markings, 65494896 edges, 194008 markings/sec, 250 secs
lola: 48250094 markings, 66803930 edges, 186938 markings/sec, 255 secs
lola: 49211255 markings, 68122993 edges, 192232 markings/sec, 260 secs
lola: 50150948 markings, 69428885 edges, 187939 markings/sec, 265 secs
lola: local time limit reached - aborting
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 4 will run for 272 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (F ((3 <= P-server_request_3_2)))
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 20 bytes per marking, with 15 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 SimpleLoadBal-PT-20-CTLCardinality-4.sara
lola: state equation: calling and running sara
sara: try reading problem file SimpleLoadBal-PT-20-CTLCardinality-4.sara.
sara: place or transition ordering is non-deterministic
lola: sara is running 0 secs || 17886 markings, 19703 edges, 3577 markings/sec, 0 secs
lola: sara is running 5 secs || 36904 markings, 41143 edges, 3804 markings/sec, 5 secs
lola: sara is running 10 secs || 55896 markings, 62407 edges, 3798 markings/sec, 10 secs
lola: sara is running 15 secs || 74814 markings, 83771 edges, 3784 markings/sec, 15 secs
lola: sara is running 20 secs || 93681 markings, 105291 edges, 3773 markings/sec, 20 secs
lola: sara is running 25 secs || 112605 markings, 126621 edges, 3785 markings/sec, 25 secs
lola: sara is running 30 secs || 131349 markings, 147952 edges, 3749 markings/sec, 30 secs
lola: sara is running 35 secs || 150246 markings, 169597 edges, 3779 markings/sec, 35 secs
lola: sara is running 40 secs || 168785 markings, 190867 edges, 3708 markings/sec, 40 secs
lola: sara is running 45 secs || 187346 markings, 211973 edges, 3712 markings/sec, 45 secs
lola: sara is running 50 secs || 206051 markings, 233233 edges, 3741 markings/sec, 50 secs
lola: sara is running 55 secs || 224667 markings, 254359 edges, 3723 markings/sec, 55 secs
lola: sara is running 60 secs || 243203 markings, 275370 edges, 3707 markings/sec, 60 secs
lola: sara is running 65 secs || 261795 markings, 296671 edges, 3718 markings/sec, 65 secs
lola: sara is running 70 secs || 280280 markings, 317849 edges, 3697 markings/sec, 70 secs
lola: sara is running 75 secs || 298639 markings, 339098 edges, 3672 markings/sec, 75 secs
lola: sara is running 80 secs || 317194 markings, 360326 edges, 3711 markings/sec, 80 secs
lola: sara is running 85 secs || 335741 markings, 381573 edges, 3709 markings/sec, 85 secs
lola: sara is running 90 secs || 354280 markings, 402872 edges, 3708 markings/sec, 90 secs
lola: sara is running 95 secs || 372836 markings, 424000 edges, 3711 markings/sec, 95 secs
lola: sara is running 100 secs || 391478 markings, 445157 edges, 3728 markings/sec, 100 secs
lola: sara is running 105 secs || 410043 markings, 466494 edges, 3713 markings/sec, 105 secs
lola: sara is running 110 secs || 428534 markings, 487778 edges, 3698 markings/sec, 110 secs
lola: sara is running 115 secs || 447030 markings, 509054 edges, 3699 markings/sec, 115 secs
lola: sara is running 120 secs || 465606 markings, 530345 edges, 3715 markings/sec, 120 secs
lola: sara is running 125 secs || 484179 markings, 551609 edges, 3715 markings/sec, 125 secs
lola: sara is running 130 secs || 502832 markings, 572961 edges, 3731 markings/sec, 130 secs
lola: sara is running 135 secs || 521621 markings, 594461 edges, 3758 markings/sec, 135 secs
lola: sara is running 140 secs || 540378 markings, 615881 edges, 3751 markings/sec, 140 secs
lola: sara is running 145 secs || 559026 markings, 637432 edges, 3730 markings/sec, 145 secs
lola: sara is running 150 secs || 577497 markings, 659186 edges, 3694 markings/sec, 150 secs
lola: sara is running 155 secs || 596186 markings, 680809 edges, 3738 markings/sec, 155 secs
lola: sara is running 160 secs || 615013 markings, 702291 edges, 3765 markings/sec, 160 secs
lola: sara is running 165 secs || 633736 markings, 723862 edges, 3745 markings/sec, 165 secs
lola: sara is running 170 secs || 652398 markings, 745266 edges, 3732 markings/sec, 170 secs
lola: sara is running 175 secs || 671241 markings, 766436 edges, 3769 markings/sec, 175 secs
lola: sara is running 180 secs || 689989 markings, 787833 edges, 3750 markings/sec, 180 secs
lola: sara is running 185 secs || 708811 markings, 809395 edges, 3764 markings/sec, 185 secs
lola: sara is running 190 secs || 727553 markings, 830809 edges, 3748 markings/sec, 190 secs
lola: sara is running 195 secs || 746179 markings, 852407 edges, 3725 markings/sec, 195 secs
lola: sara is running 200 secs || 764776 markings, 874024 edges, 3719 markings/sec, 200 secs
lola: sara is running 205 secs || 783481 markings, 895450 edges, 3741 markings/sec, 205 secs
lola: sara is running 210 secs || 802098 markings, 917030 edges, 3723 markings/sec, 210 secs
lola: sara is running 215 secs || 820727 markings, 938698 edges, 3726 markings/sec, 215 secs
lola: sara is running 220 secs || 839565 markings, 960260 edges, 3768 markings/sec, 220 secs
lola: sara is running 225 secs || 858227 markings, 981696 edges, 3732 markings/sec, 225 secs
lola: sara is running 230 secs || 876832 markings, 1003171 edges, 3721 markings/sec, 230 secs
lola: sara is running 235 secs || 895411 markings, 1024622 edges, 3716 markings/sec, 235 secs
lola: sara is running 240 secs || 914037 markings, 1046109 edges, 3725 markings/sec, 240 secs
lola: sara is running 245 secs || 932709 markings, 1067630 edges, 3734 markings/sec, 245 secs
lola: sara is running 250 secs || 951393 markings, 1089161 edges, 3737 markings/sec, 250 secs
lola: sara is running 255 secs || 970013 markings, 1110689 edges, 3724 markings/sec, 255 secs
lola: sara is running 260 secs || 988623 markings, 1132180 edges, 3722 markings/sec, 260 secs
lola: sara is running 265 secs || 1007250 markings, 1153673 edges, 3725 markings/sec, 265 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 272 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: NOT(A (G (A (F ((P-lb_load_2_17 <= P-client_request_15))))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: processed formula: E(TRUE U NOT(A(TRUE U (P-lb_load_2_17 <= P-client_request_15))))
lola: processed formula length: 64
lola: 8 rewrites
lola: formula mentions 0 of 194 places; total mentions: 0
lola: closed formula file SimpleLoadBal-PT-20-CTLCardinality.task
lola: STORE
lola: using a bit-perfect encoder (--encoder=bit)
lola: using 20 bytes per marking, with 15 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: 936906 markings, 2146702 edges, 3689330178019819520 markings/sec, 0 secs
lola: 1867676 markings, 4315233 edges, 186154 markings/sec, 5 secs
lola: 2774034 markings, 6400291 edges, 181272 markings/sec, 10 secs
lola: 3676672 markings, 8486909 edges, 180528 markings/sec, 15 secs
lola: 4608649 markings, 10669680 edges, 186395 markings/sec, 20 secs
lola: 5518803 markings, 12767354 edges, 182031 markings/sec, 25 secs
lola: 6446018 markings, 14942046 edges, 185443 markings/sec, 30 secs
lola: 7378833 markings, 17138549 edges, 186563 markings/sec, 35 secs
lola: 8296440 markings, 19297780 edges, 183521 markings/sec, 40 secs
lola: 9221881 markings, 21488675 edges, 185088 markings/sec, 45 secs
lola: 10135883 markings, 23641968 edges, 182800 markings/sec, 50 secs
lola: 11048279 markings, 25788788 edges, 182479 markings/sec, 55 secs
lola: 11915480 markings, 27830980 edges, 173440 markings/sec, 60 secs
lola: 12822013 markings, 29974527 edges, 181307 markings/sec, 65 secs
lola: 13731013 markings, 32122893 edges, 181800 markings/sec, 70 secs
lola: 14638861 markings, 34258215 edges, 181570 markings/sec, 75 secs
lola: 15543104 markings, 36386951 edges, 180849 markings/sec, 80 secs
lola: 16436968 markings, 38503250 edges, 178773 markings/sec, 85 secs
lola: 17325323 markings, 40604752 edges, 177671 markings/sec, 90 secs
lola: 18199898 markings, 42656784 edges, 174915 markings/sec, 95 secs
lola: 19097333 markings, 44765676 edges, 179487 markings/sec, 100 secs
lola: 19977894 markings, 46831525 edges, 176112 markings/sec, 105 secs
lola: 20858112 markings, 48899190 edges, 176044 markings/sec, 110 secs
lola: 21722176 markings, 50932951 edges, 172813 markings/sec, 115 secs
lola: 22575484 markings, 52937856 edges, 170662 markings/sec, 120 secs
lola: 23436523 markings, 54967534 edges, 172208 markings/sec, 125 secs
lola: 24299031 markings, 56995837 edges, 172502 markings/sec, 130 secs
lola: 25164344 markings, 59022415 edges, 173063 markings/sec, 135 secs
lola: 26023480 markings, 61042028 edges, 171827 markings/sec, 140 secs
lola: 26881050 markings, 63051882 edges, 171514 markings/sec, 145 secs
lola: 27742341 markings, 65071290 edges, 172258 markings/sec, 150 secs
lola: 28566483 markings, 67010436 edges, 164828 markings/sec, 155 secs
lola: 29423784 markings, 69042363 edges, 171460 markings/sec, 160 secs
lola: 30264651 markings, 71017481 edges, 168173 markings/sec, 165 secs
lola: 31111737 markings, 73017143 edges, 169417 markings/sec, 170 secs
lola: 31958425 markings, 75019041 edges, 169338 markings/sec, 175 secs
lola: 32808673 markings, 77023109 edges, 170050 markings/sec, 180 secs
lola: 33660477 markings, 79036861 edges, 170361 markings/sec, 185 secs
lola: 34576162 markings, 81144185 edges, 183137 markings/sec, 190 secs
lola: 35409158 markings, 83111131 edges, 166599 markings/sec, 195 secs
lola: 36246169 markings, 85089863 edges, 167402 markings/sec, 200 secs
lola: 37083643 markings, 87073614 edges, 167495 markings/sec, 205 secs
lola: 37916248 markings, 89028312 edges, 166521 markings/sec, 210 secs
lola: 38754709 markings, 91011791 edges, 167692 markings/sec, 215 secs
lola: 39595589 markings, 92997719 edges, 168176 markings/sec, 220 secs
lola: 40439788 markings, 94991477 edges, 168840 markings/sec, 225 secs
lola: 41276455 markings, 96974071 edges, 167333 markings/sec, 230 secs
lola: 42111184 markings, 98945230 edges, 166946 markings/sec, 235 secs
lola: 42959220 markings, 100947762 edges, 169607 markings/sec, 240 secs
lola: 43799688 markings, 102932993 edges, 168094 markings/sec, 245 secs
lola: 44638872 markings, 104915430 edges, 167837 markings/sec, 250 secs
lola: 45524884 markings, 106995734 edges, 177202 markings/sec, 255 secs
lola: 46398384 markings, 109048543 edges, 174700 markings/sec, 260 secs
lola: 47308800 markings, 111161035 edges, 182083 markings/sec, 265 secs
lola: local time limit reached - aborting
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 6 will run for 272 seconds at most (--localtimelimit=-1)
lola: ========================================
lola: ...considering subproblem: E (F (((P-client_request_7 <= P-lb_load_2_8) AND (P-lb_load_1_14 <= P-client_ack_12) AND ((P-client_request_12 <= P-client_ack_2) OR (1 <= P-client_waiting_17)) AND (P-client_request_17 <= 1) AND (P-client_idle_19 + 1 <= P-lb_load_1_17))))
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 20 bytes per marking, with 15 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 10 literals and 2 conjunctive subformulas
lola: state equation: write sara problem file to SimpleLoadBal-PT-20-CTLCardinality-6.sara
lola: state equation: calling and running sara
sara: try reading problem file SimpleLoadBal-PT-20-CTLCardinality-6.sara.
sara: place or transition ordering is non-deterministic
lola: sara is running 0 secs || 15310 markings, 19680 edges, 3062 markings/sec, 0 secs
lola: sara is running 5 secs || 31392 markings, 40224 edges, 3216 markings/sec, 5 secs
lola: sara is running 10 secs || 47430 markings, 61122 edges, 3208 markings/sec, 10 secs
lola: sara is running 15 secs || 63192 markings, 82292 edges, 3152 markings/sec, 15 secs
lola: sara is running 20 secs || 79566 markings, 102745 edges, 3275 markings/sec, 20 secs
lola: sara is running 25 secs || 95640 markings, 123694 edges, 3215 markings/sec, 25 secs
lola: sara is running 30 secs || 111763 markings, 144454 edges, 3225 markings/sec, 30 secs
lola: sara is running 35 secs || 127546 markings, 165648 edges, 3157 markings/sec, 35 secs
lola: sara is running 40 secs || 143282 markings, 187087 edges, 3147 markings/sec, 40 secs
lola: sara is running 45 secs || 159209 markings, 208213 edges, 3185 markings/sec, 45 secs
lola: sara is running 50 secs || 175339 markings, 228927 edges, 3226 markings/sec, 50 secs
lola: sara is running 55 secs || 191392 markings, 249753 edges, 3211 markings/sec, 55 secs
lola: sara is running 60 secs || 207496 markings, 270617 edges, 3221 markings/sec, 60 secs
lola: sara is running 65 secs || 223637 markings, 291489 edges, 3228 markings/sec, 65 secs
lola: sara is running 70 secs || 239491 markings, 312663 edges, 3171 markings/sec, 70 secs
lola: sara is running 75 secs || 255425 markings, 333517 edges, 3187 markings/sec, 75 secs
lola: sara is running 80 secs || 271399 markings, 354615 edges, 3195 markings/sec, 80 secs
lola: sara is running 85 secs || 287234 markings, 375856 edges, 3167 markings/sec, 85 secs
lola: sara is running 90 secs || 303325 markings, 396664 edges, 3218 markings/sec, 90 secs
lola: sara is running 95 secs || 319546 markings, 417431 edges, 3244 markings/sec, 95 secs
lola: sara is running 100 secs || 335902 markings, 437958 edges, 3271 markings/sec, 100 secs
lola: sara is running 105 secs || 352167 markings, 458501 edges, 3253 markings/sec, 105 secs
lola: sara is running 110 secs || 368420 markings, 479184 edges, 3251 markings/sec, 110 secs
lola: sara is running 115 secs || 383870 markings, 500890 edges, 3090 markings/sec, 115 secs
lola: sara is running 120 secs || 399984 markings, 521808 edges, 3223 markings/sec, 120 secs
lola: sara is running 125 secs || 415782 markings, 543232 edges, 3160 markings/sec, 125 secs
lola: sara is running 130 secs || 432081 markings, 563920 edges, 3260 markings/sec, 130 secs
lola: sara is running 135 secs || 448306 markings, 584757 edges, 3245 markings/sec, 135 secs
lola: sara is running 140 secs || 464457 markings, 605465 edges, 3230 markings/sec, 140 secs
lola: sara is running 145 secs || 480637 markings, 626347 edges, 3236 markings/sec, 145 secs
lola: sara is running 150 secs || 496581 markings, 647601 edges, 3189 markings/sec, 150 secs
lola: sara is running 155 secs || 512407 markings, 668912 edges, 3165 markings/sec, 155 secs
lola: sara is running 160 secs || 528557 markings, 689717 edges, 3230 markings/sec, 160 secs
lola: sara is running 165 secs || 544420 markings, 711012 edges, 3173 markings/sec, 165 secs
lola: sara is running 170 secs || 560406 markings, 731887 edges, 3197 markings/sec, 170 secs
lola: sara is running 175 secs || 576481 markings, 752860 edges, 3215 markings/sec, 175 secs
lola: sara is running 180 secs || 592324 markings, 774052 edges, 3169 markings/sec, 180 secs
lola: sara is running 185 secs || 608288 markings, 795007 edges, 3193 markings/sec, 185 secs
lola: sara is running 190 secs || 624412 markings, 816249 edges, 3225 markings/sec, 190 secs
lola: sara is running 195 secs || 640183 markings, 837843 edges, 3154 markings/sec, 195 secs
lola: sara is running 200 secs || 656098 markings, 859029 edges, 3183 markings/sec, 200 secs
lola: sara is running 205 secs || 671998 markings, 880199 edges, 3180 markings/sec, 205 secs
lola: sara is running 210 secs || 688138 markings, 901088 edges, 3228 markings/sec, 210 secs
lola: sara is running 215 secs || 703641 markings, 922917 edges, 3101 markings/sec, 215 secs
lola: sara is running 220 secs || 719901 markings, 943571 edges, 3252 markings/sec, 220 secs
lola: sara is running 225 secs || 736061 markings, 964417 edges, 3232 markings/sec, 225 secs
lola: sara is running 230 secs || 752249 markings, 985341 edges, 3238 markings/sec, 230 secs
lola: sara is running 235 secs || 768532 markings, 1006018 edges, 3257 markings/sec, 235 secs
lola: sara is running 240 secs || 784420 markings, 1027330 edges, 3178 markings/sec, 240 secs
lola: sara is running 245 secs || 800549 markings, 1048210 edges, 3226 markings/sec, 245 secs
lola: sara is running 250 secs || 816669 markings, 1069148 edges, 3224 markings/sec, 250 secs
lola: sara is running 255 secs || 832853 markings, 1090062 edges, 3237 markings/sec, 255 secs
lola: sara is running 260 secs || 849074 markings, 1110911 edges, 3244 markings/sec, 260 secs
lola: sara is running 265 secs || 864881 markings, 1132321 edges, 3161 markings/sec, 265 secs
lola: local time limit reached - aborting
lola: Child process aborted or communication problem between parent and child process
terminate called after throwing an instance of 'std::runtime_error'
what(): parse error at position 0: unexpected character, last read: '
Aborted (core dumped)
FORMULA SimpleLoadBal-PT-20-CTLCardinality-0 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-1 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-2 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-3 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-4 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-5 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-6 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-7 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-8 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-9 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-10 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-11 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-12 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-13 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-14 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
FORMULA SimpleLoadBal-PT-20-CTLCardinality-15 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT STATE_COMPRESSION STUBBORN_SETS TOPOLOGICAL USE_NUPN
----- Kill lola and sara stdout -----
----- Kill lola and sara stderr -----
----- Finished stdout -----
----- Finished stderr -----

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="SimpleLoadBal-PT-20"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="mcc4mcc-structural"
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/SimpleLoadBal-PT-20.tgz
mv SimpleLoadBal-PT-20 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-structural"
echo " Input is SimpleLoadBal-PT-20, 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 r179-smll-152708748900171"
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 '' CTLCardinality.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
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 ;