Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2024-input.r277-smll-171654416800134.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2024-input.qcow2 backing_fmt=qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
..............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-5568
Executing tool itstools
Input is Peterson-COL-3, examination is Liveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r277-smll-171654416800134
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 504K
-rw-r--r-- 1 mcc users 6.3K Apr 12 02:21 CTLCardinality.txt
-rw-r--r-- 1 mcc users 60K Apr 12 02:21 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.5K Apr 12 02:15 CTLFireability.txt
-rw-r--r-- 1 mcc users 47K Apr 12 02:15 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 18 16:43 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 4.3K Apr 23 07:42 LTLCardinality.txt
-rw-r--r-- 1 mcc users 29K Apr 23 07:42 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.4K Apr 23 07:42 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Apr 23 07:42 LTLFireability.xml
-rw-r--r-- 1 mcc users 15K Apr 12 02:33 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 144K Apr 12 02:33 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 8.9K Apr 12 02:28 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 69K Apr 12 02:28 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Apr 23 07:42 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Apr 23 07:42 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 18 16:43 equiv_pt
-rw-r--r-- 1 mcc users 2 May 18 16:43 instance
-rw-r--r-- 1 mcc users 5 May 18 16:43 iscolored
-rw-r--r-- 1 mcc users 43K May 18 16:43 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

FORMULA_NAME Liveness

=== Now, execution of the tool begins

