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-159033477500468.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 ShieldPPPs-PT-005B, examination is CTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r211-tajo-159033477500468
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 264K
-rw-r--r-- 1 mcc users 3.5K May 14 01:36 CTLCardinality.txt
-rw-r--r-- 1 mcc users 20K May 14 01:36 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.4K May 13 18:57 CTLFireability.txt
-rw-r--r-- 1 mcc users 15K May 13 18:57 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.1K May 14 10:02 LTLCardinality.txt
-rw-r--r-- 1 mcc users 23K May 14 10:02 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K May 14 10:03 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K May 14 10:03 LTLFireability.xml
-rw-r--r-- 1 mcc users 1 May 12 20:42 NewModel
-rw-r--r-- 1 mcc users 4.1K May 13 13:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 22K May 13 13:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.7K May 13 08:38 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 17K May 13 08:38 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K May 13 16:53 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K 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 86K 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 ShieldPPPs-PT-005B-CTLFireability-00
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-01
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-02
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-03
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-04
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-05
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-06
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-07
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-08
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-09
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-10
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-11
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-12
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-13
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-14
FORMULA_NAME ShieldPPPs-PT-005B-CTLFireability-15

=== Now, execution of the tool begins

BK_START 1591308117371

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-04 22:02:00] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2020-06-04 22:02:00] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-04 22:02:00] [INFO ] Load time of PNML (sax parser for PT used): 127 ms
[2020-06-04 22:02:00] [INFO ] Transformed 343 places.
[2020-06-04 22:02:00] [INFO ] Transformed 318 transitions.
[2020-06-04 22:02:00] [INFO ] Found NUPN structural information;
[2020-06-04 22:02:00] [INFO ] Parsed PT model containing 343 places and 318 transitions in 193 ms.
Parsed 16 properties from file /home/mcc/execution/CTLFireability.xml in 45 ms.
Incomplete random walk after 100000 steps, including 114 resets, run finished after 301 ms. (steps per millisecond=332 ) properties seen :[1, 1, 1, 1, 1, 1, 0, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 0, 1, 1]
// Phase 1: matrix 318 rows 343 cols
[2020-06-04 22:02:00] [INFO ] Computed 56 place invariants in 19 ms
[2020-06-04 22:02:01] [INFO ] [Real]Absence check using 56 positive place invariants in 53 ms returned sat
[2020-06-04 22:02:01] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 22:02:01] [INFO ] [Real]Absence check using state equation in 393 ms returned sat
[2020-06-04 22:02:01] [INFO ] Deduced a trap composed of 19 places in 194 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 19 places in 212 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 17 places in 70 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 18 places in 134 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 16 places in 48 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 18 places in 118 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 24 places in 57 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 29 places in 55 ms
[2020-06-04 22:02:02] [INFO ] Deduced a trap composed of 42 places in 56 ms
[2020-06-04 22:02:02] [INFO ] Trap strengthening (SAT) tested/added 10/9 trap constraints in 1114 ms
[2020-06-04 22:02:02] [INFO ] Solution in real domain found non-integer solution.
[2020-06-04 22:02:02] [INFO ] [Nat]Absence check using 56 positive place invariants in 50 ms returned sat
[2020-06-04 22:02:02] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-04 22:02:03] [INFO ] [Nat]Absence check using state equation in 205 ms returned sat
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 19 places in 95 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 26 places in 185 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 16 places in 75 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 18 places in 88 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 24 places in 63 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 19 places in 83 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 25 places in 44 ms
[2020-06-04 22:02:03] [INFO ] Deduced a trap composed of 19 places in 71 ms
[2020-06-04 22:02:04] [INFO ] Deduced a trap composed of 20 places in 116 ms
[2020-06-04 22:02:04] [INFO ] Deduced a trap composed of 23 places in 536 ms
[2020-06-04 22:02:04] [INFO ] Deduced a trap composed of 24 places in 68 ms
[2020-06-04 22:02:05] [INFO ] Deduced a trap composed of 30 places in 476 ms
[2020-06-04 22:02:05] [INFO ] Deduced a trap composed of 17 places in 689 ms
[2020-06-04 22:02:05] [INFO ] Deduced a trap composed of 15 places in 42 ms
[2020-06-04 22:02:06] [INFO ] Deduced a trap composed of 33 places in 378 ms
[2020-06-04 22:02:06] [INFO ] Deduced a trap composed of 28 places in 43 ms
[2020-06-04 22:02:06] [INFO ] Trap strengthening (SAT) tested/added 17/16 trap constraints in 3338 ms
[2020-06-04 22:02:06] [INFO ] Computed and/alt/rep : 317/533/317 causal constraints in 44 ms.
[2020-06-04 22:02:08] [INFO ] Added : 305 causal constraints over 61 iterations in 1633 ms. Result :sat
[2020-06-04 22:02:08] [INFO ] [Real]Absence check using 56 positive place invariants in 56 ms returned sat
[2020-06-04 22:02:08] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-04 22:02:08] [INFO ] [Real]Absence check using state equation in 440 ms returned sat
[2020-06-04 22:02:08] [INFO ] Deduced a trap composed of 19 places in 86 ms
[2020-06-04 22:02:08] [INFO ] Deduced a trap composed of 18 places in 108 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 18 places in 81 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 14 places in 52 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 44 places in 108 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 29 places in 81 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 38 places in 53 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 32 places in 53 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 22 places in 40 ms
[2020-06-04 22:02:09] [INFO ] Deduced a trap composed of 21 places in 37 ms
[2020-06-04 22:02:09] [INFO ] Trap strengthening (SAT) tested/added 11/10 trap constraints in 856 ms
[2020-06-04 22:02:09] [INFO ] Solution in real domain found non-integer solution.
[2020-06-04 22:02:09] [INFO ] [Nat]Absence check using 56 positive place invariants in 93 ms returned sat
[2020-06-04 22:02:09] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-04 22:02:10] [INFO ] [Nat]Absence check using state equation in 591 ms returned sat
[2020-06-04 22:02:10] [INFO ] Deduced a trap composed of 19 places in 198 ms
[2020-06-04 22:02:10] [INFO ] Deduced a trap composed of 17 places in 92 ms
[2020-06-04 22:02:10] [INFO ] Deduced a trap composed of 10 places in 52 ms
[2020-06-04 22:02:10] [INFO ] Deduced a trap composed of 19 places in 60 ms
[2020-06-04 22:02:10] [INFO ] Deduced a trap composed of 18 places in 54 ms
[2020-06-04 22:02:10] [INFO ] Deduced a trap composed of 20 places in 56 ms
[2020-06-04 22:02:11] [INFO ] Deduced a trap composed of 21 places in 54 ms
[2020-06-04 22:02:11] [INFO ] Deduced a trap composed of 14 places in 61 ms
[2020-06-04 22:02:11] [INFO ] Trap strengthening (SAT) tested/added 9/8 trap constraints in 741 ms
[2020-06-04 22:02:11] [INFO ] Computed and/alt/rep : 317/533/317 causal constraints in 19 ms.
[2020-06-04 22:02:12] [INFO ] Added : 309 causal constraints over 62 iterations in 1422 ms. Result :sat
[2020-06-04 22:02:12] [INFO ] Flatten gal took : 88 ms
[2020-06-04 22:02:12] [INFO ] Flatten gal took : 22 ms
[2020-06-04 22:02:12] [INFO ] Export to MCC properties in file /home/mcc/execution/CTLFireability.sr.xml took 6 ms.
[2020-06-04 22:02:12] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 16 ms.
info: Time: 3600 - MCC
vrfy: Checking CTLFireability @ ShieldPPPs-PT-005B @ 3570 seconds
vrfy: finished
info: timeLeft: 0
rslt: Output for CTLFireability @ ShieldPPPs-PT-005B

