Execution Chart

We display below the execution chart for this examination (boot time has been removed).

Trace from the execution

Formatting '/data/fkordon/mcc2023-input.r295-tall-167873948200657.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
............................................................
=====================================================================
Generated by BenchKit 2-5348
Executing tool lolaxred
Input is PolyORBNT-COL-S05J60, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r295-tall-167873948200657
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 564K
-rw-r--r-- 1 mcc users 8.8K Feb 25 23:30 CTLCardinality.txt
-rw-r--r-- 1 mcc users 90K Feb 25 23:30 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.9K Feb 25 23:27 CTLFireability.txt
-rw-r--r-- 1 mcc users 61K Feb 25 23:27 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:40 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K Jan 29 11:40 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 4.0K Feb 25 16:36 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Feb 25 16:36 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.6K Feb 25 16:36 LTLFireability.txt
-rw-r--r-- 1 mcc users 18K Feb 25 16:36 LTLFireability.xml
-rw-r--r-- 1 mcc users 9.5K Feb 25 23:41 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 81K Feb 25 23:41 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 11K Feb 25 23:38 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 89K Feb 25 23:38 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Feb 25 16:36 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Feb 25 16:36 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 equiv_pt
-rw-r--r-- 1 mcc users 7 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 94K Mar 5 18:23 model.pnml

--------------------
content from stdout:

=== Data for post analysis generated by BenchKit (invocation template)

The expected result is a vector of booleans
BOOL_VECTOR