BK_START 1716764511908

Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=Liveness
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=Peterson-COL-3
BK_MEMORY_CONFINEMENT=16384
Not applying reductions.
Model is COL
Liveness COL
Running Version 202405141337
[2024-05-26 23:01:54] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, Liveness, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2024-05-26 23:01:54] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2024-05-26 23:01:54] [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.
[2024-05-26 23:01:55] [WARNING] Using fallBack plugin, rng conformance not checked
[2024-05-26 23:01:55] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 1095 ms
[2024-05-26 23:01:55] [INFO ] Imported 11 HL places and 14 HL transitions for a total of 256 PT places and 396.0 transition bindings in 39 ms.
[2024-05-26 23:01:55] [INFO ] Built PT skeleton of HLPN with 11 places and 14 transitions 42 arcs in 6 ms.
[2024-05-26 23:01:55] [INFO ] Skeletonized 0 HLPN properties in 0 ms.
[2024-05-26 23:01:55] [INFO ] Unfolded HLPN to a Petri net with 256 places and 356 transitions 1112 arcs in 60 ms.
[2024-05-26 23:01:55] [INFO ] Unfolded 0 HLPN properties in 0 ms.
[2024-05-26 23:01:56] [INFO ] Unfolded HLPN to a Petri net with 256 places and 356 transitions 1112 arcs in 20 ms.
[2024-05-26 23:01:56] [INFO ] Unfolded 14 HLPN properties in 1 ms.
[2024-05-26 23:01:56] [INFO ] Built PT skeleton of HLPN with 11 places and 14 transitions 42 arcs in 1 ms.
[2024-05-26 23:01:56] [INFO ] Skeletonized 14 HLPN properties in 2 ms.
Reduce places removed 2 places and 0 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Prefix of Interest using HLPN skeleton for deadlock discarded 0 places and 0 transitions.
Domain [Process(4), Tour(3), Process(4)] of place BeginLoop breaks symmetries in sort Process
Arc [2:1*[$i, (MOD (ADD $j 1) 3)]] contains successor/predecessor on variables of sort Tour
Symmetric sort wr.t. initial and guards and successors and join/free detected :Bool
Arc [1:1*[$i, 0]] contains constants of sort Bool
Transition Ask : constants on arcs in [[1:1*[$i, 0]]] introduces in Bool(2) partition with 1 elements that refines current partition to 2 subsets.
[2024-05-26 23:01:56] [INFO ] Unfolded HLPN to a Petri net with 256 places and 356 transitions 1112 arcs in 42 ms.
[2024-05-26 23:01:56] [INFO ] Unfolded 14 HLPN properties in 1 ms.
Deduced a syphon composed of 12 places in 4 ms
Reduce places removed 12 places and 24 transitions.
Built sparse matrix representations for Structural reductions in 4 ms.25415KB memory used
Starting structural reductions in DEADLOCK mode, iteration 0 : 244/244 places, 332/332 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 0 rules in 59 ms. Remains 244 /244 variables (removed 0) and now considering 332/332 (removed 0) transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 87 ms. Remains : 244/244 places, 332/332 transitions.
Starting structural reductions in DEADLOCK mode, iteration 0 : 244/244 places, 332/332 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 0 rules in 32 ms. Remains 244 /244 variables (removed 0) and now considering 332/332 (removed 0) transitions.
[2024-05-26 23:01:56] [INFO ] Flow matrix only has 308 transitions (discarded 24 similar events)
// Phase 1: matrix 308 rows 244 cols
[2024-05-26 23:01:56] [INFO ] Computed 15 invariants in 57 ms
[2024-05-26 23:01:56] [INFO ] Implicit Places using invariants in 496 ms returned []
[2024-05-26 23:01:56] [INFO ] Flow matrix only has 308 transitions (discarded 24 similar events)
[2024-05-26 23:01:56] [INFO ] Invariant cache hit.
[2024-05-26 23:01:57] [INFO ] State equation strengthened by 57 read => feed constraints.
[2024-05-26 23:01:57] [INFO ] Implicit Places using invariants and state equation in 475 ms returned []
Implicit Place search using SMT with State Equation took 1053 ms to find 0 implicit places.
[2024-05-26 23:01:57] [INFO ] Redundant transitions in 41 ms returned []
Running 328 sub problems to find dead transitions.
[2024-05-26 23:01:57] [INFO ] Flow matrix only has 308 transitions (discarded 24 similar events)
[2024-05-26 23:01:57] [INFO ] Invariant cache hit.
[2024-05-26 23:01:57] [INFO ] State equation strengthened by 57 read => feed constraints.
At refinement iteration 0 (INCLUDED_ONLY) 0/240 variables, 7/7 constraints. Problems are: Problem set: 0 solved, 328 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/240 variables, 4/11 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:01] [INFO ] Deduced a trap composed of 12 places in 256 ms of which 41 ms to minimize.
[2024-05-26 23:02:01] [INFO ] Deduced a trap composed of 22 places in 220 ms of which 5 ms to minimize.
[2024-05-26 23:02:01] [INFO ] Deduced a trap composed of 16 places in 65 ms of which 1 ms to minimize.
[2024-05-26 23:02:01] [INFO ] Deduced a trap composed of 56 places in 189 ms of which 5 ms to minimize.
[2024-05-26 23:02:01] [INFO ] Deduced a trap composed of 16 places in 156 ms of which 4 ms to minimize.
[2024-05-26 23:02:02] [INFO ] Deduced a trap composed of 20 places in 167 ms of which 4 ms to minimize.
[2024-05-26 23:02:02] [INFO ] Deduced a trap composed of 38 places in 151 ms of which 4 ms to minimize.
[2024-05-26 23:02:02] [INFO ] Deduced a trap composed of 56 places in 209 ms of which 4 ms to minimize.
[2024-05-26 23:02:02] [INFO ] Deduced a trap composed of 49 places in 175 ms of which 3 ms to minimize.
[2024-05-26 23:02:02] [INFO ] Deduced a trap composed of 20 places in 96 ms of which 3 ms to minimize.
[2024-05-26 23:02:02] [INFO ] Deduced a trap composed of 31 places in 139 ms of which 5 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 62 places in 156 ms of which 2 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 38 places in 90 ms of which 2 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 15 places in 96 ms of which 2 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 19 places in 124 ms of which 3 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 20 places in 111 ms of which 2 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 31 places in 88 ms of which 2 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 9 places in 91 ms of which 2 ms to minimize.
[2024-05-26 23:02:03] [INFO ] Deduced a trap composed of 9 places in 88 ms of which 2 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 9 places in 88 ms of which 2 ms to minimize.
At refinement iteration 2 (INCLUDED_ONLY) 0/240 variables, 20/31 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 38 places in 105 ms of which 2 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 38 places in 103 ms of which 2 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 56 places in 105 ms of which 2 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 33 places in 94 ms of which 2 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 13 places in 50 ms of which 1 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 36 places in 102 ms of which 3 ms to minimize.
[2024-05-26 23:02:04] [INFO ] Deduced a trap composed of 34 places in 86 ms of which 2 ms to minimize.
[2024-05-26 23:02:05] [INFO ] Deduced a trap composed of 41 places in 109 ms of which 3 ms to minimize.
[2024-05-26 23:02:05] [INFO ] Deduced a trap composed of 56 places in 90 ms of which 2 ms to minimize.
[2024-05-26 23:02:05] [INFO ] Deduced a trap composed of 27 places in 57 ms of which 1 ms to minimize.
[2024-05-26 23:02:05] [INFO ] Deduced a trap composed of 27 places in 61 ms of which 1 ms to minimize.
[2024-05-26 23:02:05] [INFO ] Deduced a trap composed of 30 places in 101 ms of which 3 ms to minimize.
[2024-05-26 23:02:05] [INFO ] Deduced a trap composed of 26 places in 112 ms of which 3 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 35 places in 66 ms of which 3 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 50 places in 78 ms of which 6 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 53 places in 84 ms of which 2 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 34 places in 89 ms of which 3 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 52 places in 90 ms of which 3 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 52 places in 88 ms of which 2 ms to minimize.
[2024-05-26 23:02:06] [INFO ] Deduced a trap composed of 27 places in 113 ms of which 3 ms to minimize.
At refinement iteration 3 (INCLUDED_ONLY) 0/240 variables, 20/51 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:10] [INFO ] Deduced a trap composed of 13 places in 133 ms of which 3 ms to minimize.
[2024-05-26 23:02:10] [INFO ] Deduced a trap composed of 34 places in 116 ms of which 3 ms to minimize.
[2024-05-26 23:02:10] [INFO ] Deduced a trap composed of 46 places in 86 ms of which 2 ms to minimize.
[2024-05-26 23:02:11] [INFO ] Deduced a trap composed of 45 places in 73 ms of which 2 ms to minimize.
[2024-05-26 23:02:11] [INFO ] Deduced a trap composed of 45 places in 70 ms of which 2 ms to minimize.
[2024-05-26 23:02:11] [INFO ] Deduced a trap composed of 45 places in 58 ms of which 2 ms to minimize.
[2024-05-26 23:02:11] [INFO ] Deduced a trap composed of 49 places in 91 ms of which 2 ms to minimize.
[2024-05-26 23:02:11] [INFO ] Deduced a trap composed of 48 places in 101 ms of which 3 ms to minimize.
[2024-05-26 23:02:11] [INFO ] Deduced a trap composed of 89 places in 104 ms of which 2 ms to minimize.
[2024-05-26 23:02:12] [INFO ] Deduced a trap composed of 39 places in 169 ms of which 3 ms to minimize.
[2024-05-26 23:02:12] [INFO ] Deduced a trap composed of 61 places in 114 ms of which 4 ms to minimize.
[2024-05-26 23:02:12] [INFO ] Deduced a trap composed of 53 places in 148 ms of which 3 ms to minimize.
[2024-05-26 23:02:13] [INFO ] Deduced a trap composed of 49 places in 115 ms of which 3 ms to minimize.
[2024-05-26 23:02:13] [INFO ] Deduced a trap composed of 49 places in 159 ms of which 4 ms to minimize.
[2024-05-26 23:02:13] [INFO ] Deduced a trap composed of 39 places in 152 ms of which 4 ms to minimize.
[2024-05-26 23:02:13] [INFO ] Deduced a trap composed of 68 places in 120 ms of which 3 ms to minimize.
[2024-05-26 23:02:14] [INFO ] Deduced a trap composed of 52 places in 133 ms of which 11 ms to minimize.
[2024-05-26 23:02:14] [INFO ] Deduced a trap composed of 69 places in 137 ms of which 3 ms to minimize.
[2024-05-26 23:02:14] [INFO ] Deduced a trap composed of 87 places in 145 ms of which 3 ms to minimize.
[2024-05-26 23:02:15] [INFO ] Deduced a trap composed of 51 places in 168 ms of which 3 ms to minimize.
At refinement iteration 4 (INCLUDED_ONLY) 0/240 variables, 20/71 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:16] [INFO ] Deduced a trap composed of 37 places in 155 ms of which 3 ms to minimize.
[2024-05-26 23:02:17] [INFO ] Deduced a trap composed of 30 places in 119 ms of which 3 ms to minimize.
[2024-05-26 23:02:17] [INFO ] Deduced a trap composed of 73 places in 112 ms of which 3 ms to minimize.
[2024-05-26 23:02:17] [INFO ] Deduced a trap composed of 97 places in 149 ms of which 4 ms to minimize.
[2024-05-26 23:02:18] [INFO ] Deduced a trap composed of 46 places in 88 ms of which 2 ms to minimize.
[2024-05-26 23:02:18] [INFO ] Deduced a trap composed of 70 places in 98 ms of which 3 ms to minimize.
[2024-05-26 23:02:18] [INFO ] Deduced a trap composed of 38 places in 128 ms of which 3 ms to minimize.
[2024-05-26 23:02:19] [INFO ] Deduced a trap composed of 54 places in 139 ms of which 3 ms to minimize.
[2024-05-26 23:02:19] [INFO ] Deduced a trap composed of 54 places in 142 ms of which 3 ms to minimize.
[2024-05-26 23:02:19] [INFO ] Deduced a trap composed of 61 places in 128 ms of which 2 ms to minimize.
[2024-05-26 23:02:19] [INFO ] Deduced a trap composed of 41 places in 187 ms of which 3 ms to minimize.
[2024-05-26 23:02:19] [INFO ] Deduced a trap composed of 44 places in 112 ms of which 3 ms to minimize.
[2024-05-26 23:02:20] [INFO ] Deduced a trap composed of 46 places in 83 ms of which 2 ms to minimize.
[2024-05-26 23:02:20] [INFO ] Deduced a trap composed of 17 places in 136 ms of which 3 ms to minimize.
[2024-05-26 23:02:20] [INFO ] Deduced a trap composed of 31 places in 68 ms of which 2 ms to minimize.
[2024-05-26 23:02:21] [INFO ] Deduced a trap composed of 51 places in 136 ms of which 3 ms to minimize.
[2024-05-26 23:02:21] [INFO ] Deduced a trap composed of 49 places in 125 ms of which 3 ms to minimize.
[2024-05-26 23:02:21] [INFO ] Deduced a trap composed of 56 places in 126 ms of which 3 ms to minimize.
[2024-05-26 23:02:21] [INFO ] Deduced a trap composed of 71 places in 90 ms of which 2 ms to minimize.
At refinement iteration 5 (INCLUDED_ONLY) 0/240 variables, 19/90 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:25] [INFO ] Deduced a trap composed of 38 places in 66 ms of which 2 ms to minimize.
[2024-05-26 23:02:26] [INFO ] Deduced a trap composed of 57 places in 133 ms of which 3 ms to minimize.
[2024-05-26 23:02:26] [INFO ] Deduced a trap composed of 61 places in 139 ms of which 3 ms to minimize.
[2024-05-26 23:02:26] [INFO ] Deduced a trap composed of 58 places in 88 ms of which 2 ms to minimize.
[2024-05-26 23:02:26] [INFO ] Deduced a trap composed of 70 places in 119 ms of which 2 ms to minimize.
[2024-05-26 23:02:26] [INFO ] Deduced a trap composed of 78 places in 142 ms of which 2 ms to minimize.
Error getting values : (error "ParserException while parsing response: (timeout
org.smtlib.IParser$ParserException: Unbalanced parentheses at end of input")
At refinement iteration 6 (INCLUDED_ONLY) 0/240 variables, 6/96 constraints. Problems are: Problem set: 0 solved, 328 unsolved
Solver is answering 'unknown', stopping.
After SMT solving in domain Real declared 240/552 variables, and 96 constraints, problems are : Problem set: 0 solved, 328 unsolved in 30049 ms.
Refiners :[Positive P Invariants (semi-flows): 7/11 constraints, Generalized P Invariants (flows): 4/4 constraints, State Equation: 0/244 constraints, ReadFeed: 0/57 constraints, PredecessorRefiner: 328/328 constraints, Known Traps: 85/85 constraints]
Escalating to Integer solving :Problem set: 0 solved, 328 unsolved
At refinement iteration 0 (INCLUDED_ONLY) 0/240 variables, 7/7 constraints. Problems are: Problem set: 0 solved, 328 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/240 variables, 4/11 constraints. Problems are: Problem set: 0 solved, 328 unsolved
At refinement iteration 2 (INCLUDED_ONLY) 0/240 variables, 85/96 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:31] [INFO ] Deduced a trap composed of 84 places in 122 ms of which 4 ms to minimize.
[2024-05-26 23:02:31] [INFO ] Deduced a trap composed of 45 places in 124 ms of which 3 ms to minimize.
[2024-05-26 23:02:32] [INFO ] Deduced a trap composed of 72 places in 129 ms of which 3 ms to minimize.
[2024-05-26 23:02:32] [INFO ] Deduced a trap composed of 76 places in 129 ms of which 3 ms to minimize.
[2024-05-26 23:02:33] [INFO ] Deduced a trap composed of 84 places in 134 ms of which 3 ms to minimize.
[2024-05-26 23:02:33] [INFO ] Deduced a trap composed of 86 places in 115 ms of which 3 ms to minimize.
At refinement iteration 3 (INCLUDED_ONLY) 0/240 variables, 6/102 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:36] [INFO ] Deduced a trap composed of 54 places in 115 ms of which 3 ms to minimize.
[2024-05-26 23:02:37] [INFO ] Deduced a trap composed of 101 places in 137 ms of which 2 ms to minimize.
[2024-05-26 23:02:38] [INFO ] Deduced a trap composed of 42 places in 177 ms of which 3 ms to minimize.
[2024-05-26 23:02:38] [INFO ] Deduced a trap composed of 49 places in 141 ms of which 3 ms to minimize.
At refinement iteration 4 (INCLUDED_ONLY) 0/240 variables, 4/106 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:40] [INFO ] Deduced a trap composed of 69 places in 84 ms of which 2 ms to minimize.
[2024-05-26 23:02:40] [INFO ] Deduced a trap composed of 62 places in 96 ms of which 3 ms to minimize.
At refinement iteration 5 (INCLUDED_ONLY) 0/240 variables, 2/108 constraints. Problems are: Problem set: 0 solved, 328 unsolved
At refinement iteration 6 (INCLUDED_ONLY) 0/240 variables, 0/108 constraints. Problems are: Problem set: 0 solved, 328 unsolved
At refinement iteration 7 (OVERLAPS) 4/244 variables, 4/112 constraints. Problems are: Problem set: 0 solved, 328 unsolved
[2024-05-26 23:02:52] [INFO ] Deduced a trap composed of 34 places in 193 ms of which 3 ms to minimize.
[2024-05-26 23:02:52] [INFO ] Deduced a trap composed of 73 places in 177 ms of which 4 ms to minimize.
At refinement iteration 8 (INCLUDED_ONLY) 0/244 variables, 2/114 constraints. Problems are: Problem set: 0 solved, 328 unsolved
At refinement iteration 9 (INCLUDED_ONLY) 0/244 variables, 0/114 constraints. Problems are: Problem set: 0 solved, 328 unsolved
SMT process timed out in 60382ms, After SMT, problems are : Problem set: 0 solved, 328 unsolved
Search for dead transitions found 0 dead transitions in 60424ms
Finished structural reductions in DEADLOCK mode , in 1 iterations and 61590 ms. Remains : 244/244 places, 332/332 transitions.
Random walk for 1250000 steps, including 0 resets, run took 1604 ms (no deadlock found). (steps per millisecond=779 )
Random directed walk for 1250000 steps, including 0 resets, run took 1382 ms (no deadlock found). (steps per millisecond=904 )
[2024-05-26 23:03:00] [INFO ] Flow matrix only has 308 transitions (discarded 24 similar events)
[2024-05-26 23:03:00] [INFO ] Invariant cache hit.
[2024-05-26 23:03:01] [INFO ] [Real]Absence check using 11 positive place invariants in 15 ms returned sat
[2024-05-26 23:03:01] [INFO ] [Real]Absence check using 11 positive and 4 generalized place invariants in 9 ms returned unsat
[2024-05-26 23:03:01] [INFO ] Unfolded HLPN to a Petri net with 256 places and 356 transitions 1112 arcs in 14 ms.
[2024-05-26 23:03:01] [INFO ] Unfolded 14 HLPN properties in 0 ms.
Initial state reduction rules removed 1 formulas.
Deduced a syphon composed of 12 places in 4 ms
Reduce places removed 12 places and 24 transitions.
RANDOM walk for 40000 steps (8 resets) in 1506 ms. (26 steps per ms) remains 1/13 properties
[2024-05-26 23:03:01] [INFO ] Flatten gal took : 246 ms
BEST_FIRST walk for 40004 steps (8 resets) in 506 ms. (78 steps per ms) remains 1/1 properties
[2024-05-26 23:03:01] [INFO ] Flow matrix only has 308 transitions (discarded 24 similar events)
[2024-05-26 23:03:01] [INFO ] Invariant cache hit.
[2024-05-26 23:03:01] [INFO ] State equation strengthened by 57 read => feed constraints.
All remaining problems are real, not stopping.
At refinement iteration 0 (INCLUDED_ONLY) 0/12 variables, 0/0 constraints. Problems are: Problem set: 0 solved, 1 unsolved
[2024-05-26 23:03:01] [INFO ] Flatten gal took : 139 ms
At refinement iteration 1 (OVERLAPS) 216/228 variables, 8/8 constraints. Problems are: Problem set: 0 solved, 1 unsolved
[2024-05-26 23:03:01] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality13343439525233966934.gal : 26 ms
At refinement iteration 2 (INCLUDED_ONLY) 0/228 variables, 0/8 constraints. Problems are: Problem set: 0 solved, 1 unsolved
[2024-05-26 23:03:01] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality1434587428679575711.prop : 4 ms
At refinement iteration 3 (OVERLAPS) 4/232 variables, 4/12 constraints. Problems are: Problem set: 0 solved, 1 unsolved
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality13343439525233966934.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality1434587428679575711.prop' '--nowitness' '--gen-order' 'FOLLOW'

