About the Execution of ITS-LoLa for ShieldRVt-PT-010A
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
15743.170 | 3600000.00 | 1250397.00 | 10287.90 | TTFTTTFF?FTFTFFF | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/mnt/tpsp/fkordon/mcc2020-input.r211-tajo-159033478301003.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/fkordon/mcc2020-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
....................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itslola
Input is ShieldRVt-PT-010A, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r211-tajo-159033478301003
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 188K
-rw-r--r-- 1 mcc users 3.3K May 14 02:40 CTLCardinality.txt
-rw-r--r-- 1 mcc users 20K May 14 02:40 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.4K May 13 20:17 CTLFireability.txt
-rw-r--r-- 1 mcc users 16K May 13 20:17 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.0K May 14 10:05 LTLCardinality.txt
-rw-r--r-- 1 mcc users 22K May 14 10:05 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.9K May 14 10:05 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K May 14 10:05 LTLFireability.xml
-rw-r--r-- 1 mcc users 1 May 12 20:42 NewModel
-rw-r--r-- 1 mcc users 3.3K May 13 14:41 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 17K May 13 14:41 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.5K May 13 09:32 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 15K May 13 09:32 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K May 13 16:53 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.6K May 13 16:53 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 12 20:42 equiv_col
-rw-r--r-- 1 mcc users 5 May 12 20:42 instance
-rw-r--r-- 1 mcc users 6 May 12 20:42 iscolored
-rw-r--r-- 1 mcc users 27K May 12 20:42 model.pnml
--------------------
content from stdout:
=== Data for post analysis generated by BenchKit (invocation template)
The expected result is a vector of booleans
BOOL_VECTOR
here is the order used to build the result vector(from text file)
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-00
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-01
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-02
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-03
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-04
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-05
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-06
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-07
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-08
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-09
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-10
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-11
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-12
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-13
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-14
FORMULA_NAME ShieldRVt-PT-010A-CTLCardinality-15
=== Now, execution of the tool begins
BK_START 1591337127173
bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-05 06:05:28] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2020-06-05 06:05:28] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-05 06:05:28] [INFO ] Load time of PNML (sax parser for PT used): 36 ms
[2020-06-05 06:05:28] [INFO ] Transformed 83 places.
[2020-06-05 06:05:28] [INFO ] Transformed 83 transitions.
[2020-06-05 06:05:28] [INFO ] Found NUPN structural information;
[2020-06-05 06:05:28] [INFO ] Parsed PT model containing 83 places and 83 transitions in 70 ms.
Ensure Unique test removed 1 transitions
Reduce redundant transitions removed 1 transitions.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 14 ms.
Finished random walk after 11814 steps, including 0 resets, run visited all 16 properties in 42 ms. (steps per millisecond=281 )
[2020-06-05 06:05:28] [INFO ] Initial state reduction rules for CTL removed 12 formulas.
[2020-06-05 06:05:28] [INFO ] Flatten gal took : 33 ms
[2020-06-05 06:05:28] [INFO ] Initial state reduction rules for CTL removed 12 formulas.
[2020-06-05 06:05:28] [INFO ] Flatten gal took : 10 ms
FORMULA ShieldRVt-PT-010A-CTLCardinality-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-14 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-13 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-10 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-09 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-05 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-03 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-02 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldRVt-PT-010A-CTLCardinality-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2020-06-05 06:05:28] [INFO ] Export to MCC properties in file /home/mcc/execution/CTLCardinality.sr.xml took 2 ms.
[2020-06-05 06:05:29] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 2 ms.
info: Time: 3600 - MCC
vrfy: Checking CTLCardinality @ ShieldRVt-PT-010A @ 3570 seconds
FORMULA ShieldRVt-PT-010A-CTLCardinality-11 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA ShieldRVt-PT-010A-CTLCardinality-00 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA ShieldRVt-PT-010A-CTLCardinality-08 CANNOT_COMPUTE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
FORMULA ShieldRVt-PT-010A-CTLCardinality-12 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
vrfy: finished
info: timeLeft: 2374
rslt: Output for CTLCardinality @ ShieldRVt-PT-010A
{
"build":
{
"architecture": 64,
"assertions": false,
"build_hostname": "mcc2019",
"build_system": "x86_64-unknown-linux-gnu",
"optimizations": true,
"package_version": "2.0",
"svn_version": "3189M"
},
"call":
{
"exec_host": "mcc2020",
"markinglimit": null,
"parameters":
[
"--pnmlnet",
"model.pnml",
"--xmlformula",
"--formula=CTLCardinality.xml",
"--mcc",
"--donotcomputecapacities",
"--encoder=simplecompressed",
"--check=modelchecking",
"--stubborn=tarjan",
"--stateequation=par",
"--quickchecks",
"--timelimit=3570",
"--localtimelimit=0",
"--preference=force_ctl",
"--json=CTLCardinality.json",
"--jsoninclude=formula,formulastat,net"
],
"starttime": "Fri Jun 5 06:05:29 2020
",
"timelimit": 3570
},
"child":
[
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 891
},
"child":
[
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 891
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 1,
"aneg": 0,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 1,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 1,
"visible_transitions": 0
},
"processed": "((p64 <= 0))",
"processed_size": 12,
"rewrites": 9
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": true
},
"task":
{
"compoundnumber": 0,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 1189
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 1,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 1,
"aconj": 2,
"adisj": 1,
"aneg": 1,
"comp": 2,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 2,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 2,
"visible_transitions": 0
},
"processed": "AX((((1 <= p28)) AND ((p26 <= 0))))",
"processed_size": 35,
"rewrites": 10
},
"net":
{
"conflict_clusters": 23,
"singleton_clusters": 0
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "CTL model checker",
"value": false
},
"task":
{
"compoundnumber": 1,
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "ctl preserving"
},
"type": "ctl model checker"
},
"type": "CTL"
}
}
],
"exit":
{
"localtimelimitreached": false
},
"result":
{
"produced_by": "boolean",
"value": false
},
"task":
{
"compoundnumber": 0,
"type": "boolean"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 1189
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 1,
"F": 1,
"G": 0,
"U": 0,
"X": 0,
"aconj": 1,
"adisj": 0,
"aneg": 0,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 1,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 1,
"visible_transitions": 0
},
"processed": "E (F (((1 <= p3))))",
"processed_size": 19,
"rewrites": 10
},
"result":
{
"edges": 14,
"markings": 15,
"produced_by": "state space",
"value": true
},
"task":
{
"compoundnumber": 1,
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "reachability preserving/insertion"
},
"threads": 1,
"type": "dfs"
},
"stateequation":
{
"literals": 1,
"problems": 1
},
"type": "reachability",
"workflow": "stateequation||search"
}
},
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 3028
},
"child":
[
{
"call":
{
"dynamic_timelimit": true,
"localtimelimit": 3028
},
"exit":
{
"localtimelimitreached": false
},
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 1,
"adisj": 0,
"aneg": 1,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 1,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 1,
"visible_transitions": 0
},
"processed": "((p48 <= 0))",
"processed_size": 12,
"rewrites": 9
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": true
},
"task":
{
"compoundnumber": 3,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
}
],
"exit":
{
"localtimelimitreached": false
},
"result":
{
"produced_by": "boolean",
"value": null
},
"task":
{
"compoundnumber": 3,
"type": "boolean"
}
},
{
"child":
[
{
"formula":
{
"count":
{
"A": 0,
"E": 0,
"F": 0,
"G": 0,
"U": 0,
"X": 0,
"aconj": 1,
"adisj": 0,
"aneg": 1,
"comp": 1,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 1,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 1,
"visible_transitions": 0
},
"processed": "((p48 <= 0))",
"processed_size": 12,
"rewrites": 9
},
"result":
{
"edges": 0,
"markings": 0,
"produced_by": "preprocessing",
"value": true
},
"task":
{
"compoundnumber": 5,
"type": "initial_satisfaction",
"workflow": "preprocessing"
}
},
{
"formula":
{
"count":
{
"A": 0,
"E": 1,
"F": 1,
"G": 0,
"U": 0,
"X": 0,
"aconj": 4,
"adisj": 1,
"aneg": 1,
"comp": 4,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 4,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 4,
"visible_transitions": 0
},
"processed": "E (F ((((1 <= p45)) AND ((p30 <= 0)) AND ((1 <= p60)) AND ((p44 <= 0)))))",
"processed_size": 73,
"rewrites": 10
},
"result":
{
"edges": 128,
"markings": 122,
"produced_by": "state space",
"value": true
},
"task":
{
"compoundnumber": 6,
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "reachability preserving/insertion"
},
"threads": 1,
"type": "dfs"
},
"stateequation":
{
"literals": 4,
"problems": 4
},
"type": "reachability",
"workflow": "stateequation||search"
}
}
],
"result":
{
"produced_by": "boolean",
"value": true
},
"task":
{
"compoundnumber": 5,
"type": "boolean"
}
}
],
"exit":
{
"error": null,
"memory": 3800,
"runtime": 1196.000000,
"signal": null,
"timelimitreached": false
},
"files":
{
"formula": "CTLCardinality.xml",
"net": "model.pnml"
},
"formula":
{
"skeleton": "E(F(**)) : A(G(E(F(**)))) : (** AND A(X(*))) : (* AND E(F(*)))"
},
"net":
{
"arcs": 344,
"conflict_clusters": 23,
"places": 83,
"places_significant": 42,
"singleton_clusters": 0,
"transitions": 82
},
"result":
{
"preliminary_value": "yes unknown no yes ",
"value": "yes unknown no yes "
},
"task":
{
"type": "compound"
}
}
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: input: PNML file (--pnml)
lola: reading net from model.pnml
lola: reading pnml
lola: PNML file contains place/transition net
lola: finished parsing
lola: closed net file model.pnml
lola: 165/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 2656
lola: finding significant places
lola: 83 places, 82 transitions, 42 significant places
lola: compute conflict clusters
lola: computed conflict clusters
lola: Computing conflicting sets
lola: Computing back conflicting sets
lola: TASK
lola: Reading formula in XML format (--xmlformula)
lola: reading pnml
lola: reading formula from CTLCardinality.xml
lola: LP says that atomic proposition is always true: (p3 <= 1)
lola: LP says that atomic proposition is always true: (p23 <= 1)
lola: LP says that atomic proposition is always true: (p0 <= 1)
lola: LP says that atomic proposition is always true: (p64 <= 1)
lola: LP says that atomic proposition is always true: (p26 <= 1)
lola: LP says that atomic proposition is always true: (p48 <= 1)
lola: LP says that atomic proposition is always true: (p30 <= 1)
lola: LP says that atomic proposition is always true: (p44 <= 1)
lola: E (F (((1 <= p3)))) : A (G (E (F (((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0)))))))) : (((p64 <= 0)) AND NOT(E (X ((((p28 <= 0)) OR ((1 <= p26))))))) : (NOT(A (((1 <= 0) U ((1 <= p48))))) AND NOT(A (G ((((p45 <= 0)) OR ((1 <= p30)) OR ((p60 <= 0)) OR ((1 <= p44)))))))
lola: rewrite Frontend/Parser/formula_rewrite.k:326
lola: rewrite Frontend/Parser/formula_rewrite.k:335
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:184
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:329
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: computing a collection of formulas
lola: RUNNING
lola: subprocess 0 will run for 891 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: (((p64 <= 0)) AND A (X ((((1 <= p28)) AND ((p26 <= 0))))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 0 will run for 891 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: ((p64 <= 0))
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: ((p64 <= 0))
lola: processed formula length: 12
lola: 9 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: yes
lola: produced by: preprocessing
lola: The net satisfies the property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: subprocess 1 will run for 1189 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: A (X ((((1 <= p28)) AND ((p26 <= 0)))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: rewrite Frontend/Parser/formula_rewrite.k:812
lola: processed formula: AX((((1 <= p28)) AND ((p26 <= 0))))
lola: processed formula length: 35
lola: 10 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: Using CTL preserving stubborn sets
lola: RUNNING
lola: CTL formula contains 0 significant temporal operators and needs 0 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: 0 markings, 0 edges
lola: ========================================
lola: SUBRESULT
lola: result: no
lola: The Boolean predicate is false.
lola: ========================================
lola: subprocess 1 will run for 1189 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: E (F (((1 <= p3))))
lola: ========================================
lola: SUBTASK
lola: checking reachability
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: processed formula: E (F (((1 <= p3))))
lola: processed formula length: 19
lola: 10 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
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: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: ((1 <= p3))
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: SUBRESULT
lola: result: yes
lola: produced by: state space
lola: The predicate is reachable.
lola: 15 markings, 14 edges
lola: ========================================
lola: subprocess 2 will run for 1783 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: A (G (E (F (((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0))))))))
lola: ========================================
lola: SUBTASK
lola: checking liveness
lola: rewrite Frontend/Parser/formula_rewrite.k:603
lola: rewrite Frontend/Parser/formula_rewrite.k:613
lola: rewrite Frontend/Parser/formula_rewrite.k:703
lola: processed formula: ((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0))))
lola: processed formula length: 47
lola: 12 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH
lola: using tscc preserving stubborn set method (--stubborn)
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: state equation task get result started, id 1
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: state equation task get result rewrite finished id 1
lola: formula 0: ((p23 <= 0) OR (((1 <= p30)) AND ((p0 <= 0))))
lola: state equation task get result unparse finished id 0
lola: state equation task get result unparse finished++ id 1
lola: formula 1: ((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0))))
lola: state equation task get result unparse finished id 1
lola: state equation: Generated DNF with 4 literals and 2 conjunctive subformulas
lola: state equation: Generated DNF with 3 literals and 2 conjunctive subformulas
lola: state equation: write sara problem file to CTLCardinality-2-1.sara
lola: state equation: calling and running sara
lola: state equation: write sara problem file to CTLCardinality-2-0.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLCardinality-2-0.sara.
sara: try reading problem file CTLCardinality-2-1.sara.
sara: place or transition ordering is non-deterministic
sara: place or transition ordering is non-deterministic
lola: state equation 0: solution produced
lola: state equation 1: solution produced
lola: sara is running 0 secs || sara is running 0 secs || 2263995 markings, 3943884 edges, 452799 markings/sec, 0 secs
lola: sara is running 5 secs || sara is running 5 secs || 3813232 markings, 6901138 edges, 309847 markings/sec, 5 secs
lola: sara is running 10 secs || sara is running 10 secs || 5386798 markings, 9994428 edges, 314713 markings/sec, 10 secs
lola: sara is running 15 secs || sara is running 15 secs || 7040532 markings, 13315775 edges, 330747 markings/sec, 15 secs
lola: sara is running 20 secs || sara is running 20 secs || 8722425 markings, 16750306 edges, 336379 markings/sec, 20 secs
lola: sara is running 25 secs || sara is running 25 secs || 10343291 markings, 20103595 edges, 324173 markings/sec, 25 secs
lola: sara is running 30 secs || sara is running 30 secs || 11989016 markings, 23535246 edges, 329145 markings/sec, 30 secs
lola: sara is running 35 secs || sara is running 35 secs || 13557409 markings, 26827109 edges, 313679 markings/sec, 35 secs
lola: sara is running 40 secs || sara is running 40 secs || 15182706 markings, 30264539 edges, 325059 markings/sec, 40 secs
lola: sara is running 45 secs || sara is running 45 secs || 16807508 markings, 33732259 edges, 324960 markings/sec, 45 secs
lola: sara is running 50 secs || sara is running 50 secs || 18410085 markings, 37168885 edges, 320515 markings/sec, 50 secs
lola: sara is running 55 secs || sara is running 55 secs || 20000616 markings, 40601278 edges, 318106 markings/sec, 55 secs
lola: sara is running 60 secs || sara is running 60 secs || 21593430 markings, 44054714 edges, 318563 markings/sec, 60 secs
lola: sara is running 65 secs || sara is running 65 secs || 23181186 markings, 47507105 edges, 317551 markings/sec, 65 secs
lola: sara is running 70 secs || sara is running 70 secs || 24723975 markings, 50886945 edges, 308558 markings/sec, 70 secs
lola: sara is running 75 secs || sara is running 75 secs || 26256851 markings, 54252594 edges, 306575 markings/sec, 75 secs
lola: sara is running 80 secs || sara is running 80 secs || 27742151 markings, 57523736 edges, 297060 markings/sec, 80 secs
lola: sara is running 85 secs || sara is running 85 secs || 29032137 markings, 60373194 edges, 257997 markings/sec, 85 secs
lola: sara is running 90 secs || sara is running 90 secs || 30300151 markings, 63181626 edges, 253603 markings/sec, 90 secs
lola: sara is running 95 secs || sara is running 95 secs || 31524449 markings, 65892047 edges, 244860 markings/sec, 95 secs
lola: sara is running 100 secs || sara is running 100 secs || 32474349 markings, 68004481 edges, 189980 markings/sec, 100 secs
lola: sara is running 105 secs || sara is running 105 secs || 33400930 markings, 70061373 edges, 185316 markings/sec, 105 secs
lola: sara is running 110 secs || sara is running 110 secs || 34311785 markings, 72096528 edges, 182171 markings/sec, 110 secs
lola: sara is running 115 secs || sara is running 115 secs || 35664207 markings, 75117810 edges, 270484 markings/sec, 115 secs
lola: sara is running 120 secs || sara is running 120 secs || 37086832 markings, 78299229 edges, 284525 markings/sec, 120 secs
lola: sara is running 125 secs || sara is running 125 secs || 38289334 markings, 80982934 edges, 240500 markings/sec, 125 secs
lola: sara is running 130 secs || sara is running 130 secs || 39220232 markings, 83070714 edges, 186180 markings/sec, 130 secs
lola: sara is running 135 secs || sara is running 135 secs || 40126329 markings, 85109894 edges, 181219 markings/sec, 135 secs
lola: sara is running 140 secs || sara is running 140 secs || 41021772 markings, 87130783 edges, 179089 markings/sec, 140 secs
lola: sara is running 145 secs || sara is running 145 secs || 41954092 markings, 89231700 edges, 186464 markings/sec, 145 secs
lola: sara is running 150 secs || sara is running 150 secs || 43276486 markings, 92213126 edges, 264479 markings/sec, 150 secs
lola: sara is running 155 secs || sara is running 155 secs || 44642248 markings, 95294708 edges, 273152 markings/sec, 155 secs
lola: sara is running 160 secs || sara is running 160 secs || 46015357 markings, 98403695 edges, 274622 markings/sec, 160 secs
lola: sara is running 165 secs || sara is running 165 secs || 47378091 markings, 101502333 edges, 272547 markings/sec, 165 secs
lola: sara is running 170 secs || sara is running 170 secs || 48742471 markings, 104602974 edges, 272876 markings/sec, 170 secs
lola: sara is running 175 secs || sara is running 175 secs || 50094821 markings, 107677086 edges, 270470 markings/sec, 175 secs
lola: sara is running 180 secs || sara is running 180 secs || 51444593 markings, 110740353 edges, 269954 markings/sec, 180 secs
lola: sara is running 185 secs || sara is running 185 secs || 52789545 markings, 113805228 edges, 268990 markings/sec, 185 secs
lola: sara is running 190 secs || sara is running 190 secs || 54126242 markings, 116862949 edges, 267339 markings/sec, 190 secs
lola: sara is running 195 secs || sara is running 195 secs || 55468092 markings, 119919980 edges, 268370 markings/sec, 195 secs
lola: sara is running 200 secs || sara is running 200 secs || 56800087 markings, 122965760 edges, 266399 markings/sec, 200 secs
lola: sara is running 205 secs || sara is running 205 secs || 58130490 markings, 126022371 edges, 266081 markings/sec, 205 secs
lola: sara is running 210 secs || sara is running 210 secs || 59451152 markings, 129056587 edges, 264132 markings/sec, 210 secs
lola: sara is running 215 secs || sara is running 215 secs || 60780768 markings, 132101063 edges, 265923 markings/sec, 215 secs
lola: sara is running 220 secs || sara is running 220 secs || 62099228 markings, 135131590 edges, 263692 markings/sec, 220 secs
lola: sara is running 225 secs || sara is running 225 secs || 63356396 markings, 138026536 edges, 251434 markings/sec, 225 secs
lola: sara is running 230 secs || sara is running 230 secs || 64671802 markings, 141051666 edges, 263081 markings/sec, 230 secs
lola: sara is running 235 secs || sara is running 235 secs || 65974141 markings, 144061929 edges, 260468 markings/sec, 235 secs
lola: sara is running 240 secs || sara is running 240 secs || 67275880 markings, 147066510 edges, 260348 markings/sec, 240 secs
lola: sara is running 245 secs || sara is running 245 secs || 68579946 markings, 150075193 edges, 260813 markings/sec, 245 secs
lola: sara is running 250 secs || sara is running 250 secs || 69871850 markings, 153071683 edges, 258381 markings/sec, 250 secs
lola: sara is running 255 secs || sara is running 255 secs || 71165966 markings, 156071061 edges, 258823 markings/sec, 255 secs
lola: sara is running 260 secs || sara is running 260 secs || 72455272 markings, 159059965 edges, 257861 markings/sec, 260 secs
lola: sara is running 265 secs || sara is running 265 secs || 73764866 markings, 162065636 edges, 261919 markings/sec, 265 secs
lola: sara is running 270 secs || sara is running 270 secs || 75045462 markings, 165041503 edges, 256119 markings/sec, 270 secs
lola: sara is running 275 secs || sara is running 275 secs || 76327522 markings, 168011207 edges, 256412 markings/sec, 275 secs
lola: sara is running 280 secs || sara is running 280 secs || 77601727 markings, 170974718 edges, 254841 markings/sec, 280 secs
lola: sara is running 285 secs || sara is running 285 secs || 78875554 markings, 173939545 edges, 254765 markings/sec, 285 secs
lola: sara is running 290 secs || sara is running 290 secs || 80128266 markings, 176861371 edges, 250542 markings/sec, 290 secs
lola: sara is running 295 secs || sara is running 295 secs || 81321309 markings, 179645967 edges, 238609 markings/sec, 295 secs
lola: sara is running 300 secs || sara is running 300 secs || 82507362 markings, 182413470 edges, 237211 markings/sec, 300 secs
lola: sara is running 305 secs || sara is running 305 secs || 83732044 markings, 185281875 edges, 244936 markings/sec, 305 secs
lola: sara is running 310 secs || sara is running 310 secs || 84937345 markings, 188099609 edges, 241060 markings/sec, 310 secs
lola: sara is running 315 secs || sara is running 315 secs || 86140692 markings, 190912853 edges, 240669 markings/sec, 315 secs
lola: sara is running 320 secs || sara is running 320 secs || 87356864 markings, 193756400 edges, 243234 markings/sec, 320 secs
lola: sara is running 325 secs || sara is running 325 secs || 88480829 markings, 196392045 edges, 224793 markings/sec, 325 secs
lola: sara is running 330 secs || sara is running 330 secs || 89702632 markings, 199255503 edges, 244361 markings/sec, 330 secs
lola: sara is running 335 secs || sara is running 335 secs || 90936902 markings, 202144616 edges, 246854 markings/sec, 335 secs
lola: sara is running 340 secs || sara is running 340 secs || 92140439 markings, 204966401 edges, 240707 markings/sec, 340 secs
lola: sara is running 345 secs || sara is running 345 secs || 93332499 markings, 207768370 edges, 238412 markings/sec, 345 secs
lola: sara is running 350 secs || sara is running 350 secs || 94613620 markings, 210739726 edges, 256224 markings/sec, 350 secs
lola: sara is running 355 secs || sara is running 355 secs || 95816686 markings, 213564314 edges, 240613 markings/sec, 355 secs
lola: sara is running 360 secs || sara is running 360 secs || 97004981 markings, 216353309 edges, 237659 markings/sec, 360 secs
lola: sara is running 365 secs || sara is running 365 secs || 98206898 markings, 219174318 edges, 240383 markings/sec, 365 secs
lola: sara is running 370 secs || sara is running 370 secs || 99429165 markings, 222056157 edges, 244453 markings/sec, 370 secs
lola: sara is running 375 secs || sara is running 375 secs || 100627073 markings, 224879428 edges, 239582 markings/sec, 375 secs
lola: sara is running 380 secs || sara is running 380 secs || 101777850 markings, 227592097 edges, 230155 markings/sec, 380 secs
lola: sara is running 385 secs || sara is running 385 secs || 102668203 markings, 229687177 edges, 178071 markings/sec, 385 secs
lola: sara is running 390 secs || sara is running 390 secs || 103812810 markings, 232392261 edges, 228921 markings/sec, 390 secs
lola: sara is running 395 secs || sara is running 395 secs || 104930908 markings, 235038720 edges, 223620 markings/sec, 395 secs
lola: sara is running 400 secs || sara is running 400 secs || 105736931 markings, 236944990 edges, 161205 markings/sec, 400 secs
lola: sara is running 405 secs || sara is running 405 secs || 106502375 markings, 238752584 edges, 153089 markings/sec, 405 secs
lola: sara is running 410 secs || sara is running 410 secs || 107244028 markings, 240509660 edges, 148331 markings/sec, 410 secs
lola: sara is running 415 secs || sara is running 415 secs || 107983371 markings, 242262499 edges, 147869 markings/sec, 415 secs
lola: sara is running 420 secs || sara is running 420 secs || 108720339 markings, 243999788 edges, 147394 markings/sec, 420 secs
lola: sara is running 425 secs || sara is running 425 secs || 109450768 markings, 245723042 edges, 146086 markings/sec, 425 secs
lola: sara is running 430 secs || sara is running 430 secs || 110186409 markings, 247446205 edges, 147128 markings/sec, 430 secs
lola: sara is running 435 secs || sara is running 435 secs || 110908290 markings, 249157837 edges, 144376 markings/sec, 435 secs
lola: sara is running 440 secs || sara is running 440 secs || 111605174 markings, 250812912 edges, 139377 markings/sec, 440 secs
lola: sara is running 445 secs || sara is running 445 secs || 112304062 markings, 252468873 edges, 139778 markings/sec, 445 secs
lola: sara is running 450 secs || sara is running 450 secs || 113284808 markings, 254799755 edges, 196149 markings/sec, 450 secs
lola: sara is running 455 secs || sara is running 455 secs || 114307923 markings, 257229874 edges, 204623 markings/sec, 455 secs
lola: sara is running 460 secs || sara is running 460 secs || 115078358 markings, 259056990 edges, 154087 markings/sec, 460 secs
lola: sara is running 465 secs || sara is running 465 secs || 115806711 markings, 260776227 edges, 145671 markings/sec, 465 secs
lola: sara is running 470 secs || sara is running 470 secs || 116539335 markings, 262509804 edges, 146525 markings/sec, 470 secs
lola: sara is running 475 secs || sara is running 475 secs || 117283044 markings, 264275980 edges, 148742 markings/sec, 475 secs
lola: sara is running 480 secs || sara is running 480 secs || 118012670 markings, 266009159 edges, 145925 markings/sec, 480 secs
lola: sara is running 485 secs || sara is running 485 secs || 118740192 markings, 267739952 edges, 145504 markings/sec, 485 secs
lola: sara is running 490 secs || sara is running 490 secs || 119476328 markings, 269493832 edges, 147227 markings/sec, 490 secs
lola: sara is running 495 secs || sara is running 495 secs || 120207865 markings, 271231047 edges, 146307 markings/sec, 495 secs
lola: sara is running 500 secs || sara is running 500 secs || 120962169 markings, 272997226 edges, 150861 markings/sec, 500 secs
lola: sara is running 505 secs || sara is running 505 secs || 121763403 markings, 274905897 edges, 160247 markings/sec, 505 secs
lola: sara is running 510 secs || sara is running 510 secs || 122802504 markings, 277376999 edges, 207820 markings/sec, 510 secs
lola: sara is running 515 secs || sara is running 515 secs || 123865328 markings, 279907144 edges, 212565 markings/sec, 515 secs
lola: sara is running 520 secs || sara is running 520 secs || 124944336 markings, 282469851 edges, 215802 markings/sec, 520 secs
lola: sara is running 525 secs || sara is running 525 secs || 125760076 markings, 284409679 edges, 163148 markings/sec, 525 secs
lola: sara is running 530 secs || sara is running 530 secs || 126770501 markings, 286823696 edges, 202085 markings/sec, 530 secs
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 3 will run for 3028 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: (((p48 <= 0)) AND E (F ((((1 <= p45)) AND ((p30 <= 0)) AND ((1 <= p60)) AND ((p44 <= 0))))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 3 will run for 3028 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: ((p48 <= 0))
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: ((p48 <= 0))
lola: processed formula length: 12
lola: 9 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: yes
lola: produced by: preprocessing
lola: The net satisfies the property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: Child process aborted or communication problem between parent and child process
lola: SUBRESULT
lola: result: unknown
lola: The Boolean predicate may be true or false.
lola: ========================================
lola: ========================================
lola: ...considering subproblem: A (G (E (F (((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0))))))))
lola: ========================================
lola: SUBTASK
lola: checking liveness
lola: rewrite Frontend/Parser/formula_rewrite.k:603
lola: rewrite Frontend/Parser/formula_rewrite.k:613
lola: rewrite Frontend/Parser/formula_rewrite.k:703
lola: processed formula: ((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0))))
lola: processed formula length: 47
lola: 12 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH
lola: using tscc preserving stubborn set method (--stubborn)
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: Planning: workflow for reachability check: stateequation (--findpath=off)
lola: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: state equation task get result started, id 1
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 1
lola: formula 0: ((p23 <= 0) OR (((1 <= p30)) AND ((p0 <= 0))))
lola: state equation task get result unparse finished id 0
lola: state equation task get result unparse finished++ id 1
lola: state equation: Generated DNF with 3 literals and 2 conjunctive subformulas
lola: formula 1: ((1 <= p23) AND (((p30 <= 0)) OR ((1 <= p0))))
lola: state equation task get result unparse finished id 1
lola: state equation: Generated DNF with 4 literals and 2 conjunctive subformulas
lola: state equation: write sara problem file to CTLCardinality-4-0.sara
lola: state equation: calling and running sara
lola: state equation: write sara problem file to CTLCardinality-4-1.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLCardinality-4-0.sara.
sara: try reading problem file CTLCardinality-4-1.sara.
sara: place or transition ordering is non-deterministic
sara: place or transition ordering is non-deterministic
lola: state equation 0: solution produced
lola: state equation 1: solution produced
lola: sara is running 0 secs || sara is running 0 secs || 2517336 markings, 4416158 edges, 503467 markings/sec, 0 secs
lola: sara is running 5 secs || sara is running 5 secs || 3985725 markings, 7237079 edges, 293678 markings/sec, 5 secs
lola: sara is running 10 secs || sara is running 10 secs || 5375296 markings, 9971486 edges, 277914 markings/sec, 10 secs
lola: sara is running 15 secs || sara is running 15 secs || 6670859 markings, 12575552 edges, 259113 markings/sec, 15 secs
lola: sara is running 20 secs || sara is running 20 secs || 7912661 markings, 15088186 edges, 248360 markings/sec, 20 secs
lola: sara is running 25 secs || sara is running 25 secs || 9148409 markings, 17626500 edges, 247150 markings/sec, 25 secs
lola: sara is running 30 secs || sara is running 30 secs || 10579830 markings, 20598327 edges, 286284 markings/sec, 30 secs
lola: sara is running 35 secs || sara is running 35 secs || 11755307 markings, 23046578 edges, 235095 markings/sec, 35 secs
lola: sara is running 40 secs || sara is running 40 secs || 12888407 markings, 25422328 edges, 226620 markings/sec, 40 secs
lola: sara is running 45 secs || sara is running 45 secs || 14007151 markings, 27773056 edges, 223749 markings/sec, 45 secs
lola: sara is running 50 secs || sara is running 50 secs || 15103528 markings, 30094332 edges, 219275 markings/sec, 50 secs
lola: sara is running 55 secs || sara is running 55 secs || 16467481 markings, 33007655 edges, 272791 markings/sec, 55 secs
lola: sara is running 60 secs || sara is running 60 secs || 18009846 markings, 36309498 edges, 308473 markings/sec, 60 secs
lola: sara is running 65 secs || sara is running 65 secs || 19534787 markings, 39596661 edges, 304988 markings/sec, 65 secs
lola: sara is running 70 secs || sara is running 70 secs || 20969775 markings, 42703270 edges, 286998 markings/sec, 70 secs
lola: sara is running 75 secs || sara is running 75 secs || 22462716 markings, 45944115 edges, 298588 markings/sec, 75 secs
lola: sara is running 80 secs || sara is running 80 secs || 23955114 markings, 49204720 edges, 298480 markings/sec, 80 secs
lola: sara is running 85 secs || sara is running 85 secs || 25428095 markings, 52428214 edges, 294596 markings/sec, 85 secs
lola: sara is running 90 secs || sara is running 90 secs || 26879418 markings, 55624058 edges, 290265 markings/sec, 90 secs
lola: sara is running 95 secs || sara is running 95 secs || 28244600 markings, 58638141 edges, 273036 markings/sec, 95 secs
lola: sara is running 100 secs || sara is running 100 secs || 29555237 markings, 61535660 edges, 262127 markings/sec, 100 secs
lola: sara is running 105 secs || sara is running 105 secs || 31000538 markings, 64727084 edges, 289060 markings/sec, 105 secs
lola: sara is running 110 secs || sara is running 110 secs || 32434360 markings, 67915123 edges, 286764 markings/sec, 110 secs
lola: sara is running 115 secs || sara is running 115 secs || 33858049 markings, 71084088 edges, 284738 markings/sec, 115 secs
lola: sara is running 120 secs || sara is running 120 secs || 35273571 markings, 74242430 edges, 283104 markings/sec, 120 secs
lola: sara is running 125 secs || sara is running 125 secs || 36671967 markings, 77370624 edges, 279679 markings/sec, 125 secs
lola: sara is running 130 secs || sara is running 130 secs || 37895494 markings, 80098242 edges, 244705 markings/sec, 130 secs
lola: sara is running 135 secs || sara is running 135 secs || 39225556 markings, 83082125 edges, 266012 markings/sec, 135 secs
lola: sara is running 140 secs || sara is running 140 secs || 40454277 markings, 85849223 edges, 245744 markings/sec, 140 secs
lola: sara is running 145 secs || sara is running 145 secs || 41337374 markings, 87842524 edges, 176619 markings/sec, 145 secs
lola: sara is running 150 secs || sara is running 150 secs || 42234278 markings, 89861195 edges, 179381 markings/sec, 150 secs
lola: sara is running 155 secs || sara is running 155 secs || 43116892 markings, 91854167 edges, 176523 markings/sec, 155 secs
lola: sara is running 160 secs || sara is running 160 secs || 44000887 markings, 93850413 edges, 176799 markings/sec, 160 secs
lola: sara is running 165 secs || sara is running 165 secs || 44879949 markings, 95833094 edges, 175812 markings/sec, 165 secs
lola: sara is running 170 secs || sara is running 170 secs || 45765361 markings, 97839628 edges, 177082 markings/sec, 170 secs
lola: sara is running 175 secs || sara is running 175 secs || 46635695 markings, 99808407 edges, 174067 markings/sec, 175 secs
lola: sara is running 180 secs || sara is running 180 secs || 47499511 markings, 101774802 edges, 172763 markings/sec, 180 secs
lola: sara is running 185 secs || sara is running 185 secs || 48359912 markings, 103733070 edges, 172080 markings/sec, 185 secs
lola: sara is running 190 secs || sara is running 190 secs || 49216063 markings, 105679913 edges, 171230 markings/sec, 190 secs
lola: sara is running 195 secs || sara is running 195 secs || 50071462 markings, 107623546 edges, 171080 markings/sec, 195 secs
lola: sara is running 200 secs || sara is running 200 secs || 50942188 markings, 109597465 edges, 174145 markings/sec, 200 secs
lola: sara is running 205 secs || sara is running 205 secs || 51801931 markings, 111555164 edges, 171949 markings/sec, 205 secs
lola: sara is running 210 secs || sara is running 210 secs || 52663134 markings, 113516945 edges, 172241 markings/sec, 210 secs
lola: sara is running 215 secs || sara is running 215 secs || 53512400 markings, 115459608 edges, 169853 markings/sec, 215 secs
lola: sara is running 220 secs || sara is running 220 secs || 54346633 markings, 117364441 edges, 166847 markings/sec, 220 secs
lola: sara is running 225 secs || sara is running 225 secs || 55185574 markings, 119277153 edges, 167788 markings/sec, 225 secs
lola: sara is running 230 secs || sara is running 230 secs || 56019757 markings, 121180163 edges, 166837 markings/sec, 230 secs
lola: sara is running 235 secs || sara is running 235 secs || 56839080 markings, 123055008 edges, 163865 markings/sec, 235 secs
lola: sara is running 240 secs || sara is running 240 secs || 57660361 markings, 124941393 edges, 164256 markings/sec, 240 secs
lola: sara is running 245 secs || sara is running 245 secs || 58479809 markings, 126824215 edges, 163890 markings/sec, 245 secs
lola: sara is running 250 secs || sara is running 250 secs || 59296115 markings, 128700958 edges, 163261 markings/sec, 250 secs
lola: sara is running 255 secs || sara is running 255 secs || 60116507 markings, 130581569 edges, 164078 markings/sec, 255 secs
lola: sara is running 260 secs || sara is running 260 secs || 60939163 markings, 132464726 edges, 164531 markings/sec, 260 secs
lola: sara is running 265 secs || sara is running 265 secs || 61740243 markings, 134304939 edges, 160216 markings/sec, 265 secs
lola: sara is running 270 secs || sara is running 270 secs || 62541012 markings, 136145009 edges, 160154 markings/sec, 270 secs
lola: sara is running 275 secs || sara is running 275 secs || 63335459 markings, 137978314 edges, 158889 markings/sec, 275 secs
lola: sara is running 280 secs || sara is running 280 secs || 64145494 markings, 139840644 edges, 162007 markings/sec, 280 secs
lola: sara is running 285 secs || sara is running 285 secs || 64944294 markings, 141682692 edges, 159760 markings/sec, 285 secs
lola: sara is running 290 secs || sara is running 290 secs || 65749000 markings, 143544085 edges, 160941 markings/sec, 290 secs
lola: sara is running 295 secs || sara is running 295 secs || 66547797 markings, 145391562 edges, 159759 markings/sec, 295 secs
lola: sara is running 300 secs || sara is running 300 secs || 67350842 markings, 147240028 edges, 160609 markings/sec, 300 secs
lola: sara is running 305 secs || sara is running 305 secs || 68149315 markings, 149078549 edges, 159695 markings/sec, 305 secs
lola: sara is running 310 secs || sara is running 310 secs || 68927210 markings, 150882162 edges, 155579 markings/sec, 310 secs
lola: sara is running 315 secs || sara is running 315 secs || 69705041 markings, 152684619 edges, 155566 markings/sec, 315 secs
lola: sara is running 320 secs || sara is running 320 secs || 70482748 markings, 154489123 edges, 155541 markings/sec, 320 secs
lola: sara is running 325 secs || sara is running 325 secs || 71265106 markings, 156300956 edges, 156472 markings/sec, 325 secs
lola: sara is running 330 secs || sara is running 330 secs || 72039495 markings, 158096292 edges, 154878 markings/sec, 330 secs
lola: sara is running 335 secs || sara is running 335 secs || 72816577 markings, 159900003 edges, 155416 markings/sec, 335 secs
lola: sara is running 340 secs || sara is running 340 secs || 73612766 markings, 161713262 edges, 159238 markings/sec, 340 secs
lola: sara is running 345 secs || sara is running 345 secs || 74371205 markings, 163473196 edges, 151688 markings/sec, 345 secs
lola: sara is running 350 secs || sara is running 350 secs || 75111247 markings, 165193856 edges, 148008 markings/sec, 350 secs
lola: sara is running 355 secs || sara is running 355 secs || 75870638 markings, 166951823 edges, 151878 markings/sec, 355 secs
lola: sara is running 360 secs || sara is running 360 secs || 76635379 markings, 168727562 edges, 152948 markings/sec, 360 secs
lola: sara is running 365 secs || sara is running 365 secs || 77395394 markings, 170493924 edges, 152003 markings/sec, 365 secs
lola: sara is running 370 secs || sara is running 370 secs || 78158940 markings, 172271391 edges, 152709 markings/sec, 370 secs
lola: sara is running 375 secs || sara is running 375 secs || 78918372 markings, 174040736 edges, 151886 markings/sec, 375 secs
lola: sara is running 380 secs || sara is running 380 secs || 79681271 markings, 175820383 edges, 152580 markings/sec, 380 secs
lola: sara is running 385 secs || sara is running 385 secs || 80441645 markings, 177592120 edges, 152075 markings/sec, 385 secs
lola: sara is running 390 secs || sara is running 390 secs || 81196713 markings, 179356033 edges, 151014 markings/sec, 390 secs
lola: sara is running 395 secs || sara is running 395 secs || 81943935 markings, 181096167 edges, 149444 markings/sec, 395 secs
lola: sara is running 400 secs || sara is running 400 secs || 82696850 markings, 182856102 edges, 150583 markings/sec, 400 secs
lola: sara is running 405 secs || sara is running 405 secs || 83451204 markings, 184622355 edges, 150871 markings/sec, 405 secs
lola: sara is running 410 secs || sara is running 410 secs || 84213804 markings, 186407900 edges, 152520 markings/sec, 410 secs
lola: sara is running 415 secs || sara is running 415 secs || 84968866 markings, 188173077 edges, 151012 markings/sec, 415 secs
lola: sara is running 420 secs || sara is running 420 secs || 85727375 markings, 189942635 edges, 151702 markings/sec, 420 secs
lola: sara is running 425 secs || sara is running 425 secs || 86481721 markings, 191709649 edges, 150869 markings/sec, 425 secs
lola: sara is running 430 secs || sara is running 430 secs || 87245505 markings, 193495295 edges, 152757 markings/sec, 430 secs
lola: sara is running 435 secs || sara is running 435 secs || 88009591 markings, 195286349 edges, 152817 markings/sec, 435 secs
lola: sara is running 440 secs || sara is running 440 secs || 88768485 markings, 197065158 edges, 151779 markings/sec, 440 secs
lola: sara is running 445 secs || sara is running 445 secs || 89518356 markings, 198822939 edges, 149974 markings/sec, 445 secs
lola: sara is running 450 secs || sara is running 450 secs || 90268555 markings, 200585823 edges, 150040 markings/sec, 450 secs
lola: sara is running 455 secs || sara is running 455 secs || 91023945 markings, 202349203 edges, 151078 markings/sec, 455 secs
lola: sara is running 460 secs || sara is running 460 secs || 91772798 markings, 204106937 edges, 149771 markings/sec, 460 secs
lola: sara is running 465 secs || sara is running 465 secs || 92535517 markings, 205895296 edges, 152544 markings/sec, 465 secs
lola: sara is running 470 secs || sara is running 470 secs || 93298137 markings, 207688018 edges, 152524 markings/sec, 470 secs
lola: sara is running 475 secs || sara is running 475 secs || 94083491 markings, 209497791 edges, 157071 markings/sec, 475 secs
lola: sara is running 480 secs || sara is running 480 secs || 94840825 markings, 211275076 edges, 151467 markings/sec, 480 secs
lola: sara is running 485 secs || sara is running 485 secs || 95588329 markings, 213032239 edges, 149501 markings/sec, 485 secs
lola: sara is running 490 secs || sara is running 490 secs || 96337947 markings, 214788507 edges, 149924 markings/sec, 490 secs
lola: sara is running 495 secs || sara is running 495 secs || 97087201 markings, 216545871 edges, 149851 markings/sec, 495 secs
lola: sara is running 500 secs || sara is running 500 secs || 97848771 markings, 218336836 edges, 152314 markings/sec, 500 secs
lola: sara is running 505 secs || sara is running 505 secs || 98610560 markings, 220127630 edges, 152358 markings/sec, 505 secs
lola: sara is running 510 secs || sara is running 510 secs || 99489013 markings, 222195527 edges, 175691 markings/sec, 510 secs
lola: sara is running 515 secs || sara is running 515 secs || 100588996 markings, 224789867 edges, 219997 markings/sec, 515 secs
lola: sara is running 520 secs || sara is running 520 secs || 101595088 markings, 227158162 edges, 201218 markings/sec, 520 secs
lola: sara is running 525 secs || sara is running 525 secs || 102611448 markings, 229553512 edges, 203272 markings/sec, 525 secs
lola: sara is running 530 secs || sara is running 530 secs || 103725420 markings, 232185361 edges, 222794 markings/sec, 530 secs
lola: sara is running 535 secs || sara is running 535 secs || 104829720 markings, 234802469 edges, 220860 markings/sec, 535 secs
lola: sara is running 540 secs || sara is running 540 secs || 105947227 markings, 237441572 edges, 223501 markings/sec, 540 secs
lola: sara is running 545 secs || sara is running 545 secs || 106781695 markings, 239415052 edges, 166894 markings/sec, 545 secs
lola: sara is running 550 secs || sara is running 550 secs || 107520194 markings, 241165602 edges, 147700 markings/sec, 550 secs
lola: sara is running 555 secs || sara is running 555 secs || 108253900 markings, 242895691 edges, 146741 markings/sec, 555 secs
lola: sara is running 560 secs || sara is running 560 secs || 109008060 markings, 244678085 edges, 150832 markings/sec, 560 secs
lola: sara is running 565 secs || sara is running 565 secs || 109740897 markings, 246408586 edges, 146567 markings/sec, 565 secs
lola: sara is running 570 secs || sara is running 570 secs || 110473834 markings, 248127622 edges, 146587 markings/sec, 570 secs
lola: sara is running 575 secs || sara is running 575 secs || 111398046 markings, 250321556 edges, 184842 markings/sec, 575 secs
lola: sara is running 580 secs || sara is running 580 secs || 112473823 markings, 252869884 edges, 215155 markings/sec, 580 secs
lola: sara is running 585 secs || sara is running 585 secs || 113568116 markings, 255473135 edges, 218859 markings/sec, 585 secs
lola: sara is running 590 secs || sara is running 590 secs || 114543203 markings, 257786303 edges, 195017 markings/sec, 590 secs
lola: sara is running 595 secs || sara is running 595 secs || 115635126 markings, 260380196 edges, 218385 markings/sec, 595 secs
lola: sara is running 600 secs || sara is running 600 secs || 116719962 markings, 262940097 edges, 216967 markings/sec, 600 secs
lola: sara is running 605 secs || sara is running 605 secs || 117748592 markings, 265384149 edges, 205726 markings/sec, 605 secs
lola: sara is running 610 secs || sara is running 610 secs || 118746137 markings, 267754148 edges, 199509 markings/sec, 610 secs
lola: sara is running 615 secs || sara is running 615 secs || 119840119 markings, 270359524 edges, 218796 markings/sec, 615 secs
lola: sara is running 620 secs || sara is running 620 secs || 120913278 markings, 272879952 edges, 214632 markings/sec, 620 secs
lola: sara is running 625 secs || sara is running 625 secs || 122013484 markings, 275499811 edges, 220041 markings/sec, 625 secs
lola: sara is running 630 secs || sara is running 630 secs || 123119223 markings, 278128267 edges, 221148 markings/sec, 630 secs
lola: sara is running 635 secs || sara is running 635 secs || 124198980 markings, 280694660 edges, 215951 markings/sec, 635 secs
lola: sara is running 640 secs || sara is running 640 secs || 125317819 markings, 283356552 edges, 223768 markings/sec, 640 secs
lola: sara is running 645 secs || sara is running 645 secs || 126421314 markings, 285990265 edges, 220699 markings/sec, 645 secs
lola: Child process aborted or communication problem between parent and child process
lola: ========================================
lola: ...considering subproblem: (((p48 <= 0)) AND E (F ((((1 <= p45)) AND ((p30 <= 0)) AND ((1 <= p60)) AND ((p44 <= 0))))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: ========================================
lola: ...considering subproblem: ((p48 <= 0))
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: ((p48 <= 0))
lola: processed formula length: 12
lola: 9 rewrites
lola: closed formula file CTLCardinality.xml
lola: processed formula with 1 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: yes
lola: produced by: preprocessing
lola: The net satisfies the property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================
lola: ========================================
lola: ...considering subproblem: E (F ((((1 <= p45)) AND ((p30 <= 0)) AND ((1 <= p60)) AND ((p44 <= 0)))))
lola: ========================================
lola: SUBTASK
lola: checking reachability
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: processed formula: E (F ((((1 <= p45)) AND ((p30 <= 0)) AND ((1 <= p60)) AND ((p44 <= 0)))))
lola: processed formula length: 73
lola: 10 rewrites
lola: closed formula file CTLCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
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: built state equation task
lola: RUNNING
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:711
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: (((1 <= p45)) AND ((p30 <= 0)) AND ((1 <= p60)) AND ((p44 <= 0)))
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 4 literals and 1 conjunctive subformulas
lola: SUBRESULT
lola: result: yes
lola: produced by: state space
lola: The predicate is reachable.
lola: 122 markings, 128 edges
lola: state equation: write sara problem file to CTLCardinality-6-0.sara
lola: ========================================
lola: state equation: calling and running sara
lola: SUBRESULT
lola: result: yes
lola: The Boolean predicate is true.
lola: ========================================
lola: RESULT
lola:
SUMMARY: yes unknown no yes
lola:
preliminary result: yes unknown no yes
sara: try reading problem file CTLCardinality-6-0.sara.
sara: place or transition ordering is non-deterministic
lola: memory consumption: 3800 KB
lola: time consumption: 1196 seconds
lola: print data as JSON (--json)
lola: writing JSON to CTLCardinality.json
lola: closed JSON file CTLCardinality.json
rslt: finished
--------------------
content from 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="ShieldRVt-PT-010A"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="itslola"
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
# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itslola"
echo " Input is ShieldRVt-PT-010A, 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 r211-tajo-159033478301003"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/ShieldRVt-PT-010A.tgz
mv ShieldRVt-PT-010A execution
cd execution
if [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "UpperBounds" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] || [ "CTLCardinality" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '
echo "FORMULA_NAME $x"
done
elif [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLCardinality"
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;