here is the order used to build the result vector(from text file)
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-00
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-01
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-02
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-03
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-04
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-05
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-06
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-07
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-08
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-09
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-10
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-11
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-12
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-13
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-14
FORMULA_NAME PolyORBNT-COL-S05J60-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1678882938855

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=lolaxred
BK_EXAMINATION=CTLCardinality
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=3600
BK_INPUT=PolyORBNT-COL-S05J60
Applying reductions before tool lola
Invoking reducer
Running Version 202303021504
[2023-03-15 12:22:20] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -timeout, 360, -rebuildPNML]
[2023-03-15 12:22:20] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-15 12:22:20] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
log4j:WARN No appenders could be found for logger (org.apache.axiom.locator.DefaultOMMetaFactoryLocator).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
[2023-03-15 12:22:20] [WARNING] Using fallBack plugin, rng conformance not checked
[2023-03-15 12:22:20] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 477 ms
[2023-03-15 12:22:20] [INFO ] Imported 48 HL places and 38 HL transitions for a total of 969 PT places and 2152.0 transition bindings in 18 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 128 ms.
[2023-03-15 12:22:21] [INFO ] Built PT skeleton of HLPN with 48 places and 38 transitions 140 arcs in 8 ms.
[2023-03-15 12:22:21] [INFO ] Skeletonized 16 HLPN properties in 2 ms.
Computed a total of 0 stabilizing places and 0 stable transitions
Remains 16 properties that can be checked using skeleton over-approximation.
Computed a total of 0 stabilizing places and 0 stable transitions
Incomplete random walk after 10001 steps, including 794 resets, run finished after 450 ms. (steps per millisecond=22 ) properties (out of 98) seen :5
Incomplete Best-First random walk after 1001 steps, including 27 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 93) seen :14
Incomplete Best-First random walk after 1000 steps, including 22 resets, run finished after 21 ms. (steps per millisecond=47 ) properties (out of 79) seen :2
Incomplete Best-First random walk after 1001 steps, including 38 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 28 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 19 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 24 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 17 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 39 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 28 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 26 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 30 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 28 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 28 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 21 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 25 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 26 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 24 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 28 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 42 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 33 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 28 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 24 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 40 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 27 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 18 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 22 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 29 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 21 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 35 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 25 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 30 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 36 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 29 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 25 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 20 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 27 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 26 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 21 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 19 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 42 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 23 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 25 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 42 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 21 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 28 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 23 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 27 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 23 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1000 steps, including 20 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 26 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 77) seen :0
Incomplete Best-First random walk after 1001 steps, including 41 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 77) seen :0
Running SMT prover for 77 properties.
// Phase 1: matrix 38 rows 48 cols
[2023-03-15 12:22:22] [INFO ] Computed 13 place invariants in 7 ms
[2023-03-15 12:22:22] [INFO ] [Real]Absence check using 6 positive place invariants in 98 ms returned sat
[2023-03-15 12:22:22] [INFO ] [Real]Absence check using 6 positive and 7 generalized place invariants in 4 ms returned sat
[2023-03-15 12:22:22] [INFO ] After 366ms SMT Verify possible using all constraints in real domain returned unsat :7 sat :0 real:70
[2023-03-15 12:22:22] [INFO ] [Nat]Absence check using 6 positive place invariants in 1 ms returned sat
[2023-03-15 12:22:22] [INFO ] [Nat]Absence check using 6 positive and 7 generalized place invariants in 2 ms returned sat
[2023-03-15 12:22:22] [INFO ] After 33ms SMT Verify possible using state equation in natural domain returned unsat :75 sat :2
[2023-03-15 12:22:22] [INFO ] State equation strengthened by 1 read => feed constraints.
[2023-03-15 12:22:22] [INFO ] After 10ms SMT Verify possible using 1 Read/Feed constraints in natural domain returned unsat :75 sat :2
[2023-03-15 12:22:22] [INFO ] Deduced a trap composed of 13 places in 43 ms of which 4 ms to minimize.
[2023-03-15 12:22:22] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 49 ms
[2023-03-15 12:22:22] [INFO ] Deduced a trap composed of 14 places in 23 ms of which 1 ms to minimize.
[2023-03-15 12:22:22] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 28 ms
[2023-03-15 12:22:22] [INFO ] After 97ms SMT Verify possible using trap constraints in natural domain returned unsat :75 sat :2
Attempting to minimize the solution found.
Minimization took 59 ms.
[2023-03-15 12:22:22] [INFO ] After 343ms SMT Verify possible using all constraints in natural domain returned unsat :75 sat :2
Fused 77 Parikh solutions to 2 different solutions.
Parikh walk visited 0 properties in 16 ms.
Support contains 4 out of 48 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 48/48 places, 38/38 transitions.
Ensure Unique test removed 1 places
Drop transitions removed 3 transitions
Trivial Post-agglo rules discarded 3 transitions
Performed 3 trivial Post agglomeration. Transition count delta: 3
Iterating post reduction 0 with 4 rules applied. Total rules applied 4 place count 47 transition count 35
Reduce places removed 3 places and 0 transitions.
Iterating post reduction 1 with 3 rules applied. Total rules applied 7 place count 44 transition count 35
Performed 3 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 3 Pre rules applied. Total rules applied 7 place count 44 transition count 32
Deduced a syphon composed of 3 places in 0 ms
Reduce places removed 3 places and 0 transitions.
Iterating global reduction 2 with 6 rules applied. Total rules applied 13 place count 41 transition count 32
Discarding 2 places :
Symmetric choice reduction at 2 with 2 rule applications. Total rules 15 place count 39 transition count 30
Iterating global reduction 2 with 2 rules applied. Total rules applied 17 place count 39 transition count 30
Performed 1 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 1 Pre rules applied. Total rules applied 17 place count 39 transition count 29
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 19 place count 38 transition count 29
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 21 place count 37 transition count 28
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: -2
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 23 place count 36 transition count 30
Free-agglomeration rule (complex) applied 1 times.
Iterating global reduction 2 with 1 rules applied. Total rules applied 24 place count 36 transition count 29
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 2 with 1 rules applied. Total rules applied 25 place count 35 transition count 29
Applied a total of 25 rules in 21 ms. Remains 35 /48 variables (removed 13) and now considering 29/38 (removed 9) transitions.
// Phase 1: matrix 29 rows 35 cols
[2023-03-15 12:22:22] [INFO ] Computed 12 place invariants in 2 ms
[2023-03-15 12:22:22] [INFO ] Dead Transitions using invariants and state equation in 38 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 59 ms. Remains : 35/48 places, 29/38 transitions.
Incomplete random walk after 10000 steps, including 1172 resets, run finished after 61 ms. (steps per millisecond=163 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 10001 steps, including 369 resets, run finished after 46 ms. (steps per millisecond=217 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 10000 steps, including 408 resets, run finished after 30 ms. (steps per millisecond=333 ) properties (out of 2) seen :0
Probably explored full state space saw : 338 states, properties seen :0
Probabilistic random walk after 895 steps, saw 338 distinct states, run finished after 13 ms. (steps per millisecond=68 ) properties seen :0
Explored full state space saw : 338 states, properties seen :0
Exhaustive walk after 895 steps, saw 338 distinct states, run finished after 5 ms. (steps per millisecond=179 ) properties seen :0
Successfully simplified 77 atomic propositions for a total of 16 simplifications.
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-11 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-12 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-14 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-15 12:22:23] [INFO ] Initial state reduction rules for CTL removed 8 formulas.
[2023-03-15 12:22:23] [INFO ] Flatten gal took : 18 ms
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-13 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-09 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-08 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-05 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-01 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-00 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-15 12:22:23] [INFO ] Flatten gal took : 6 ms
Transition Run forces synchronizations/join behavior on parameter j of sort Jobs
Transition trans_376 forces synchronizations/join behavior on parameter s of sort Sources
Symmetric sort wr.t. initial and guards and successors and join/free detected :States
Arc [42:1*[$t, 0, $j]] contains constants of sort States
Transition WillPerformWork : constants on arcs in [[42:1*[$t, 0, $j]]] introduces in States(2) partition with 1 elements that refines current partition to 2 subsets.
[2023-03-15 12:22:23] [INFO ] Unfolded HLPN to a Petri net with 969 places and 2030 transitions 12704 arcs in 42 ms.
[2023-03-15 12:22:23] [INFO ] Unfolded 5 HLPN properties in 1 ms.
Deduced a syphon composed of 60 places in 9 ms
Reduce places removed 60 places and 60 transitions.
Ensure Unique test removed 655 transitions
Reduce redundant transitions removed 655 transitions.
Support contains 884 out of 909 places. Attempting structural reductions.
Starting structural reductions in LTL mode, iteration 0 : 909/909 places, 1315/1315 transitions.
Ensure Unique test removed 5 places
Iterating post reduction 0 with 5 rules applied. Total rules applied 5 place count 904 transition count 1315
Applied a total of 5 rules in 17 ms. Remains 904 /909 variables (removed 5) and now considering 1315/1315 (removed 0) transitions.
[2023-03-15 12:22:23] [INFO ] Flow matrix only has 1311 transitions (discarded 4 similar events)
// Phase 1: matrix 1311 rows 904 cols
[2023-03-15 12:22:23] [INFO ] Computed 137 place invariants in 83 ms
[2023-03-15 12:22:24] [INFO ] Dead Transitions using invariants and state equation in 1131 ms found 95 transitions.
Found 95 dead transitions using SMT.
Drop transitions removed 95 transitions
Dead transitions reduction (with SMT) triggered by suspicious arc values removed 95 transitions.
[2023-03-15 12:22:24] [INFO ] Flow matrix only has 1216 transitions (discarded 4 similar events)
// Phase 1: matrix 1216 rows 904 cols
[2023-03-15 12:22:24] [INFO ] Computed 137 place invariants in 32 ms
[2023-03-15 12:22:24] [INFO ] Implicit Places using invariants in 227 ms returned []
[2023-03-15 12:22:24] [INFO ] Flow matrix only has 1216 transitions (discarded 4 similar events)
[2023-03-15 12:22:24] [INFO ] Invariant cache hit.
[2023-03-15 12:22:25] [INFO ] State equation strengthened by 1 read => feed constraints.
[2023-03-15 12:22:25] [INFO ] Implicit Places using invariants and state equation in 807 ms returned []
Implicit Place search using SMT with State Equation took 1041 ms to find 0 implicit places.
Starting structural reductions in LTL mode, iteration 1 : 904/909 places, 1220/1315 transitions.
Applied a total of 0 rules in 8 ms. Remains 904 /904 variables (removed 0) and now considering 1220/1220 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 2201 ms. Remains : 904/909 places, 1220/1315 transitions.
Support contains 884 out of 904 places after structural reductions.
[2023-03-15 12:22:25] [INFO ] Flatten gal took : 125 ms
[2023-03-15 12:22:25] [INFO ] Flatten gal took : 83 ms
[2023-03-15 12:22:25] [INFO ] Input system was already deterministic with 1220 transitions.
Incomplete random walk after 10000 steps, including 695 resets, run finished after 405 ms. (steps per millisecond=24 ) properties (out of 35) seen :9
Incomplete Best-First random walk after 1001 steps, including 14 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 23 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 18 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 30 resets, run finished after 24 ms. (steps per millisecond=41 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1000 steps, including 24 resets, run finished after 20 ms. (steps per millisecond=50 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1000 steps, including 14 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 26 resets, run finished after 21 ms. (steps per millisecond=47 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 16 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 7 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 25 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1000 steps, including 13 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 4 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 15 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 17 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1000 steps, including 8 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 26 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1000 steps, including 25 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 17 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 26) seen :0
Incomplete Best-First random walk after 1001 steps, including 8 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 26) seen :0
Running SMT prover for 26 properties.
[2023-03-15 12:22:26] [INFO ] Flow matrix only has 1216 transitions (discarded 4 similar events)
[2023-03-15 12:22:26] [INFO ] Invariant cache hit.
[2023-03-15 12:22:27] [INFO ] [Real]Absence check using 131 positive place invariants in 31 ms returned sat
[2023-03-15 12:22:27] [INFO ] [Real]Absence check using 131 positive and 6 generalized place invariants in 18 ms returned sat
[2023-03-15 12:22:27] [INFO ] After 541ms SMT Verify possible using all constraints in real domain returned unsat :1 sat :0 real:25
[2023-03-15 12:22:27] [INFO ] [Nat]Absence check using 131 positive place invariants in 31 ms returned sat
[2023-03-15 12:22:27] [INFO ] [Nat]Absence check using 131 positive and 6 generalized place invariants in 17 ms returned sat
[2023-03-15 12:22:37] [INFO ] After 9810ms SMT Verify possible using state equation in natural domain returned unsat :24 sat :1
[2023-03-15 12:22:37] [INFO ] State equation strengthened by 1 read => feed constraints.
[2023-03-15 12:22:37] [INFO ] After 86ms SMT Verify possible using 1 Read/Feed constraints in natural domain returned unsat :24 sat :1
[2023-03-15 12:22:38] [INFO ] After 306ms SMT Verify possible using trap constraints in natural domain returned unsat :24 sat :1
Attempting to minimize the solution found.
Minimization took 123 ms.
[2023-03-15 12:22:38] [INFO ] After 10839ms SMT Verify possible using all constraints in natural domain returned unsat :24 sat :1
Fused 26 Parikh solutions to 2 different solutions.
Parikh walk visited 0 properties in 14 ms.
Support contains 69 out of 904 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 904/904 places, 1220/1220 transitions.
Drop transitions removed 65 transitions
Trivial Post-agglo rules discarded 65 transitions
Performed 65 trivial Post agglomeration. Transition count delta: 65
Iterating post reduction 0 with 65 rules applied. Total rules applied 65 place count 904 transition count 1155
Reduce places removed 65 places and 0 transitions.
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Iterating post reduction 1 with 66 rules applied. Total rules applied 131 place count 839 transition count 1154
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 2 with 1 rules applied. Total rules applied 132 place count 838 transition count 1154
Performed 64 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 64 Pre rules applied. Total rules applied 132 place count 838 transition count 1090
Deduced a syphon composed of 64 places in 2 ms
Reduce places removed 64 places and 0 transitions.
Iterating global reduction 3 with 128 rules applied. Total rules applied 260 place count 774 transition count 1090
Discarding 1 places :
Symmetric choice reduction at 3 with 1 rule applications. Total rules 261 place count 773 transition count 1089
Iterating global reduction 3 with 1 rules applied. Total rules applied 262 place count 773 transition count 1089
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 3 with 4 rules applied. Total rules applied 266 place count 771 transition count 1087
Applied a total of 266 rules in 215 ms. Remains 771 /904 variables (removed 133) and now considering 1087/1220 (removed 133) transitions.
[2023-03-15 12:22:38] [INFO ] Flow matrix only has 1083 transitions (discarded 4 similar events)
// Phase 1: matrix 1083 rows 771 cols
[2023-03-15 12:22:38] [INFO ] Computed 137 place invariants in 17 ms
[2023-03-15 12:22:39] [INFO ] Dead Transitions using invariants and state equation in 693 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 912 ms. Remains : 771/904 places, 1087/1220 transitions.
Finished random walk after 64 steps, including 3 resets, run visited all 2 properties in 2 ms. (steps per millisecond=32 )
Successfully simplified 24 atomic propositions for a total of 5 simplifications.
[2023-03-15 12:22:39] [INFO ] Flatten gal took : 57 ms
[2023-03-15 12:22:39] [INFO ] Flatten gal took : 52 ms
[2023-03-15 12:22:39] [INFO ] Input system was already deterministic with 1220 transitions.
Support contains 1 out of 904 places (down from 129) after GAL structural reductions.
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Computed a total of 0 stabilizing places and 0 stable transitions
Starting structural reductions in LTL mode, iteration 0 : 904/904 places, 1220/1220 transitions.
Discarding 1 places :
Symmetric choice reduction at 0 with 1 rule applications. Total rules 1 place count 903 transition count 1219
Iterating global reduction 0 with 1 rules applied. Total rules applied 2 place count 903 transition count 1219
Applied a total of 2 rules in 31 ms. Remains 903 /904 variables (removed 1) and now considering 1219/1220 (removed 1) transitions.
[2023-03-15 12:22:39] [INFO ] Flow matrix only has 1215 transitions (discarded 4 similar events)
// Phase 1: matrix 1215 rows 903 cols
[2023-03-15 12:22:39] [INFO ] Computed 137 place invariants in 24 ms
[2023-03-15 12:22:40] [INFO ] Dead Transitions using invariants and state equation in 883 ms found 0 transitions.
Finished structural reductions in LTL mode , in 1 iterations and 918 ms. Remains : 903/904 places, 1219/1220 transitions.
[2023-03-15 12:22:40] [INFO ] Flatten gal took : 47 ms
[2023-03-15 12:22:40] [INFO ] Flatten gal took : 48 ms
[2023-03-15 12:22:40] [INFO ] Input system was already deterministic with 1219 transitions.
Starting structural reductions in LTL mode, iteration 0 : 904/904 places, 1220/1220 transitions.
Discarding 1 places :
Symmetric choice reduction at 0 with 1 rule applications. Total rules 1 place count 903 transition count 1219
Iterating global reduction 0 with 1 rules applied. Total rules applied 2 place count 903 transition count 1219
Applied a total of 2 rules in 37 ms. Remains 903 /904 variables (removed 1) and now considering 1219/1220 (removed 1) transitions.
[2023-03-15 12:22:40] [INFO ] Flow matrix only has 1215 transitions (discarded 4 similar events)
[2023-03-15 12:22:40] [INFO ] Invariant cache hit.
[2023-03-15 12:22:41] [INFO ] Dead Transitions using invariants and state equation in 906 ms found 0 transitions.
Finished structural reductions in LTL mode , in 1 iterations and 947 ms. Remains : 903/904 places, 1219/1220 transitions.
[2023-03-15 12:22:41] [INFO ] Flatten gal took : 46 ms
[2023-03-15 12:22:41] [INFO ] Flatten gal took : 47 ms
[2023-03-15 12:22:41] [INFO ] Input system was already deterministic with 1219 transitions.
Starting structural reductions in LTL mode, iteration 0 : 904/904 places, 1220/1220 transitions.
Discarding 1 places :
Symmetric choice reduction at 0 with 1 rule applications. Total rules 1 place count 903 transition count 1219
Iterating global reduction 0 with 1 rules applied. Total rules applied 2 place count 903 transition count 1219
Applied a total of 2 rules in 29 ms. Remains 903 /904 variables (removed 1) and now considering 1219/1220 (removed 1) transitions.
[2023-03-15 12:22:41] [INFO ] Flow matrix only has 1215 transitions (discarded 4 similar events)
[2023-03-15 12:22:41] [INFO ] Invariant cache hit.
[2023-03-15 12:22:42] [INFO ] Dead Transitions using invariants and state equation in 890 ms found 0 transitions.
Finished structural reductions in LTL mode , in 1 iterations and 923 ms. Remains : 903/904 places, 1219/1220 transitions.
[2023-03-15 12:22:42] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
[2023-03-15 12:22:42] [INFO ] Flatten gal took : 40 ms
FORMULA PolyORBNT-COL-S05J60-CTLCardinality-10 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-15 12:22:42] [INFO ] Flatten gal took : 42 ms
[2023-03-15 12:22:42] [INFO ] Input system was already deterministic with 1219 transitions.
Starting structural reductions in LTL mode, iteration 0 : 904/904 places, 1220/1220 transitions.
Discarding 1 places :
Symmetric choice reduction at 0 with 1 rule applications. Total rules 1 place count 903 transition count 1219
Iterating global reduction 0 with 1 rules applied. Total rules applied 2 place count 903 transition count 1219
Applied a total of 2 rules in 30 ms. Remains 903 /904 variables (removed 1) and now considering 1219/1220 (removed 1) transitions.
[2023-03-15 12:22:42] [INFO ] Flow matrix only has 1215 transitions (discarded 4 similar events)
[2023-03-15 12:22:42] [INFO ] Invariant cache hit.
[2023-03-15 12:22:43] [INFO ] Dead Transitions using invariants and state equation in 887 ms found 0 transitions.
Finished structural reductions in LTL mode , in 1 iterations and 922 ms. Remains : 903/904 places, 1219/1220 transitions.
[2023-03-15 12:22:43] [INFO ] Flatten gal took : 37 ms
[2023-03-15 12:22:43] [INFO ] Flatten gal took : 46 ms
[2023-03-15 12:22:43] [INFO ] Input system was already deterministic with 1219 transitions.
[2023-03-15 12:22:43] [INFO ] Flatten gal took : 42 ms
[2023-03-15 12:22:43] [INFO ] Flatten gal took : 42 ms
[2023-03-15 12:22:43] [INFO ] Export to MCC of 3 properties in file /home/mcc/execution/CTLCardinality.sr.xml took 1 ms.
[2023-03-15 12:22:43] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml of net with 904 places, 1220 transitions and 5774 arcs took 10 ms.
Total runtime 23781 ms.
There are residual formulas that ITS could not solve within timeout
starting LoLA
BK_INPUT PolyORBNT-COL-S05J60
BK_EXAMINATION: CTLCardinality
bin directory: /home/mcc/BenchKit/bin//../reducer/bin//../../lola/bin/
current directory: /home/mcc/execution/374