At refinement iteration 4 (INCLUDED_ONLY) 0/232 variables, 0/12 constraints. Problems are: Problem set: 0 solved, 1 unsolved
its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...329
Loading property file /tmp/ReachabilityCardinality1434587428679575711.prop.
At refinement iteration 5 (OVERLAPS) 308/540 variables, 232/244 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 6 (INCLUDED_ONLY) 0/540 variables, 57/301 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SDD proceeding with computation,1 properties remain. new max is 4
SDD size :1 after 3
SDD proceeding with computation,1 properties remain. new max is 8
SDD size :3 after 4
SDD proceeding with computation,1 properties remain. new max is 16
SDD size :4 after 5
SDD proceeding with computation,1 properties remain. new max is 32
SDD size :5 after 19
At refinement iteration 7 (INCLUDED_ONLY) 0/540 variables, 0/301 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SDD proceeding with computation,1 properties remain. new max is 64
SDD size :19 after 30
At refinement iteration 8 (OVERLAPS) 12/552 variables, 12/313 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 9 (INCLUDED_ONLY) 0/552 variables, 3/316 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SDD proceeding with computation,1 properties remain. new max is 128
SDD size :30 after 56
At refinement iteration 10 (INCLUDED_ONLY) 0/552 variables, 0/316 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SDD proceeding with computation,1 properties remain. new max is 256
SDD size :56 after 390
At refinement iteration 11 (OVERLAPS) 0/552 variables, 0/316 constraints. Problems are: Problem set: 0 solved, 1 unsolved
No progress, stopping.
After SMT solving in domain Real declared 552/552 variables, and 316 constraints, problems are : Problem set: 0 solved, 1 unsolved in 417 ms.
Refiners :[Positive P Invariants (semi-flows): 11/11 constraints, Generalized P Invariants (flows): 4/4 constraints, State Equation: 244/244 constraints, ReadFeed: 57/57 constraints, PredecessorRefiner: 1/1 constraints, Known Traps: 0/0 constraints]
Escalating to Integer solving :Problem set: 0 solved, 1 unsolved
At refinement iteration 0 (INCLUDED_ONLY) 0/12 variables, 0/0 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SDD proceeding with computation,1 properties remain. new max is 512
SDD size :390 after 824
At refinement iteration 1 (OVERLAPS) 216/228 variables, 8/8 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 2 (INCLUDED_ONLY) 0/228 variables, 0/8 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 3 (OVERLAPS) 4/232 variables, 4/12 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 4 (INCLUDED_ONLY) 0/232 variables, 0/12 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 5 (OVERLAPS) 308/540 variables, 232/244 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 6 (INCLUDED_ONLY) 0/540 variables, 57/301 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 7 (INCLUDED_ONLY) 0/540 variables, 1/302 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 8 (INCLUDED_ONLY) 0/540 variables, 0/302 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 9 (OVERLAPS) 12/552 variables, 12/314 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 10 (INCLUDED_ONLY) 0/552 variables, 3/317 constraints. Problems are: Problem set: 0 solved, 1 unsolved
SDD proceeding with computation,1 properties remain. new max is 1024
SDD size :824 after 4758
[2024-05-26 23:03:02] [INFO ] Deduced a trap composed of 9 places in 102 ms of which 2 ms to minimize.
SDD proceeding with computation,1 properties remain. new max is 2048
SDD size :4758 after 26891
[2024-05-26 23:03:02] [INFO ] Deduced a trap composed of 18 places in 116 ms of which 2 ms to minimize.
[2024-05-26 23:03:02] [INFO ] Deduced a trap composed of 9 places in 124 ms of which 2 ms to minimize.
At refinement iteration 11 (INCLUDED_ONLY) 0/552 variables, 3/320 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 12 (INCLUDED_ONLY) 0/552 variables, 0/320 constraints. Problems are: Problem set: 0 solved, 1 unsolved
[2024-05-26 23:03:02] [INFO ] Deduced a trap composed of 52 places in 91 ms of which 2 ms to minimize.
SDD proceeding with computation,1 properties remain. new max is 4096
SDD size :26891 after 48572
[2024-05-26 23:03:03] [INFO ] Deduced a trap composed of 27 places in 116 ms of which 2 ms to minimize.
[2024-05-26 23:03:03] [INFO ] Deduced a trap composed of 51 places in 96 ms of which 2 ms to minimize.
At refinement iteration 13 (OVERLAPS) 0/552 variables, 3/323 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 14 (INCLUDED_ONLY) 0/552 variables, 0/323 constraints. Problems are: Problem set: 0 solved, 1 unsolved
At refinement iteration 15 (OVERLAPS) 0/552 variables, 0/323 constraints. Problems are: Problem set: 0 solved, 1 unsolved
No progress, stopping.
After SMT solving in domain Int declared 552/552 variables, and 323 constraints, problems are : Problem set: 0 solved, 1 unsolved in 1077 ms.
Refiners :[Positive P Invariants (semi-flows): 11/11 constraints, Generalized P Invariants (flows): 4/4 constraints, State Equation: 244/244 constraints, ReadFeed: 57/57 constraints, PredecessorRefiner: 1/1 constraints, Known Traps: 6/6 constraints]
After SMT, in 1519ms problems are : Problem set: 0 solved, 1 unsolved
Parikh walk visited 0 properties in 68 ms.
Support contains 12 out of 244 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 244/244 places, 332/332 transitions.
Drop transitions (Trivial Post-Agglo cleanup.) removed 90 transitions
Trivial Post-agglo rules discarded 90 transitions
Performed 90 trivial Post agglomeration. Transition count delta: 90
Iterating post reduction 0 with 90 rules applied. Total rules applied 90 place count 244 transition count 242
Reduce places removed 90 places and 0 transitions.
Iterating post reduction 1 with 90 rules applied. Total rules applied 180 place count 154 transition count 242
Performed 51 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 51 Pre rules applied. Total rules applied 180 place count 154 transition count 191
Deduced a syphon composed of 51 places in 1 ms
Reduce places removed 51 places and 0 transitions.
Iterating global reduction 2 with 102 rules applied. Total rules applied 282 place count 103 transition count 191
Applied a total of 282 rules in 41 ms. Remains 103 /244 variables (removed 141) and now considering 191/332 (removed 141) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 41 ms. Remains : 103/244 places, 191/332 transitions.
SDD proceeding with computation,1 properties remain. new max is 8192
SDD size :48572 after 87177
Reachability property qltransition_13 is true.
Found states matching all0 target predicate
Will report total states built up to this point. Computation was interrupted after 8193 fixpoint passes
RANDOM walk for 3666673 steps (8 resets) in 10462 ms. (350 steps per ms) remains 0/1 properties
ITS runner timed out or was interrupted.
ITS tools runner thread asked to quit. Dying gracefully.
Able to resolve query QuasiLiveness after proving 14 properties.
Net is quasi-live, checking if it is reversible to establish liveness.
Net is conservative; using simplified expression for initial state.
Deduced a syphon composed of 12 places in 2 ms
Reduce places removed 12 places and 24 transitions.
[2024-05-26 23:03:06] [INFO ] Flatten gal took : 28 ms
[2024-05-26 23:03:06] [INFO ] Flatten gal took : 25 ms
[2024-05-26 23:03:06] [INFO ] Time to serialize gal into /tmp/CTLFireability14044582443939228537.gal : 101 ms
[2024-05-26 23:03:06] [INFO ] Time to serialize properties into /tmp/CTLFireability11234256814329742423.ctl : 2 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability14044582443939228537.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability11234256814329742423.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...285
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
[2024-05-26 23:03:09] [INFO ] Flatten gal took : 25 ms
[2024-05-26 23:03:09] [INFO ] Applying decomposition
[2024-05-26 23:03:09] [INFO ] Flatten gal took : 22 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/convert-linux64' '-i' '/tmp/graph18090833232283193136.txt' '-o' '/tmp/graph18090833232283193136.bin' '-w' '/tmp/graph18090833232283193136.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/louvain-linux64' '/tmp/graph18090833232283193136.bin' '-l' '-1' '-v' '-w' '/tmp/graph18090833232283193136.weights' '-q' '0' '-e' '0.001'
[2024-05-26 23:03:09] [INFO ] Decomposing Gal with order
[2024-05-26 23:03:09] [INFO ] Rewriting arrays to variables to allow decomposition.
[2024-05-26 23:03:09] [INFO ] Removed a total of 220 redundant transitions.
[2024-05-26 23:03:09] [INFO ] Flatten gal took : 64 ms
[2024-05-26 23:03:09] [INFO ] Fuse similar labels procedure discarded/fused a total of 0 labels/synchronizations in 8 ms.
[2024-05-26 23:03:09] [INFO ] Time to serialize gal into /tmp/CTLFireability17089538359553476037.gal : 10 ms
[2024-05-26 23:03:09] [INFO ] Time to serialize properties into /tmp/CTLFireability2992026406185806986.ctl : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability17089538359553476037.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability2992026406185806986.ctl'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...263
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
[2024-05-26 23:03:13] [INFO ] Flatten gal took : 32 ms
[2024-05-26 23:03:13] [INFO ] Flatten gal took : 16 ms
[2024-05-26 23:03:13] [INFO ] Time to serialize gal into /tmp/CTLFireability11961314943978372537.gal : 3 ms
[2024-05-26 23:03:13] [INFO ] Time to serialize properties into /tmp/CTLFireability4565587524425591625.ctl : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability11961314943978372537.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability4565587524425591625.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...284
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Detected timeout of ITS tools.
[2024-05-26 23:03:43] [INFO ] Flatten gal took : 15 ms
[2024-05-26 23:03:43] [INFO ] Applying decomposition
[2024-05-26 23:03:43] [INFO ] Flatten gal took : 15 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/convert-linux64' '-i' '/tmp/graph8064589455265792959.txt' '-o' '/tmp/graph8064589455265792959.bin' '-w' '/tmp/graph8064589455265792959.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/louvain-linux64' '/tmp/graph8064589455265792959.bin' '-l' '-1' '-v' '-w' '/tmp/graph8064589455265792959.weights' '-q' '0' '-e' '0.001'
[2024-05-26 23:03:43] [INFO ] Decomposing Gal with order
[2024-05-26 23:03:43] [INFO ] Rewriting arrays to variables to allow decomposition.
[2024-05-26 23:03:43] [INFO ] Removed a total of 214 redundant transitions.
[2024-05-26 23:03:43] [INFO ] Flatten gal took : 54 ms
[2024-05-26 23:03:43] [INFO ] Fuse similar labels procedure discarded/fused a total of 9 labels/synchronizations in 14 ms.
[2024-05-26 23:03:43] [INFO ] Time to serialize gal into /tmp/CTLFireability7561634601976664659.gal : 13 ms
[2024-05-26 23:03:43] [INFO ] Time to serialize properties into /tmp/CTLFireability10586681757122378754.ctl : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability7561634601976664659.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability10586681757122378754.ctl'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...263
No direction supplied, using forward translation only.
Parsed 1 CTL formulae.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,3.40795e+06,8.20503,168336,3853,200,205341,3652,779,1.23003e+06,94,28947,0