{
"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=CTLFireability.xml",
"--mcc",
"--donotcomputecapacities",
"--encoder=simplecompressed",
"--check=modelchecking",
"--stubborn=tarjan",
"--stateequation=par",
"--quickchecks",
"--timelimit=3570",
"--localtimelimit=0",
"--preference=force_ctl",
"--json=CTLFireability.json",
"--jsoninclude=formula,formulastat,net"
],
"starttime": "Thu Jun 4 22:02:13 2020
",
"timelimit": 3570
},
"child": null,
"exit":
{
"error": null,
"memory": 2443776,
"runtime": 3570.000000,
"signal": null,
"timelimitreached": true
},
"files":
{
"formula": "CTLFireability.xml",
"net": "model.pnml"
},
"formula":
{
"skeleton": "A(G(A(F(**)))) : A((E(F(**)) U A((** U **)))) : A((A(X(**)) U E(G(*)))) : (E(F(**)) OR **) : A(F((E(X(**)) AND A(F(**))))) : A(G(*)) : (A(X(*)) AND E(G(*))) : E(G(*)) : E(F((** AND (A(G(**)) OR (** OR **))))) : (E(X(**)) OR (E(X(**)) OR (A(X(E(F(**)))) AND (A(X(**)) AND A(X(**)))))) : E(F(**)) : E(G(*)) : (E(F(**)) OR A((** U **))) : E(F((** AND (A(X(**)) AND (E(G(**)) OR (** OR **)))))) : E(F(**)) : (E(F(**)) OR (** OR **))"
},
"net":
{
"arcs": 876,
"conflict_clusters": 243,
"places": 343,
"places_significant": 287,
"singleton_clusters": 0,
"transitions": 318
},
"result":
{
"interim_value": "unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown ",
"preliminary_value": "unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown "
},
"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: 661/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 10976
lola: finding significant places
lola: 343 places, 318 transitions, 287 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 CTLFireability.xml
lola: LP says that atomic proposition is always true: (p165 <= 1)
lola: LP says that atomic proposition is always true: (p206 <= 1)
lola: LP says that atomic proposition is always true: (p55 <= 1)
lola: LP says that atomic proposition is always true: (p33 <= 1)
lola: LP says that atomic proposition is always true: (p123 <= 1)
lola: LP says that atomic proposition is always true: (p104 <= 1)
lola: LP says that atomic proposition is always true: (p106 <= 1)
lola: LP says that atomic proposition is always true: (p65 <= 1)
lola: LP says that atomic proposition is always true: (p38 <= 1)
lola: LP says that atomic proposition is always true: (p61 <= 1)
lola: LP says that atomic proposition is always true: (p296 <= 1)
lola: LP says that atomic proposition is always true: (p308 <= 1)
lola: LP says that atomic proposition is always true: (p165 <= 1)
lola: LP says that atomic proposition is always true: (p205 <= 1)
lola: LP says that atomic proposition is always true: (p217 <= 1)
lola: LP says that atomic proposition is always true: (p267 <= 1)
lola: LP says that atomic proposition is always true: (p236 <= 1)
lola: LP says that atomic proposition is always true: (p244 <= 1)
lola: LP says that atomic proposition is always true: (p201 <= 1)
lola: LP says that atomic proposition is always true: (p249 <= 1)
lola: LP says that atomic proposition is always true: (p229 <= 1)
lola: LP says that atomic proposition is always true: (p183 <= 1)
lola: LP says that atomic proposition is always true: (p289 <= 1)
lola: LP says that atomic proposition is always true: (p102 <= 1)
lola: LP says that atomic proposition is always true: (p183 <= 1)
lola: LP says that atomic proposition is always true: (p205 <= 1)
lola: LP says that atomic proposition is always true: (p261 <= 1)
lola: LP says that atomic proposition is always true: (p131 <= 1)
lola: LP says that atomic proposition is always true: (p117 <= 1)
lola: LP says that atomic proposition is always true: (p141 <= 1)
lola: LP says that atomic proposition is always true: (p314 <= 1)
lola: LP says that atomic proposition is always true: (p76 <= 1)
lola: LP says that atomic proposition is always true: (p105 <= 1)
lola: LP says that atomic proposition is always true: (p128 <= 1)
lola: LP says that atomic proposition is always true: (p189 <= 1)
lola: LP says that atomic proposition is always true: (p100 <= 1)
lola: LP says that atomic proposition is always true: (p190 <= 1)
lola: LP says that atomic proposition is always true: (p328 <= 1)
lola: LP says that atomic proposition is always true: (p306 <= 1)
lola: LP says that atomic proposition is always true: (p329 <= 1)
lola: LP says that atomic proposition is always true: (p136 <= 1)
lola: LP says that atomic proposition is always true: (p207 <= 1)
lola: LP says that atomic proposition is always true: (p29 <= 1)
lola: LP says that atomic proposition is always true: (p47 <= 1)
lola: LP says that atomic proposition is always true: (p23 <= 1)
lola: LP says that atomic proposition is always true: (p25 <= 1)
lola: LP says that atomic proposition is always true: (p194 <= 1)
lola: LP says that atomic proposition is always true: (p6 <= 1)
lola: LP says that atomic proposition is always true: (p182 <= 1)
lola: LP says that atomic proposition is always true: (p252 <= 1)
lola: LP says that atomic proposition is always true: (p312 <= 1)
lola: LP says that atomic proposition is always true: (p18 <= 1)
lola: LP says that atomic proposition is always true: (p53 <= 1)
lola: LP says that atomic proposition is always true: (p135 <= 1)
lola: LP says that atomic proposition is always true: (p49 <= 1)
lola: LP says that atomic proposition is always true: (p146 <= 1)
lola: LP says that atomic proposition is always true: (p98 <= 1)
lola: LP says that atomic proposition is always true: (p138 <= 1)
lola: LP says that atomic proposition is always true: (p224 <= 1)
lola: LP says that atomic proposition is always true: (p226 <= 1)
lola: LP says that atomic proposition is always true: (p301 <= 1)
lola: LP says that atomic proposition is always true: (p121 <= 1)
lola: LP says that atomic proposition is always true: (p333 <= 1)
lola: LP says that atomic proposition is always true: (p234 <= 1)
lola: LP says that atomic proposition is always true: (p324 <= 1)
lola: LP says that atomic proposition is always true: (p54 <= 1)
lola: LP says that atomic proposition is always true: (p83 <= 1)
lola: LP says that atomic proposition is always true: (p133 <= 1)
lola: LP says that atomic proposition is always true: (p156 <= 1)
lola: LP says that atomic proposition is always true: (p181 <= 1)
lola: LP says that atomic proposition is always true: (p249 <= 1)
lola: LP says that atomic proposition is always true: (p144 <= 1)
lola: A (G (A (F (((1 <= p165) AND (1 <= p206)))))) : A ((E (F ((((1 <= p55)) OR ((1 <= p33) AND (1 <= p123))))) U A ((((1 <= p104) AND (1 <= p106)) U ((1 <= p65)))))) : A ((A (X (((p38 <= 0) OR (p61 <= 0)))) U NOT(A (F (((1 <= p296))))))) : (A (F (E (F (((1 <= p308) AND (1 <= p165) AND (1 <= p205)))))) OR ((1 <= p217) AND (1 <= p267))) : A (F ((E (X (((1 <= p236)))) AND A (F ((((1 <= p244)) OR ((1 <= p201)))))))) : NOT(A ((((1 <= p249)) U E (F (((1 <= p229))))))) : (NOT(E (X (((1 <= p183))))) AND NOT(A (F (((1 <= p289)))))) : E (G (NOT(A (F ((((1 <= p102)) OR ((1 <= p183)))))))) : E (F ((((1 <= p205)) AND ((A (G (((1 <= p261)))) OR ((p131 <= 0))) OR ((p117 <= 0)))))) : ((E (X (((1 <= p141)))) OR E (X (((1 <= p314) AND (((1 <= p76)) OR ((1 <= p105) AND (1 <= p128))))))) OR A (X (((E (F (((1 <= p189)))) AND ((p100 <= 0) OR (p190 <= 0))) AND ((p328 <= 0)))))) : E (F (((1 <= p306) AND (1 <= p329)))) : E (G (NOT(A (F (((1 <= p136))))))) : (A ((((1 <= p207)) U E (F (((1 <= p29) AND (1 <= p47)))))) OR A (((((1 <= p23) AND (1 <= p25) AND (1 <= p194)) OR ((1 <= p6) AND (1 <= p182))) U ((1 <= p252))))) : E (F (((((1 <= p18) AND ((p312 <= 0)) AND (1 <= p53) AND (1 <= p135)) AND A (X (((1 <= p49))))) AND ((E (G (((1 <= p146)))) OR ((1 <= p98) AND (1 <= p138))) OR ((1 <= p224) AND (1 <= p226) AND (1 <= p301)))))) : E ((NOT(E (X (((1 <= p121))))) U E (F ((((1 <= p333)) OR ((1 <= p234) AND (1 <= p324))))))) : ((E (F (((1 <= p54) AND (1 <= p83) AND (1 <= p133)))) OR ((1 <= p156) AND (1 <= p181))) OR ((1 <= p144) AND ((p249 <= 0))))
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:332
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:449
lola: rewrite Frontend/Parser/formula_rewrite.k:452
lola: rewrite Frontend/Parser/formula_rewrite.k:326
lola: rewrite Frontend/Parser/formula_rewrite.k:332
lola: rewrite Frontend/Parser/formula_rewrite.k:297
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:323
lola: rewrite Frontend/Parser/formula_rewrite.k:332
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:332
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:461
lola: rewrite Frontend/Parser/formula_rewrite.k:254
lola: rewrite Frontend/Parser/formula_rewrite.k:251
lola: rewrite Frontend/Parser/formula_rewrite.k:551
lola: rewrite Frontend/Parser/formula_rewrite.k:551
lola: rewrite Frontend/Parser/formula_rewrite.k:254
lola: rewrite Frontend/Parser/formula_rewrite.k:323
lola: rewrite Frontend/Parser/formula_rewrite.k:332
lola: rewrite Frontend/Parser/formula_rewrite.k:297
lola: rewrite Frontend/Parser/formula_rewrite.k:461
lola: rewrite Frontend/Parser/formula_rewrite.k:452
lola: rewrite Frontend/Parser/formula_rewrite.k:254
lola: rewrite Frontend/Parser/formula_rewrite.k:251
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:473
lola: rewrite Frontend/Parser/formula_rewrite.k:254
lola: computing a collection of formulas
lola: RUNNING
lola: subprocess 0 will run for 222 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: A ((A (X (((p38 <= 0) OR (p61 <= 0)))) U E (G (((p296 <= 0))))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: rewrite Frontend/Parser/formula_rewrite.k:812
lola: rewrite Frontend/Parser/formula_rewrite.k:808
lola: rewrite Frontend/Parser/formula_rewrite.k:814
lola: processed formula: A(AX(((p38 <= 0) OR (p61 <= 0))) U EG(((p296 <= 0))))
lola: processed formula length: 54
lola: 38 rewrites
lola: closed formula file CTLFireability.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 2 significant temporal operators and needs 9 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 693796 markings, 2234975 edges, 138759 markings/sec, 0 secs
lola: 1411143 markings, 4596013 edges, 143469 markings/sec, 5 secs
lola: 2100124 markings, 6933764 edges, 137796 markings/sec, 10 secs
lola: 2805064 markings, 9284024 edges, 140988 markings/sec, 15 secs
lola: 3453378 markings, 11587278 edges, 129663 markings/sec, 20 secs
lola: 4137144 markings, 13927630 edges, 136753 markings/sec, 25 secs
lola: 4798087 markings, 16287707 edges, 132189 markings/sec, 30 secs
lola: 5361444 markings, 18485240 edges, 112671 markings/sec, 35 secs
lola: 5982724 markings, 20820289 edges, 124256 markings/sec, 40 secs
lola: 6571458 markings, 23131786 edges, 117747 markings/sec, 45 secs
lola: 7189707 markings, 25477003 edges, 123650 markings/sec, 50 secs
lola: 7756173 markings, 27746866 edges, 113293 markings/sec, 55 secs
lola: 8345977 markings, 30060920 edges, 117961 markings/sec, 60 secs
lola: 8906539 markings, 32379963 edges, 112112 markings/sec, 65 secs
lola: 9532904 markings, 34734690 edges, 125273 markings/sec, 70 secs
lola: 10117345 markings, 37030510 edges, 116888 markings/sec, 75 secs
lola: 10742005 markings, 39344276 edges, 124932 markings/sec, 80 secs
lola: 11324597 markings, 41622679 edges, 116518 markings/sec, 85 secs
lola: 11925893 markings, 43931252 edges, 120259 markings/sec, 90 secs
lola: 12489194 markings, 46182279 edges, 112660 markings/sec, 95 secs
lola: 13062406 markings, 48470798 edges, 114642 markings/sec, 100 secs
lola: 13549399 markings, 50490827 edges, 97399 markings/sec, 105 secs
lola: 14063833 markings, 52374656 edges, 102887 markings/sec, 110 secs
lola: 14577221 markings, 54407695 edges, 102678 markings/sec, 115 secs
lola: 15192922 markings, 56675453 edges, 123140 markings/sec, 120 secs
lola: 15685773 markings, 58623377 edges, 98570 markings/sec, 125 secs
lola: 16197508 markings, 60591663 edges, 102347 markings/sec, 130 secs
lola: 16697181 markings, 62547914 edges, 99935 markings/sec, 135 secs
lola: 17254365 markings, 64759964 edges, 111437 markings/sec, 140 secs
lola: 17770044 markings, 66808073 edges, 103136 markings/sec, 145 secs
lola: 18264629 markings, 68832752 edges, 98917 markings/sec, 150 secs
lola: 18758512 markings, 70921215 edges, 98777 markings/sec, 155 secs
lola: 19262852 markings, 73156450 edges, 100868 markings/sec, 160 secs
lola: 19753281 markings, 75204685 edges, 98086 markings/sec, 165 secs
lola: 20185627 markings, 77140514 edges, 86469 markings/sec, 170 secs
lola: 20643197 markings, 79127304 edges, 91514 markings/sec, 175 secs
lola: 21120403 markings, 81188773 edges, 95441 markings/sec, 180 secs
lola: 21545258 markings, 83100343 edges, 84971 markings/sec, 185 secs
lola: 21966420 markings, 84971379 edges, 84232 markings/sec, 190 secs
lola: 22446159 markings, 87142190 edges, 95948 markings/sec, 195 secs
lola: 22930917 markings, 89286640 edges, 96952 markings/sec, 200 secs
lola: 23450470 markings, 91542653 edges, 103911 markings/sec, 205 secs
lola: 23964472 markings, 93790905 edges, 102800 markings/sec, 210 secs
lola: 24491840 markings, 96026281 edges, 105474 markings/sec, 215 secs
lola: local time limit reached - aborting
lola:
preliminary result: unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown
lola: memory consumption: 1875356 KB
lola: time consumption: 226 seconds
lola: print data as JSON (--json)
lola: writing JSON to CTLFireability.json
lola: closed JSON file CTLFireability.json
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 1 will run for 222 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: A (F ((E (X (((1 <= p236)))) AND A (F ((((1 <= p244)) OR ((1 <= p201))))))))
lola: ========================================
lola: SUBTASK
lola: checking CTL
lola: rewrite Frontend/Parser/formula_rewrite.k:807
lola: rewrite Frontend/Parser/formula_rewrite.k:811
lola: rewrite Frontend/Parser/formula_rewrite.k:811
lola: processed formula: AF((EX(((1 <= p236))) AND AF((((1 <= p244)) OR ((1 <= p201))))))
lola: processed formula length: 65
lola: 38 rewrites
lola: closed formula file CTLFireability.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 2 significant temporal operators and needs 9 bytes of payload
lola: Ignoring fairness constraints (--fair).
lola: 756284 markings, 2389720 edges, 151257 markings/sec, 0 secs
lola: 1475768 markings, 4776893 edges, 143897 markings/sec, 5 secs
lola: 2153215 markings, 7143670 edges, 135489 markings/sec, 10 secs
lola: 2843238 markings, 9458430 edges, 138005 markings/sec, 15 secs
lola: 3515901 markings, 11794540 edges, 134533 markings/sec, 20 secs
lola: 4165555 markings, 14076171 edges, 129931 markings/sec, 25 secs
lola: 4829471 markings, 16367075 edges, 132783 markings/sec, 30 secs
lola: 5474819 markings, 18635708 edges, 129070 markings/sec, 35 secs
lola: 6128222 markings, 20953879 edges, 130681 markings/sec, 40 secs
lola: 6750625 markings, 23302342 edges, 124481 markings/sec, 45 secs
lola: 7351814 markings, 25630425 edges, 120238 markings/sec, 50 secs
lola: 7898944 markings, 27808902 edges, 109426 markings/sec, 55 secs
lola: 8446580 markings, 29929980 edges, 109527 markings/sec, 60 secs
lola: 9028783 markings, 32213488 edges, 116441 markings/sec, 65 secs
lola: 9545424 markings, 34262572 edges, 103328 markings/sec, 70 secs
lola: 10081306 markings, 36436509 edges, 107176 markings/sec, 75 secs
lola: 10652403 markings, 38688093 edges, 114219 markings/sec, 80 secs
lola: 11196177 markings, 40878562 edges, 108755 markings/sec, 85 secs
lola: 11828617 markings, 43194642 edges, 126488 markings/sec, 90 secs
lola: 12451590 markings, 45546478 edges, 124595 markings/sec, 95 secs
lola: 13049959 markings, 47878430 edges, 119674 markings/sec, 100 secs
lola: 13632926 markings, 50180906 edges, 116593 markings/sec, 105 secs
lola: 14215562 markings, 52434777 edges, 116527 markings/sec, 110 secs
lola: 14785133 markings, 54712302 edges, 113914 markings/sec, 115 secs
lola: 15358428 markings, 56964102 edges, 114659 markings/sec, 120 secs
lola: 15901286 markings, 59141230 edges, 108572 markings/sec, 125 secs
lola: 16466649 markings, 61403004 edges, 113073 markings/sec, 130 secs
lola: 17013000 markings, 63585554 edges, 109270 markings/sec, 135 secs
lola: 17641772 markings, 65839008 edges, 125754 markings/sec, 140 secs
lola: 18187189 markings, 68035741 edges, 109083 markings/sec, 145 secs
lola: 18772709 markings, 70252803 edges, 117104 markings/sec, 150 secs
lola: 19367789 markings, 72357616 edges, 119016 markings/sec, 155 secs
lola: 19971935 markings, 74487655 edges, 120829 markings/sec, 160 secs
lola: 20597460 markings, 76569777 edges, 125105 markings/sec, 165 secs
lola: 21266414 markings, 78844101 edges, 133791 markings/sec, 170 secs
lola: 21936860 markings, 81172504 edges, 134089 markings/sec, 175 secs
lola: 22584591 markings, 83502821 edges, 129546 markings/sec, 180 secs
lola: 23222081 markings, 85829337 edges, 127498 markings/sec, 185 secs
lola: 23861077 markings, 88135474 edges, 127799 markings/sec, 190 secs
lola: 24482383 markings, 90369894 edges, 124261 markings/sec, 195 secs
lola: 25037841 markings, 92368052 edges, 111092 markings/sec, 200 secs
lola: 25592556 markings, 94325162 edges, 110943 markings/sec, 205 secs
lola: 26110414 markings, 96316703 edges, 103572 markings/sec, 210 secs
lola: 26667604 markings, 98355388 edges, 111438 markings/sec, 215 secs
lola: local time limit reached - aborting
lola:
preliminary result: unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown
lola: memory consumption: 2040056 KB
lola: time consumption: 448 seconds
lola: print data as JSON (--json)
lola: writing JSON to CTLFireability.json
lola: closed JSON file CTLFireability.json
lola: Child process aborted or communication problem between parent and child process
lola: subprocess 2 will run for 223 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: (A (X (((p183 <= 0)))) AND E (G (((p289 <= 0)))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 2 will run for 223 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: E (G (((p289 <= 0))))
lola: ========================================
lola: SUBTASK
lola: checking possible preservation
lola: rewrite Frontend/Parser/formula_rewrite.k:583
lola: processed formula: E (G (((p289 <= 0))))
lola: processed formula length: 21
lola: 36 rewrites
lola: closed formula file CTLFireability.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space / EG)
lola: state space: using search routine for EG formula (--search=depth)
lola: state space: using EG preserving stubborn set method (--stubborn=tarjan)
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:788
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: ((1 <= p289))
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 1 literals and 1 conjunctive subformulas
lola: state equation: write sara problem file to CTLFireability-2-0.sara
lola: state equation: calling and running sara
sara: try reading problem file CTLFireability-2-0.sara.
sara: place or transition ordering is non-deterministic

lola: state equation 0: solution produced
lola: 1554918 markings, 1927791 edges, 310984 markings/sec, 0 secs || sara is running 0 secs
lola: 3016698 markings, 3790857 edges, 292356 markings/sec, 5 secs || sara is running 5 secs
lola: 4569665 markings, 5744778 edges, 310593 markings/sec, 10 secs || sara is running 10 secs
lola: 6059075 markings, 7640736 edges, 297882 markings/sec, 15 secs || sara is running 15 secs
lola: 7549153 markings, 9519508 edges, 298016 markings/sec, 20 secs || sara is running 20 secs
lola: 9032084 markings, 11388565 edges, 296586 markings/sec, 25 secs || sara is running 25 secs
lola: 10539975 markings, 13303924 edges, 301578 markings/sec, 30 secs || sara is running 30 secs
lola: 12048410 markings, 15241509 edges, 301687 markings/sec, 35 secs || sara is running 35 secs
lola: 13536023 markings, 17167749 edges, 297523 markings/sec, 40 secs || sara is running 40 secs
lola: 15061537 markings, 19055750 edges, 305103 markings/sec, 45 secs || sara is running 45 secs
lola: 16539043 markings, 20940336 edges, 295501 markings/sec, 50 secs || sara is running 50 secs
lola: 18038945 markings, 22831169 edges, 299980 markings/sec, 55 secs || sara is running 55 secs
lola: 19528873 markings, 24726503 edges, 297986 markings/sec, 60 secs || sara is running 60 secs
lola: 20983511 markings, 26570378 edges, 290928 markings/sec, 65 secs || sara is running 65 secs
lola: 22447794 markings, 28407760 edges, 292857 markings/sec, 70 secs || sara is running 70 secs
lola: 23896307 markings, 30243827 edges, 289703 markings/sec, 75 secs || sara is running 75 secs
lola: 25332663 markings, 32048005 edges, 287271 markings/sec, 80 secs || sara is running 80 secs
lola: 26768001 markings, 33842046 edges, 287068 markings/sec, 85 secs || sara is running 85 secs
lola: 28237388 markings, 35664360 edges, 293877 markings/sec, 90 secs || sara is running 90 secs
lola: 29555776 markings, 37315208 edges, 263678 markings/sec, 95 secs || sara is running 95 secs
lola: 30822366 markings, 38917843 edges, 253318 markings/sec, 100 secs || sara is running 100 secs
lola: 32086310 markings, 40505023 edges, 252789 markings/sec, 105 secs || sara is running 105 secs
lola: 33520766 markings, 42322272 edges, 286891 markings/sec, 110 secs || sara is running 110 secs
lola: 34983126 markings, 44227522 edges, 292472 markings/sec, 115 secs || sara is running 115 secs
lola: 36406721 markings, 46086486 edges, 284719 markings/sec, 120 secs || sara is running 120 secs
lola: 37885016 markings, 47986629 edges, 295659 markings/sec, 125 secs || sara is running 125 secs
lola: 39422508 markings, 49922136 edges, 307498 markings/sec, 130 secs || sara is running 130 secs
lola: 40943054 markings, 51824660 edges, 304109 markings/sec, 135 secs || sara is running 135 secs
lola: 42446408 markings, 53722108 edges, 300671 markings/sec, 140 secs || sara is running 140 secs
lola: 43930730 markings, 55584691 edges, 296864 markings/sec, 145 secs || sara is running 145 secs
lola: 45395070 markings, 57415617 edges, 292868 markings/sec, 150 secs || sara is running 150 secs
lola: 46859091 markings, 59267997 edges, 292804 markings/sec, 155 secs || sara is running 155 secs
lola: 48307952 markings, 61156040 edges, 289772 markings/sec, 160 secs || sara is running 160 secs
lola: 49762762 markings, 63037403 edges, 290962 markings/sec, 165 secs || sara is running 165 secs
lola: 51207047 markings, 64890382 edges, 288857 markings/sec, 170 secs || sara is running 170 secs
lola: 52649277 markings, 66687423 edges, 288446 markings/sec, 175 secs || sara is running 175 secs
lola: 54064768 markings, 68453772 edges, 283098 markings/sec, 180 secs || sara is running 180 secs
lola: 55510387 markings, 70292882 edges, 289124 markings/sec, 185 secs || sara is running 185 secs
lola: 56914257 markings, 72132679 edges, 280774 markings/sec, 190 secs || sara is running 190 secs
lola: 58430204 markings, 74034087 edges, 303189 markings/sec, 195 secs || sara is running 195 secs
lola: 59897877 markings, 75879682 edges, 293535 markings/sec, 200 secs || sara is running 200 secs
lola: 61318500 markings, 77691357 edges, 284125 markings/sec, 205 secs || sara is running 205 secs
lola: 62734129 markings, 79468315 edges, 283126 markings/sec, 210 secs || sara is running 210 secs
lola: 64168761 markings, 81268182 edges, 286926 markings/sec, 215 secs || sara is running 215 secs
lola: local time limit reached - aborting
lola:
preliminary result: unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown
lola: local time limit reached - aborting
lola:
preliminary result: unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown
lola: memory consumption: 2443748 KB
lola: time consumption: 671 seconds
lola: print data as JSON (--json)
lola: writing JSON to CTLFireability.json
lola: closed JSON file CTLFireability.json
lola: caught signal User defined signal 1 - aborting LoLA
lola: caught signal User defined signal 2 - aborting LoLA
lola: time limit reached - aborting
lola:
preliminary result: unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown
lola:
preliminary result: unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown unknown
lola: memory consumption: 2443776 KB
lola: time consumption: 3570 seconds
lola: print data as JSON (--json)
lola: writing JSON to CTLFireability.json
lola: closed JSON file CTLFireability.json
rslt: finished
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16427456 kB
MemFree: 13693808 kB
After kill :
MemTotal: 16427456 kB
MemFree: 13693808 kB

--------------------
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="ShieldPPPs-PT-005B"
export BK_EXAMINATION="CTLFireability"
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 ShieldPPPs-PT-005B, examination is CTLFireability"
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-159033477500468"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/ShieldPPPs-PT-005B.tgz
mv ShieldPPPs-PT-005B execution
cd execution
if [ "CTLFireability" = "ReachabilityDeadlock" ] || [ "CTLFireability" = "UpperBounds" ] || [ "CTLFireability" = "QuasiLiveness" ] || [ "CTLFireability" = "StableMarking" ] || [ "CTLFireability" = "Liveness" ] || [ "CTLFireability" = "OneSafe" ] || [ "CTLFireability" = "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 [ "CTLFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLFireability" != "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 "CTLFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLFireability.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 '' CTLFireability.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "CTLFireability" = "ReachabilityDeadlock" ] || [ "CTLFireability" = "QuasiLiveness" ] || [ "CTLFireability" = "StableMarking" ] || [ "CTLFireability" = "Liveness" ] || [ "CTLFireability" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLFireability"
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 ;