FORMULA PolyORBNT-COL-S05J60-CTLCardinality-02 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA PolyORBNT-COL-S05J60-CTLCardinality-15 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA PolyORBNT-COL-S05J60-CTLCardinality-03 TRUE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

BK_STOP 1678882965159

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

+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
+ VERSION=202303021504
+ echo 'Running Version 202303021504'
+ /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/its-tools -pnfolder /home/mcc/execution -examination CTLCardinality -timeout 360 -rebuildPNML
lola: MEM LIMIT 32
lola: MEM LIMIT 5
lola: NET
lola: input: PNML file (--pnmlnet)
lola: reading net from /home/mcc/execution/374/model.pnml
lola: reading pnml
lola: PNML file contains place/transition net
lola: finished parsing
lola: closed net file /home/mcc/execution/374/model.pnml
lola: Reading formula.
lola: Using XML format (--xmlformula)
lola: reading XML formula
lola: reading formula from /home/mcc/execution/374/CTLCardinality.xml
lola: rewrite Frontend/Parser/formula_rewrite.k:98
lola: rewrite Frontend/Parser/formula_rewrite.k:129
lola: rewrite Frontend/Parser/formula_rewrite.k:96
lola: rewrite Frontend/Parser/formula_rewrite.k:138
lola: Created skeleton in 0.000000 secs.
lola: Rule S: 0 transitions removed,0 places removed
lola: LAUNCH INITIAL
lola: LAUNCH task # 1 (type CNST) for 0 PolyORBNT-COL-S05J60-CTLCardinality-02
lola: time limit : 0 sec
lola: memory limit: 0 pages
lola: FINISHED task # 1 (type CNST) for PolyORBNT-COL-S05J60-CTLCardinality-02
lola: result : true
lola: LAUNCH INITIAL
lola: LAUNCH task # 7 (type CNST) for 6 PolyORBNT-COL-S05J60-CTLCardinality-15
lola: time limit : 0 sec
lola: memory limit: 0 pages
lola: FINISHED task # 7 (type CNST) for PolyORBNT-COL-S05J60-CTLCardinality-15
lola: result : false
lola: rewrite Frontend/Parser/formula_rewrite.k:808
lola: rewrite Frontend/Parser/formula_rewrite.k:812
lola: rewrite Frontend/Parser/formula_rewrite.k:806
lola: rewrite Frontend/Parser/formula_rewrite.k:807
lola: LAUNCH task # 4 (type EXCL) for 3 PolyORBNT-COL-S05J60-CTLCardinality-03
lola: time limit : 3599 sec
lola: memory limit: 32 pages
lola: FINISHED task # 4 (type EXCL) for PolyORBNT-COL-S05J60-CTLCardinality-03
lola: result : true
lola: markings : 12
lola: fired transitions : 22
lola: time used : 0.000000
lola: memory pages used : 1
lola: Portfolio finished: no open formulas

FINAL RESULTS
FINISHED FORMULA: CATEGORY VALUE PRODUCED BY
PolyORBNT-COL-S05J60-CTLCardinality-02: INITIAL true preprocessing
PolyORBNT-COL-S05J60-CTLCardinality-03: CTL true CTL model checker
PolyORBNT-COL-S05J60-CTLCardinality-15: INITIAL false preprocessing


Time elapsed: 1 secs. Pages in use: 1

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="PolyORBNT-COL-S05J60"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="lolaxred"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-5348"
echo " Executing tool lolaxred"
echo " Input is PolyORBNT-COL-S05J60, 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 r295-tall-167873948200657"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/PolyORBNT-COL-S05J60.tgz
mv PolyORBNT-COL-S05J60 execution
cd execution
if [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "UpperBounds" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] || [ "CTLCardinality" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '' CTLCardinality.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLCardinality"
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;