Converting to forward existential form...Done !
original formula: AG(EF((((((i3.u0.Idle_0==1)&&(i3.u1.Idle_1==1))&&((i11.i0.u2.Idle_2==1)&&(i3.u3.Idle_3==1)))&&(((i2.i1.u42.WantSection_0==1)&&(i8.i1.u25....297
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((((i3.u0.Idle_0==1)&&(i3.u1.Idle_1==1))&&((i11.i0.u2.Idle_2==1)&&(i3.u3.Idle_3=...357
Reverse transition relation is NOT exact ! Due to transitions UpdateTurnj1i0k1, UpdateTurnj1i0k2, UpdateTurnj1i0k3, UpdateTurnj1i1k0, UpdateTurnj1i1k2, Upd...1617
(forward)formula 0,0,12.2079,168336,1,0,206048,3652,3925,1.23003e+06,476,28947,643626
ITS tools runner thread asked to quit. Dying gracefully.
Deduced a syphon composed of 12 places in 1 ms
Reduce places removed 12 places and 24 transitions.
[2024-05-26 23:03:55] [INFO ] Flatten gal took : 17 ms
[2024-05-26 23:03:55] [INFO ] Flatten gal took : 15 ms
[2024-05-26 23:03:55] [INFO ] Time to serialize gal into /tmp/CTLFireability41607169851047807.gal : 4 ms
[2024-05-26 23:03:55] [INFO ] Time to serialize properties into /tmp/CTLFireability10796486643872595292.ctl : 4 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability41607169851047807.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability10796486643872595292.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...282
No direction supplied, using forward translation only.
Parsed 14 CTL formulae.
Detected timeout of ITS tools.
[2024-05-26 23:03:58] [INFO ] Flatten gal took : 15 ms
[2024-05-26 23:03:58] [INFO ] Applying decomposition
[2024-05-26 23:03:58] [INFO ] Flatten gal took : 16 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/convert-linux64' '-i' '/tmp/graph8477390686509911077.txt' '-o' '/tmp/graph8477390686509911077.bin' '-w' '/tmp/graph8477390686509911077.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/louvain-linux64' '/tmp/graph8477390686509911077.bin' '-l' '-1' '-v' '-w' '/tmp/graph8477390686509911077.weights' '-q' '0' '-e' '0.001'
[2024-05-26 23:03:58] [INFO ] Decomposing Gal with order
[2024-05-26 23:03:58] [INFO ] Rewriting arrays to variables to allow decomposition.
[2024-05-26 23:03:58] [INFO ] Removed a total of 206 redundant transitions.
[2024-05-26 23:03:58] [INFO ] Flatten gal took : 38 ms
[2024-05-26 23:03:58] [INFO ] Fuse similar labels procedure discarded/fused a total of 23 labels/synchronizations in 9 ms.
[2024-05-26 23:03:58] [INFO ] Time to serialize gal into /tmp/CTLFireability3373358384921797757.gal : 6 ms
[2024-05-26 23:03:58] [INFO ] Time to serialize properties into /tmp/CTLFireability11811762997811691349.ctl : 5 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability3373358384921797757.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability11811762997811691349.ctl'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...263
No direction supplied, using forward translation only.
Parsed 14 CTL formulae.
Detected timeout of ITS tools.
[2024-05-26 23:04:02] [INFO ] Flatten gal took : 17 ms
[2024-05-26 23:04:02] [INFO ] Flatten gal took : 16 ms
[2024-05-26 23:04:02] [INFO ] Time to serialize gal into /tmp/CTLFireability13745821849617077313.gal : 3 ms
[2024-05-26 23:04:02] [INFO ] Time to serialize properties into /tmp/CTLFireability8810834769181164916.ctl : 2 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability13745821849617077313.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability8810834769181164916.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...284
No direction supplied, using forward translation only.
Parsed 14 CTL formulae.
Detected timeout of ITS tools.
[2024-05-26 23:04:32] [INFO ] Flatten gal took : 16 ms
[2024-05-26 23:04:32] [INFO ] Applying decomposition
[2024-05-26 23:04:32] [INFO ] Flatten gal took : 15 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/convert-linux64' '-i' '/tmp/graph13818925515975483924.txt' '-o' '/tmp/graph13818925515975483924.bin' '-w' '/tmp/graph13818925515975483924.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/louvain-linux64' '/tmp/graph13818925515975483924.bin' '-l' '-1' '-v' '-w' '/tmp/graph13818925515975483924.weights' '-q' '0' '-e' '0.001'
[2024-05-26 23:04:32] [INFO ] Decomposing Gal with order
[2024-05-26 23:04:32] [INFO ] Rewriting arrays to variables to allow decomposition.
[2024-05-26 23:04:32] [INFO ] Removed a total of 201 redundant transitions.
[2024-05-26 23:04:32] [INFO ] Flatten gal took : 31 ms
[2024-05-26 23:04:32] [INFO ] Fuse similar labels procedure discarded/fused a total of 27 labels/synchronizations in 5 ms.
[2024-05-26 23:04:32] [INFO ] Time to serialize gal into /tmp/CTLFireability7020948152404149498.gal : 4 ms
[2024-05-26 23:04:32] [INFO ] Time to serialize properties into /tmp/CTLFireability14431782030662548162.ctl : 2 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability7020948152404149498.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability14431782030662548162.ctl'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...263
No direction supplied, using forward translation only.
Parsed 14 CTL formulae.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,3.40795e+06,20.4838,442956,5406,338,532316,6520,627,3.41651e+06,122,66898,0


Converting to forward existential form...Done !
original formula: AG(EF(((((i1.u1.Idle_0>=1)&&(i12.u45.WantSection_0>=1))||((i10.u3.Idle_3>=1)&&(i10.u3.WantSection_6>=1)))||(((i2.u2.Idle_1>=1)&&(i2.u2.Wa...222
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((i1.u1.Idle_0>=1)&&(i12.u45.WantSection_0>=1))||((i10.u3.Idle_3>=1)&&(i10.u3.W...282
Reverse transition relation is NOT exact ! Due to transitions BecomeIdlei0, BecomeIdlei1, BecomeIdlei2, BecomeIdlei3, NotAlonej0i0k2, NotAlonej0i0k3, NotAl...1429
(forward)formula 0,1,27.0691,442956,1,0,532316,7505,3554,3.41651e+06,698,66898,1339798
Formula is TRUE !

***************************************

original formula: AG(EF(((((((((i10.u6.AskForSection_3>=1)&&(i10.u7.Turn_2>=1))||((i10.u6.AskForSection_3>=1)&&(i10.u7.Turn_1>=1)))||(((i10.u6.AskForSectio...2558
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((((((i10.u6.AskForSection_3>=1)&&(i10.u7.Turn_2>=1))||((i10.u6.AskForSection_3...2618
(forward)formula 1,1,28.1032,442956,1,0,532316,7741,3968,3.41651e+06,736,66898,1466357
Formula is TRUE !

***************************************

original formula: AG(EF(((((((i10.u7.Turn_2>=1)&&(i10.u7.TestTurn_6>=1))||((i0.u32.Turn_4>=1)&&(i0.u31.TestTurn_1>=1)))||(((i1.u5.Turn_11>=1)&&(i1.u9.TestT...596
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((((i10.u7.Turn_2>=1)&&(i10.u7.TestTurn_6>=1))||((i0.u32.Turn_4>=1)&&(i0.u31.Te...656
(forward)formula 2,1,28.9922,442956,1,0,532316,7790,4080,3.41651e+06,738,66898,1558153
Formula is TRUE !
Detected timeout of ITS tools.
[2024-05-26 23:05:02] [INFO ] Flatten gal took : 16 ms
[2024-05-26 23:05:02] [INFO ] Flatten gal took : 11 ms
[2024-05-26 23:05:02] [INFO ] Time to serialize gal into /tmp/CTLFireability6230497873267126276.gal : 16 ms
[2024-05-26 23:05:02] [INFO ] Time to serialize properties into /tmp/CTLFireability8548882271402710629.ctl : 2 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability6230497873267126276.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability8548882271402710629.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...283
No direction supplied, using forward translation only.
Parsed 11 CTL formulae.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,3.40795e+06,35.4724,760884,2,86058,5,2.20358e+06,6,0,1311,3.77443e+06,0


Converting to forward existential form...Done !
original formula: AG(EF(((((((((Turn_7>=1)&&(TestTurn_7>=1))||((Turn_2>=1)&&(TestTurn_9>=1)))||(((Turn_2>=1)&&(TestTurn_3>=1))||((Turn_11>=1)&&(TestTurn_2>...1258
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((((((Turn_7>=1)&&(TestTurn_7>=1))||((Turn_2>=1)&&(TestTurn_9>=1)))||(((Turn_2>...1318
Reverse transition relation is NOT exact ! Due to transitions UpdateTurnj0i0k0, UpdateTurnj0i0k1, UpdateTurnj0i0k2, UpdateTurnj0i0k3, UpdateTurnj0i1k0, Upd...1570
(forward)formula 0,1,186.132,2770224,1,0,663,1.40658e+07,14,335,4380,7.75318e+06,15
Formula is TRUE !

***************************************

original formula: AG(EF((((EndTurn_2>=1)||(EndTurn_5>=1))||((EndTurn_8>=1)||(EndTurn_11>=1)))))
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((EndTurn_2>=1)||(EndTurn_5>=1))||((EndTurn_8>=1)||(EndTurn_11>=1))))))] = FALSE
(forward)formula 1,1,233.166,2830060,1,0,663,2.15297e+07,15,335,4383,7.75318e+06,66
Formula is TRUE !
Detected timeout of ITS tools.
[2024-05-26 23:10:02] [INFO ] Flatten gal took : 12 ms
[2024-05-26 23:10:02] [INFO ] Applying decomposition
[2024-05-26 23:10:02] [INFO ] Flatten gal took : 13 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/convert-linux64' '-i' '/tmp/graph4512658437259302879.txt' '-o' '/tmp/graph4512658437259302879.bin' '-w' '/tmp/graph4512658437259302879.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202405141337/bin/louvain-linux64' '/tmp/graph4512658437259302879.bin' '-l' '-1' '-v' '-w' '/tmp/graph4512658437259302879.weights' '-q' '0' '-e' '0.001'
[2024-05-26 23:10:02] [INFO ] Decomposing Gal with order
[2024-05-26 23:10:02] [INFO ] Rewriting arrays to variables to allow decomposition.
[2024-05-26 23:10:02] [INFO ] Removed a total of 214 redundant transitions.
[2024-05-26 23:10:02] [INFO ] Flatten gal took : 38 ms
[2024-05-26 23:10:02] [INFO ] Fuse similar labels procedure discarded/fused a total of 9 labels/synchronizations in 3 ms.
[2024-05-26 23:10:02] [INFO ] Time to serialize gal into /tmp/CTLFireability9602242963017335104.gal : 7 ms
[2024-05-26 23:10:02] [INFO ] Time to serialize properties into /tmp/CTLFireability16867923571707441423.ctl : 2 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLFireability9602242963017335104.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLFireability16867923571707441423.ctl'

its-ctl command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -...263
No direction supplied, using forward translation only.
Parsed 9 CTL formulae.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
reachable,3.40795e+06,8.86873,178792,3692,149,268782,2966,711,1.0912e+06,79,20556,0


Converting to forward existential form...Done !
original formula: AG(EF(((((i1.u8.EndTurn_1>=1)||(i2.u7.EndTurn_0>=1))||((i2.u5.EndTurn_3>=1)||(i1.u9.EndTurn_4>=1)))||(((i1.u10.EndTurn_7>=1)||(i2.u31.End...218
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((i1.u8.EndTurn_1>=1)||(i2.u7.EndTurn_0>=1))||((i2.u5.EndTurn_3>=1)||(i1.u9.End...278
Reverse transition relation is NOT exact ! Due to transitions UpdateTurnj2i0k1, UpdateTurnj2i0k2, UpdateTurnj2i0k3, UpdateTurnj2i1k0, UpdateTurnj2i1k2, Upd...1642
(forward)formula 0,1,14.2597,202816,1,0,268782,3596,3709,1.4255e+06,400,20556,816967
Formula is TRUE !

***************************************

original formula: AG(EF(((((i0.u0.WantSection_5>=1)&&(i7.i1.u32.CS_2>=1))||((i2.u1.WantSection_7>=1)&&(i12.u12.CS_3>=1)))||(((i6.i1.u2.WantSection_1>=1)&&(...227
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((i0.u0.WantSection_5>=1)&&(i7.i1.u32.CS_2>=1))||((i2.u1.WantSection_7>=1)&&(i1...287
(forward)formula 1,1,16.9213,250680,1,0,332195,3789,3737,1.71017e+06,400,21896,1003902
Formula is TRUE !

***************************************

original formula: AG(EF((((((((i9.u64.BeginLoop_17>=1)||(i1.u41.BeginLoop_16>=1))||((i9.u20.BeginLoop_19>=1)||(i9.u42.BeginLoop_18>=1)))||(((i14.i1.u65.Beg...1415
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((((((i9.u64.BeginLoop_17>=1)||(i1.u41.BeginLoop_16>=1))||((i9.u20.BeginLoop_19>...1475
(forward)formula 2,1,18.1851,282096,1,0,373292,3808,3895,1.91621e+06,400,22002,1126744
Formula is TRUE !

***************************************

original formula: AG(EF((((((i7.i0.u28.TestIdentity_34>=1)||(i3.u33.TestIdentity_0>=1))||((i9.u64.TestIdentity_17>=1)||(i13.u49.TestIdentity_39>=1)))||(((i...408
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((((i7.i0.u28.TestIdentity_34>=1)||(i3.u33.TestIdentity_0>=1))||((i9.u64.TestIde...468
(forward)formula 3,1,19.8539,318264,1,0,420995,3961,3928,2.1618e+06,400,23319,1246742
Formula is TRUE !

***************************************

original formula: AG(EF((((((((i9.u42.TestIdentity_18>=1)||(i9.u20.TestIdentity_19>=1))||((i1.u41.TestIdentity_16>=1)||(i14.i1.u43.TestIdentity_22>=1)))||(...1173
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((((((i9.u42.TestIdentity_18>=1)||(i9.u20.TestIdentity_19>=1))||((i1.u41.TestIde...1233
(forward)formula 4,1,20.7909,338592,1,0,447548,3961,4052,2.29458e+06,400,23321,1331645
Formula is TRUE !

***************************************

original formula: AG(EF((((((((i0.u14.IsEndLoop_2>=1)||(i3.u56.IsEndLoop_1>=1))||((i3.u33.IsEndLoop_0>=1)||(i0.u35.IsEndLoop_6>=1)))||(((i4.i1.u16.IsEndLoo...1070
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((((((i0.u14.IsEndLoop_2>=1)||(i3.u56.IsEndLoop_1>=1))||((i3.u33.IsEndLoop_0>=1)...1130
(forward)formula 5,1,21.9284,360240,1,0,483403,3984,4170,2.38005e+06,401,23472,1419013
Formula is TRUE !

***************************************

original formula: AG(EF(((((((((i2.u1.WantSection_7>=1)&&(i0.u35.TestAlone_7>=1))||((i0.u0.WantSection_5>=1)&&(i12.u63.TestAlone_46>=1)))||(((i0.u0.WantSec...2127
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((((((i2.u1.WantSection_7>=1)&&(i0.u35.TestAlone_7>=1))||((i0.u0.WantSection_5>...2187
(forward)formula 6,1,22.2533,365256,1,0,491671,3984,4387,2.39779e+06,401,23472,1451126
Formula is TRUE !

***************************************

original formula: AG(EF(((((((((i6.i1.u2.WantSection_0>=1)&&(i12.u53.TestAlone_44>=1))||((i4.i1.u3.WantSection_2>=1)&&(i8.u58.TestAlone_9>=1)))||(((i0.u0.W...2127
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U ((((((((i6.i1.u2.WantSection_0>=1)&&(i12.u53.TestAlone_44>=1))||((i4.i1.u3.WantSe...2187
(forward)formula 7,1,24.8696,416736,1,0,567150,4083,4552,2.68597e+06,401,23977,1641128
Formula is TRUE !

***************************************

original formula: AG(EF((((((i2.u7.IsEndLoop_3>=1)||(i1.u9.IsEndLoop_19>=1))||((i13.u49.IsEndLoop_39>=1)||(i1.u8.IsEndLoop_7>=1)))||(((i14.i0.u30.IsEndLoop...361
=> equivalent forward existential formula: [(FwdU(Init,TRUE) * !(E(TRUE U (((((i2.u7.IsEndLoop_3>=1)||(i1.u9.IsEndLoop_19>=1))||((i13.u49.IsEndLoop_39>=1)|...421
(forward)formula 8,0,25.6428,431932,1,0,585689,4116,4597,2.7837e+06,401,24094,1693035
FORMULA Liveness FALSE TECHNIQUES RANDOM_WALK DECISION_DIAGRAMS COLLATERAL_PROCESSING TOPOLOGICAL INITIAL_STATE USE_NUPN
ITS tools runner thread asked to quit. Dying gracefully.
Total runtime 513961 ms.

BK_STOP 1716765028548

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

+ export BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ Liveness = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution Liveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ 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//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202405141337.jar
+ VERSION=202405141337
+ echo 'Running Version 202405141337'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination Liveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800

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="Peterson-COL-3"
export BK_EXAMINATION="Liveness"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
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-5568"
echo " Executing tool itstools"
echo " Input is Peterson-COL-3, examination is Liveness"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r277-smll-171654416800134"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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