About the Execution of ITS-Tools for LamportFastMutEx-COL-8
| Execution Summary | |||||
| Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
| 15742.870 | 3600000.00 | 10496795.00 | 8458.30 | TTTTT?TFTTFTTTFF | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fko/mcc2020-input.r096-oct2-158940145400639.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2020-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.........................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is LamportFastMutEx-COL-8, examination is ReachabilityFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r096-oct2-158940145400639
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 220K
-rw-r--r-- 1 mcc users 3.4K Apr 30 13:04 CTLCardinality.txt
-rw-r--r-- 1 mcc users 18K Apr 30 13:04 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.7K Apr 30 13:04 CTLFireability.txt
-rw-r--r-- 1 mcc users 17K Apr 30 13:04 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Apr 30 13:04 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.3K Apr 30 13:04 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.2K Apr 30 13:04 LTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Apr 30 13:04 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.1K Apr 30 13:04 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 30 13:04 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.6K Apr 30 13:04 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 18K Apr 30 13:04 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.1K Apr 30 13:04 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 18K Apr 30 13:04 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Apr 30 13:04 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Apr 30 13:04 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Apr 30 13:04 equiv_pt
-rw-r--r-- 1 mcc users 2 Apr 30 13:04 instance
-rw-r--r-- 1 mcc users 5 Apr 30 13:04 iscolored
-rw-r--r-- 1 mcc users 44K Apr 30 13:04 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 LamportFastMutEx-COL-8-ReachabilityFireability-00
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-01
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-02
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-03
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-04
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-05
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-06
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-07
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-08
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-09
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-10
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-11
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-12
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-13
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-14
FORMULA_NAME LamportFastMutEx-COL-8-ReachabilityFireability-15
=== Now, execution of the tool begins
BK_START 1589592307418
[2020-05-16 01:25:09] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -greatspnpath, /home/mcc/BenchKit//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2020-05-16 01:25:09] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-05-16 01:25:09] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2020-05-16 01:25:09] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 500 ms
[2020-05-16 01:25:09] [INFO ] sort/places :
pid * pid->wait,done,
pid * bool->b,
pid->P-start_1,x,y,P-setx_3,P-setbi_5,P-ify0_4,P-sety_9,P-ifxi_10,P-setbi_11,P-fordo_12,P-await_13,P-ifyi_15,P-awaity,P-CS_21,P-setbi_24,
[2020-05-16 01:25:09] [INFO ] Imported 18 HL places and 17 HL transitions for a total of 315 PT places and 837.0 transition bindings in 27 ms.
[2020-05-16 01:25:09] [INFO ] Computed order based on color domains.
[2020-05-16 01:25:09] [INFO ] Unfolded HLPN to a Petri net with 315 places and 666 transitions in 16 ms.
[2020-05-16 01:25:09] [INFO ] Unfolded HLPN properties in 1 ms.
Deduced a syphon composed of 49 places in 3 ms
Reduce places removed 49 places and 82 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityFireability.xml in 59 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 0 resets, run finished after 131 ms. (steps per millisecond=76 ) properties seen :[1, 1, 1, 1, 1, 0, 1, 1, 1, 1, 0, 1, 1, 1, 1, 1]
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-15 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-14 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-13 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-12 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-11 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-09 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-08 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-07 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-06 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-04 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-03 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-01 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-00 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 47 ms. (steps per millisecond=212 ) properties seen :[0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 174 ms. (steps per millisecond=57 ) properties seen :[0, 0]
[2020-05-16 01:25:10] [INFO ] Flow matrix only has 416 transitions (discarded 168 similar events)
// Phase 1: matrix 416 rows 266 cols
[2020-05-16 01:25:10] [INFO ] Computed 82 place invariants in 13 ms
[2020-05-16 01:25:10] [INFO ] [Real]Absence check using 82 positive place invariants in 53 ms returned sat
[2020-05-16 01:25:10] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:25:10] [INFO ] [Real]Absence check using state equation in 254 ms returned sat
[2020-05-16 01:25:10] [INFO ] State equation strengthened by 128 read => feed constraints.
[2020-05-16 01:25:10] [INFO ] [Real]Added 128 Read/Feed constraints in 20 ms returned sat
[2020-05-16 01:25:10] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:25:10] [INFO ] [Nat]Absence check using 82 positive place invariants in 35 ms returned sat
[2020-05-16 01:25:10] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:25:10] [INFO ] [Nat]Absence check using state equation in 235 ms returned sat
[2020-05-16 01:25:10] [INFO ] [Nat]Added 128 Read/Feed constraints in 40 ms returned sat
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 42 places in 102 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 8 places in 92 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 34 places in 93 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 30 places in 102 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 17 places in 89 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 9 places in 84 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 39 places in 124 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 33 places in 73 ms
[2020-05-16 01:25:11] [INFO ] Deduced a trap composed of 35 places in 77 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 29 places in 98 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 24 places in 88 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 35 places in 111 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 39 places in 90 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 18 places in 82 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 9 places in 124 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 17 places in 93 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 39 places in 63 ms
[2020-05-16 01:25:12] [INFO ] Deduced a trap composed of 36 places in 75 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 28 places in 71 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 28 places in 73 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 27 places in 82 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 39 places in 85 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 9 places in 96 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 37 places in 83 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 33 places in 91 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 38 places in 81 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 38 places in 79 ms
[2020-05-16 01:25:13] [INFO ] Deduced a trap composed of 31 places in 87 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 30 places in 81 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 34 places in 78 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 20 places in 75 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 9 places in 75 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 37 places in 84 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 29 places in 66 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 31 places in 63 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 32 places in 81 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 41 places in 69 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 8 places in 69 ms
[2020-05-16 01:25:14] [INFO ] Deduced a trap composed of 28 places in 65 ms
[2020-05-16 01:25:15] [INFO ] Deduced a trap composed of 32 places in 71 ms
[2020-05-16 01:25:15] [INFO ] Deduced a trap composed of 35 places in 84 ms
[2020-05-16 01:25:15] [INFO ] Deduced a trap composed of 22 places in 69 ms
[2020-05-16 01:25:15] [INFO ] Deduced a trap composed of 26 places in 168 ms
[2020-05-16 01:25:15] [INFO ] Deduced a trap composed of 20 places in 103 ms
[2020-05-16 01:25:15] [INFO ] Deduced a trap composed of 37 places in 103 ms
[2020-05-16 01:25:15] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream closed (> (+ s3 s9 s12 s13 s14 s15 s16 s17 s18 s19 s21 s22 s24 s25 s33 s34 s46 s51 s52 s59 s60 s76 s79 s84 s87 s92 s93 s95 s118 s127 s142 s199 s237 s243 s244 s245 s252) 0)") while checking expression at index 0
[2020-05-16 01:25:15] [INFO ] [Real]Absence check using 82 positive place invariants in 33 ms returned sat
[2020-05-16 01:25:15] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:25:16] [INFO ] [Real]Absence check using state equation in 872 ms returned sat
[2020-05-16 01:25:16] [INFO ] [Real]Added 128 Read/Feed constraints in 59 ms returned sat
[2020-05-16 01:25:16] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:25:16] [INFO ] [Nat]Absence check using 82 positive place invariants in 41 ms returned sat
[2020-05-16 01:25:16] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:25:17] [INFO ] [Nat]Absence check using state equation in 260 ms returned sat
[2020-05-16 01:25:17] [INFO ] [Nat]Added 128 Read/Feed constraints in 20 ms returned sat
[2020-05-16 01:25:17] [INFO ] Deduced a trap composed of 8 places in 110 ms
[2020-05-16 01:25:17] [INFO ] Deduced a trap composed of 8 places in 38 ms
[2020-05-16 01:25:17] [INFO ] Deduced a trap composed of 9 places in 41 ms
[2020-05-16 01:25:17] [INFO ] Deduced a trap composed of 9 places in 45 ms
[2020-05-16 01:25:17] [INFO ] Deduced a trap composed of 9 places in 20 ms
[2020-05-16 01:25:17] [INFO ] Deduced a trap composed of 9 places in 20 ms
[2020-05-16 01:25:17] [INFO ] Trap strengthening (SAT) tested/added 7/6 trap constraints in 433 ms
[2020-05-16 01:25:17] [INFO ] Computed and/alt/rep : 576/5248/408 causal constraints in 29 ms.
[2020-05-16 01:25:21] [INFO ] Added : 370 causal constraints over 74 iterations in 4205 ms. Result :unknown
Incomplete Parikh walk after 151700 steps, including 1000 resets, run finished after 573 ms. (steps per millisecond=264 ) properties seen :[0, 0] could not realise parikh vector
Support contains 162 out of 266 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 266/266 places, 584/584 transitions.
Applied a total of 0 rules in 67 ms. Remains 266 /266 variables (removed 0) and now considering 584/584 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 266/266 places, 584/584 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 3507 ms. (steps per millisecond=285 ) properties seen :[0, 0]
Incomplete Best-First random walk after 1000001 steps, including 0 resets, run finished after 2808 ms. (steps per millisecond=356 ) properties seen :[0, 0]
Interrupted Best-First random walk after 460943 steps, including 0 resets, run timeout after 5001 ms. (steps per millisecond=92 ) properties seen :[0, 1]
FORMULA LamportFastMutEx-COL-8-ReachabilityFireability-10 FALSE TECHNIQUES TOPOLOGICAL BESTFIRST_WALK
[2020-05-16 01:25:33] [INFO ] Flow matrix only has 416 transitions (discarded 168 similar events)
// Phase 1: matrix 416 rows 266 cols
[2020-05-16 01:25:33] [INFO ] Computed 82 place invariants in 6 ms
[2020-05-16 01:25:33] [INFO ] [Real]Absence check using 82 positive place invariants in 189 ms returned sat
[2020-05-16 01:25:33] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:25:34] [INFO ] [Real]Absence check using state equation in 372 ms returned sat
[2020-05-16 01:25:34] [INFO ] State equation strengthened by 128 read => feed constraints.
[2020-05-16 01:25:34] [INFO ] [Real]Added 128 Read/Feed constraints in 37 ms returned sat
[2020-05-16 01:25:34] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:25:34] [INFO ] [Nat]Absence check using 82 positive place invariants in 271 ms returned sat
[2020-05-16 01:25:34] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:25:34] [INFO ] [Nat]Absence check using state equation in 264 ms returned sat
[2020-05-16 01:25:34] [INFO ] [Nat]Added 128 Read/Feed constraints in 21 ms returned sat
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 42 places in 124 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 8 places in 89 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 34 places in 89 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 30 places in 91 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 17 places in 95 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 9 places in 128 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 39 places in 86 ms
[2020-05-16 01:25:35] [INFO ] Deduced a trap composed of 33 places in 161 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 35 places in 87 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 29 places in 84 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 24 places in 83 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 35 places in 80 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 39 places in 96 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 18 places in 81 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 9 places in 93 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 17 places in 87 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 39 places in 85 ms
[2020-05-16 01:25:36] [INFO ] Deduced a trap composed of 36 places in 79 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 28 places in 79 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 28 places in 80 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 27 places in 94 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 39 places in 87 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 9 places in 94 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 37 places in 82 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 33 places in 91 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 38 places in 85 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 38 places in 85 ms
[2020-05-16 01:25:37] [INFO ] Deduced a trap composed of 31 places in 80 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 30 places in 84 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 34 places in 75 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 20 places in 79 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 9 places in 75 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 37 places in 83 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 29 places in 83 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 31 places in 76 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 32 places in 87 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 41 places in 75 ms
[2020-05-16 01:25:38] [INFO ] Deduced a trap composed of 8 places in 85 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 28 places in 85 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 32 places in 81 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 35 places in 82 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 22 places in 71 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 26 places in 81 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 20 places in 89 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 37 places in 86 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 26 places in 77 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 40 places in 73 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 27 places in 84 ms
[2020-05-16 01:25:39] [INFO ] Deduced a trap composed of 9 places in 77 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 35 places in 91 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 27 places in 92 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 35 places in 99 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 31 places in 97 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 29 places in 104 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 24 places in 75 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 28 places in 74 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 23 places in 72 ms
[2020-05-16 01:25:40] [INFO ] Deduced a trap composed of 8 places in 76 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 17 places in 80 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 38 places in 78 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 26 places in 167 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 17 places in 127 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 9 places in 107 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 39 places in 125 ms
[2020-05-16 01:25:41] [INFO ] Deduced a trap composed of 24 places in 165 ms
[2020-05-16 01:25:42] [INFO ] Deduced a trap composed of 35 places in 364 ms
[2020-05-16 01:25:42] [INFO ] Deduced a trap composed of 17 places in 130 ms
[2020-05-16 01:25:42] [INFO ] Deduced a trap composed of 19 places in 140 ms
[2020-05-16 01:25:42] [INFO ] Deduced a trap composed of 22 places in 297 ms
[2020-05-16 01:25:43] [INFO ] Deduced a trap composed of 27 places in 147 ms
[2020-05-16 01:25:43] [INFO ] Deduced a trap composed of 22 places in 221 ms
[2020-05-16 01:25:43] [INFO ] Deduced a trap composed of 33 places in 166 ms
[2020-05-16 01:25:43] [INFO ] Deduced a trap composed of 38 places in 212 ms
[2020-05-16 01:25:44] [INFO ] Deduced a trap composed of 24 places in 275 ms
[2020-05-16 01:25:44] [INFO ] Deduced a trap composed of 26 places in 108 ms
[2020-05-16 01:25:44] [INFO ] Deduced a trap composed of 31 places in 116 ms
[2020-05-16 01:25:44] [INFO ] Deduced a trap composed of 33 places in 163 ms
[2020-05-16 01:25:44] [INFO ] Deduced a trap composed of 29 places in 117 ms
[2020-05-16 01:25:44] [INFO ] Deduced a trap composed of 21 places in 191 ms
[2020-05-16 01:25:45] [INFO ] Deduced a trap composed of 21 places in 181 ms
[2020-05-16 01:25:45] [INFO ] Deduced a trap composed of 17 places in 116 ms
[2020-05-16 01:25:45] [INFO ] Deduced a trap composed of 27 places in 170 ms
[2020-05-16 01:25:45] [INFO ] Deduced a trap composed of 33 places in 100 ms
[2020-05-16 01:25:45] [INFO ] Deduced a trap composed of 10 places in 110 ms
[2020-05-16 01:25:45] [INFO ] Deduced a trap composed of 17 places in 176 ms
[2020-05-16 01:25:46] [INFO ] Deduced a trap composed of 15 places in 198 ms
[2020-05-16 01:25:46] [INFO ] Deduced a trap composed of 22 places in 96 ms
[2020-05-16 01:25:46] [INFO ] Deduced a trap composed of 17 places in 202 ms
[2020-05-16 01:25:46] [INFO ] Deduced a trap composed of 24 places in 204 ms
[2020-05-16 01:25:46] [INFO ] Deduced a trap composed of 25 places in 136 ms
[2020-05-16 01:25:46] [INFO ] Deduced a trap composed of 47 places in 84 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 22 places in 103 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 25 places in 110 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 40 places in 88 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 23 places in 163 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 31 places in 86 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 25 places in 87 ms
[2020-05-16 01:25:47] [INFO ] Deduced a trap composed of 30 places in 109 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 17 places in 143 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 24 places in 150 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 23 places in 155 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 19 places in 102 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 8 places in 96 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 13 places in 99 ms
[2020-05-16 01:25:48] [INFO ] Deduced a trap composed of 31 places in 108 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 34 places in 142 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 35 places in 113 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 38 places in 86 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 17 places in 159 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 27 places in 181 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 24 places in 120 ms
[2020-05-16 01:25:49] [INFO ] Deduced a trap composed of 22 places in 94 ms
[2020-05-16 01:25:50] [INFO ] Deduced a trap composed of 20 places in 228 ms
[2020-05-16 01:25:50] [INFO ] Deduced a trap composed of 31 places in 70 ms
[2020-05-16 01:25:50] [INFO ] Deduced a trap composed of 28 places in 116 ms
[2020-05-16 01:25:50] [INFO ] Deduced a trap composed of 9 places in 108 ms
[2020-05-16 01:25:50] [INFO ] Deduced a trap composed of 30 places in 176 ms
[2020-05-16 01:25:50] [INFO ] Deduced a trap composed of 34 places in 138 ms
[2020-05-16 01:25:51] [INFO ] Deduced a trap composed of 35 places in 85 ms
[2020-05-16 01:25:51] [INFO ] Deduced a trap composed of 22 places in 171 ms
[2020-05-16 01:25:51] [INFO ] Deduced a trap composed of 22 places in 169 ms
[2020-05-16 01:25:51] [INFO ] Deduced a trap composed of 34 places in 102 ms
[2020-05-16 01:25:51] [INFO ] Deduced a trap composed of 32 places in 89 ms
[2020-05-16 01:25:51] [INFO ] Deduced a trap composed of 26 places in 203 ms
[2020-05-16 01:25:52] [INFO ] Deduced a trap composed of 28 places in 145 ms
[2020-05-16 01:25:52] [INFO ] Deduced a trap composed of 18 places in 74 ms
[2020-05-16 01:25:52] [INFO ] Deduced a trap composed of 31 places in 132 ms
[2020-05-16 01:25:53] [INFO ] Deduced a trap composed of 27 places in 1010 ms
[2020-05-16 01:25:53] [INFO ] Deduced a trap composed of 30 places in 178 ms
[2020-05-16 01:25:53] [INFO ] Deduced a trap composed of 17 places in 182 ms
[2020-05-16 01:25:54] [INFO ] Deduced a trap composed of 26 places in 391 ms
[2020-05-16 01:25:54] [INFO ] Deduced a trap composed of 22 places in 284 ms
[2020-05-16 01:25:55] [INFO ] Deduced a trap composed of 17 places in 926 ms
[2020-05-16 01:25:57] [INFO ] Deduced a trap composed of 32 places in 1844 ms
[2020-05-16 01:25:57] [INFO ] Deduced a trap composed of 28 places in 116 ms
[2020-05-16 01:25:57] [INFO ] Deduced a trap composed of 32 places in 192 ms
[2020-05-16 01:25:57] [INFO ] Deduced a trap composed of 33 places in 162 ms
[2020-05-16 01:25:58] [INFO ] Deduced a trap composed of 18 places in 404 ms
[2020-05-16 01:25:58] [INFO ] Deduced a trap composed of 18 places in 114 ms
[2020-05-16 01:25:58] [INFO ] Deduced a trap composed of 30 places in 97 ms
[2020-05-16 01:25:58] [INFO ] Deduced a trap composed of 31 places in 113 ms
[2020-05-16 01:25:58] [INFO ] Deduced a trap composed of 24 places in 82 ms
[2020-05-16 01:25:58] [INFO ] Deduced a trap composed of 32 places in 101 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 18 places in 87 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 45 places in 106 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 31 places in 76 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 27 places in 77 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 30 places in 161 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 29 places in 114 ms
[2020-05-16 01:25:59] [INFO ] Deduced a trap composed of 36 places in 137 ms
[2020-05-16 01:26:00] [INFO ] Deduced a trap composed of 26 places in 674 ms
[2020-05-16 01:26:00] [INFO ] Deduced a trap composed of 32 places in 86 ms
[2020-05-16 01:26:00] [INFO ] Deduced a trap composed of 28 places in 175 ms
[2020-05-16 01:26:01] [INFO ] Deduced a trap composed of 36 places in 282 ms
[2020-05-16 01:26:02] [INFO ] Deduced a trap composed of 43 places in 1708 ms
[2020-05-16 01:26:03] [INFO ] Deduced a trap composed of 36 places in 155 ms
[2020-05-16 01:26:03] [INFO ] Deduced a trap composed of 37 places in 238 ms
[2020-05-16 01:26:03] [INFO ] Deduced a trap composed of 35 places in 101 ms
[2020-05-16 01:26:03] [INFO ] Deduced a trap composed of 31 places in 186 ms
[2020-05-16 01:26:03] [INFO ] Deduced a trap composed of 32 places in 233 ms
[2020-05-16 01:26:04] [INFO ] Deduced a trap composed of 35 places in 510 ms
[2020-05-16 01:26:05] [INFO ] Deduced a trap composed of 46 places in 1042 ms
[2020-05-16 01:26:08] [INFO ] Deduced a trap composed of 25 places in 2873 ms
[2020-05-16 01:26:09] [INFO ] Deduced a trap composed of 20 places in 632 ms
[2020-05-16 01:26:09] [INFO ] Deduced a trap composed of 31 places in 87 ms
[2020-05-16 01:26:09] [INFO ] Deduced a trap composed of 29 places in 239 ms
[2020-05-16 01:26:11] [INFO ] Deduced a trap composed of 27 places in 2042 ms
[2020-05-16 01:26:11] [INFO ] Deduced a trap composed of 10 places in 84 ms
[2020-05-16 01:26:12] [INFO ] Deduced a trap composed of 42 places in 456 ms
[2020-05-16 01:26:12] [INFO ] Deduced a trap composed of 43 places in 107 ms
[2020-05-16 01:26:12] [INFO ] Deduced a trap composed of 35 places in 86 ms
[2020-05-16 01:26:12] [INFO ] Deduced a trap composed of 22 places in 115 ms
[2020-05-16 01:26:12] [INFO ] Deduced a trap composed of 34 places in 161 ms
[2020-05-16 01:26:12] [INFO ] Deduced a trap composed of 33 places in 198 ms
[2020-05-16 01:26:13] [INFO ] Deduced a trap composed of 28 places in 176 ms
[2020-05-16 01:26:13] [INFO ] Deduced a trap composed of 36 places in 155 ms
[2020-05-16 01:26:13] [INFO ] Deduced a trap composed of 27 places in 82 ms
[2020-05-16 01:26:14] [INFO ] Deduced a trap composed of 25 places in 570 ms
[2020-05-16 01:26:14] [INFO ] Deduced a trap composed of 38 places in 419 ms
[2020-05-16 01:26:14] [INFO ] Deduced a trap composed of 9 places in 177 ms
[2020-05-16 01:26:14] [INFO ] Deduced a trap composed of 27 places in 175 ms
[2020-05-16 01:26:15] [INFO ] Deduced a trap composed of 29 places in 152 ms
[2020-05-16 01:26:17] [INFO ] Deduced a trap composed of 30 places in 2395 ms
[2020-05-16 01:26:17] [INFO ] Deduced a trap composed of 30 places in 187 ms
[2020-05-16 01:26:17] [INFO ] Deduced a trap composed of 35 places in 97 ms
[2020-05-16 01:26:17] [INFO ] Deduced a trap composed of 36 places in 68 ms
[2020-05-16 01:26:18] [INFO ] Deduced a trap composed of 31 places in 145 ms
[2020-05-16 01:26:18] [INFO ] Deduced a trap composed of 29 places in 167 ms
[2020-05-16 01:26:18] [INFO ] Deduced a trap composed of 23 places in 175 ms
[2020-05-16 01:26:19] [INFO ] Deduced a trap composed of 38 places in 1188 ms
[2020-05-16 01:26:19] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream closed (> (+ s5 s9 s11 s12 s13 s14 s17 s18 s19 s20 s21 s23 s24 s37 s38 s48 s51 s56 s57 s59 s64 s65 s78 s81 s86 s89 s94 s95 s97 s136 s140 s160 s212 s239 s243 s247 s249 s257) 0)") while checking expression at index 0
Support contains 64 out of 266 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 266/266 places, 584/584 transitions.
Performed 8 Post agglomeration using F-continuation condition.Transition count delta: 8
Deduced a syphon composed of 8 places in 1 ms
Reduce places removed 8 places and 0 transitions.
Iterating global reduction 0 with 16 rules applied. Total rules applied 16 place count 258 transition count 576
Applied a total of 16 rules in 30 ms. Remains 258 /266 variables (removed 8) and now considering 576/584 (removed 8) transitions.
Finished structural reductions, in 1 iterations. Remains : 258/266 places, 576/584 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 2241 ms. (steps per millisecond=446 ) properties seen :[0]
Incomplete Best-First random walk after 1000001 steps, including 0 resets, run finished after 2646 ms. (steps per millisecond=377 ) properties seen :[0]
Interrupted probabilistic random walk after 14711015 steps, run timeout after 30001 ms. (steps per millisecond=490 ) properties seen :[0]
Probabilistic random walk after 14711015 steps, saw 1848110 distinct states, run finished after 30001 ms. (steps per millisecond=490 ) properties seen :[0]
[2020-05-16 01:26:54] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 258 cols
[2020-05-16 01:26:54] [INFO ] Computed 82 place invariants in 2 ms
[2020-05-16 01:26:54] [INFO ] [Real]Absence check using 82 positive place invariants in 27 ms returned sat
[2020-05-16 01:26:54] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:26:54] [INFO ] [Real]Absence check using state equation in 214 ms returned sat
[2020-05-16 01:26:55] [INFO ] State equation strengthened by 128 read => feed constraints.
[2020-05-16 01:26:55] [INFO ] [Real]Added 128 Read/Feed constraints in 22 ms returned sat
[2020-05-16 01:26:55] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:26:55] [INFO ] [Nat]Absence check using 82 positive place invariants in 28 ms returned sat
[2020-05-16 01:26:55] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:26:55] [INFO ] [Nat]Absence check using state equation in 203 ms returned sat
[2020-05-16 01:26:55] [INFO ] [Nat]Added 128 Read/Feed constraints in 18 ms returned sat
[2020-05-16 01:26:55] [INFO ] Deduced a trap composed of 30 places in 104 ms
[2020-05-16 01:26:55] [INFO ] Deduced a trap composed of 27 places in 116 ms
[2020-05-16 01:26:55] [INFO ] Deduced a trap composed of 8 places in 79 ms
[2020-05-16 01:26:55] [INFO ] Deduced a trap composed of 19 places in 80 ms
[2020-05-16 01:26:55] [INFO ] Deduced a trap composed of 30 places in 80 ms
[2020-05-16 01:26:55] [INFO ] Deduced a trap composed of 21 places in 78 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 7 places in 28 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 7 places in 82 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 8 places in 82 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 38 places in 79 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 25 places in 73 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 30 places in 77 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 28 places in 78 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 28 places in 78 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 29 places in 90 ms
[2020-05-16 01:26:56] [INFO ] Deduced a trap composed of 37 places in 97 ms
[2020-05-16 01:26:57] [INFO ] Deduced a trap composed of 24 places in 206 ms
[2020-05-16 01:26:57] [INFO ] Deduced a trap composed of 35 places in 221 ms
[2020-05-16 01:26:57] [INFO ] Deduced a trap composed of 22 places in 353 ms
[2020-05-16 01:26:57] [INFO ] Deduced a trap composed of 29 places in 212 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 21 places in 143 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 19 places in 104 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 24 places in 101 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 22 places in 98 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 37 places in 103 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 27 places in 99 ms
[2020-05-16 01:26:58] [INFO ] Deduced a trap composed of 24 places in 119 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 28 places in 131 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 26 places in 93 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 19 places in 87 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 36 places in 91 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 28 places in 84 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 33 places in 97 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 28 places in 166 ms
[2020-05-16 01:26:59] [INFO ] Deduced a trap composed of 29 places in 107 ms
[2020-05-16 01:27:00] [INFO ] Deduced a trap composed of 31 places in 144 ms
[2020-05-16 01:27:00] [INFO ] Deduced a trap composed of 25 places in 79 ms
[2020-05-16 01:27:00] [INFO ] Deduced a trap composed of 33 places in 156 ms
[2020-05-16 01:27:00] [INFO ] Deduced a trap composed of 22 places in 121 ms
[2020-05-16 01:27:00] [INFO ] Deduced a trap composed of 8 places in 146 ms
[2020-05-16 01:27:00] [INFO ] Deduced a trap composed of 29 places in 175 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 35 places in 140 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 39 places in 79 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 39 places in 153 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 31 places in 88 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 20 places in 60 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 42 places in 71 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 9 places in 66 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 34 places in 84 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 22 places in 88 ms
[2020-05-16 01:27:01] [INFO ] Deduced a trap composed of 22 places in 80 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 36 places in 216 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 38 places in 85 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 33 places in 86 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 23 places in 89 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 27 places in 85 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 8 places in 64 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 43 places in 67 ms
[2020-05-16 01:27:02] [INFO ] Deduced a trap composed of 34 places in 75 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 21 places in 67 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 38 places in 66 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 21 places in 77 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 33 places in 71 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 19 places in 74 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 34 places in 103 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 22 places in 72 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 26 places in 94 ms
[2020-05-16 01:27:03] [INFO ] Deduced a trap composed of 37 places in 81 ms
[2020-05-16 01:27:04] [INFO ] Deduced a trap composed of 31 places in 464 ms
[2020-05-16 01:27:04] [INFO ] Deduced a trap composed of 27 places in 73 ms
[2020-05-16 01:27:04] [INFO ] Deduced a trap composed of 21 places in 76 ms
[2020-05-16 01:27:04] [INFO ] Deduced a trap composed of 26 places in 57 ms
[2020-05-16 01:27:04] [INFO ] Deduced a trap composed of 21 places in 90 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 28 places in 82 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 18 places in 73 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 34 places in 81 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 24 places in 59 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 25 places in 67 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 27 places in 91 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 22 places in 95 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 32 places in 105 ms
[2020-05-16 01:27:05] [INFO ] Deduced a trap composed of 17 places in 85 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 28 places in 148 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 25 places in 73 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 37 places in 101 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 17 places in 78 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 34 places in 145 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 35 places in 87 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 32 places in 85 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 24 places in 90 ms
[2020-05-16 01:27:06] [INFO ] Deduced a trap composed of 32 places in 90 ms
[2020-05-16 01:27:07] [INFO ] Deduced a trap composed of 8 places in 71 ms
[2020-05-16 01:27:07] [INFO ] Deduced a trap composed of 23 places in 105 ms
[2020-05-16 01:27:07] [INFO ] Deduced a trap composed of 39 places in 77 ms
[2020-05-16 01:27:07] [INFO ] Deduced a trap composed of 37 places in 130 ms
[2020-05-16 01:27:07] [INFO ] Deduced a trap composed of 30 places in 143 ms
[2020-05-16 01:27:07] [INFO ] Deduced a trap composed of 37 places in 127 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 22 places in 175 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 46 places in 159 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 22 places in 131 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 25 places in 89 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 31 places in 86 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 23 places in 74 ms
[2020-05-16 01:27:08] [INFO ] Deduced a trap composed of 30 places in 161 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 31 places in 156 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 31 places in 110 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 30 places in 106 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 39 places in 83 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 31 places in 80 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 17 places in 77 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 36 places in 155 ms
[2020-05-16 01:27:09] [INFO ] Deduced a trap composed of 21 places in 80 ms
[2020-05-16 01:27:10] [INFO ] Deduced a trap composed of 29 places in 66 ms
[2020-05-16 01:27:10] [INFO ] Deduced a trap composed of 33 places in 139 ms
[2020-05-16 01:27:10] [INFO ] Deduced a trap composed of 21 places in 96 ms
[2020-05-16 01:27:10] [INFO ] Deduced a trap composed of 21 places in 277 ms
[2020-05-16 01:27:10] [INFO ] Deduced a trap composed of 22 places in 216 ms
[2020-05-16 01:27:10] [INFO ] Deduced a trap composed of 31 places in 88 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 25 places in 74 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 22 places in 77 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 27 places in 183 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 39 places in 103 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 24 places in 76 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 25 places in 149 ms
[2020-05-16 01:27:11] [INFO ] Deduced a trap composed of 36 places in 101 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 17 places in 81 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 29 places in 77 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 23 places in 67 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 28 places in 116 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 27 places in 80 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 36 places in 104 ms
[2020-05-16 01:27:12] [INFO ] Deduced a trap composed of 24 places in 193 ms
[2020-05-16 01:27:13] [INFO ] Deduced a trap composed of 22 places in 137 ms
[2020-05-16 01:27:13] [INFO ] Deduced a trap composed of 26 places in 607 ms
[2020-05-16 01:27:13] [INFO ] Deduced a trap composed of 28 places in 182 ms
[2020-05-16 01:27:14] [INFO ] Deduced a trap composed of 33 places in 119 ms
[2020-05-16 01:27:14] [INFO ] Deduced a trap composed of 35 places in 307 ms
[2020-05-16 01:27:14] [INFO ] Deduced a trap composed of 27 places in 100 ms
[2020-05-16 01:27:14] [INFO ] Deduced a trap composed of 18 places in 325 ms
[2020-05-16 01:27:15] [INFO ] Deduced a trap composed of 18 places in 164 ms
[2020-05-16 01:27:15] [INFO ] Deduced a trap composed of 21 places in 379 ms
[2020-05-16 01:27:16] [INFO ] Deduced a trap composed of 22 places in 409 ms
[2020-05-16 01:27:16] [INFO ] Deduced a trap composed of 22 places in 359 ms
[2020-05-16 01:27:16] [INFO ] Deduced a trap composed of 35 places in 180 ms
[2020-05-16 01:27:17] [INFO ] Deduced a trap composed of 21 places in 977 ms
[2020-05-16 01:27:19] [INFO ] Deduced a trap composed of 34 places in 1393 ms
[2020-05-16 01:27:19] [INFO ] Deduced a trap composed of 38 places in 878 ms
[2020-05-16 01:27:20] [INFO ] Deduced a trap composed of 16 places in 206 ms
[2020-05-16 01:27:20] [INFO ] Deduced a trap composed of 33 places in 228 ms
[2020-05-16 01:27:20] [INFO ] Deduced a trap composed of 30 places in 158 ms
[2020-05-16 01:27:20] [INFO ] Deduced a trap composed of 20 places in 94 ms
[2020-05-16 01:27:20] [INFO ] Deduced a trap composed of 35 places in 99 ms
[2020-05-16 01:27:21] [INFO ] Deduced a trap composed of 24 places in 81 ms
[2020-05-16 01:27:21] [INFO ] Deduced a trap composed of 22 places in 944 ms
[2020-05-16 01:27:22] [INFO ] Deduced a trap composed of 23 places in 144 ms
[2020-05-16 01:27:22] [INFO ] Deduced a trap composed of 36 places in 293 ms
[2020-05-16 01:27:22] [INFO ] Deduced a trap composed of 23 places in 244 ms
[2020-05-16 01:27:24] [INFO ] Deduced a trap composed of 25 places in 1863 ms
[2020-05-16 01:27:24] [INFO ] Deduced a trap composed of 32 places in 64 ms
[2020-05-16 01:27:24] [INFO ] Deduced a trap composed of 40 places in 68 ms
[2020-05-16 01:27:24] [INFO ] Deduced a trap composed of 43 places in 67 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 22 places in 80 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 23 places in 83 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 36 places in 108 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 9 places in 84 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 31 places in 111 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 31 places in 110 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 26 places in 111 ms
[2020-05-16 01:27:25] [INFO ] Deduced a trap composed of 38 places in 95 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 24 places in 78 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 9 places in 101 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 16 places in 67 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 35 places in 77 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 30 places in 103 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 19 places in 88 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 25 places in 162 ms
[2020-05-16 01:27:26] [INFO ] Deduced a trap composed of 30 places in 91 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 24 places in 135 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 20 places in 77 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 29 places in 133 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 31 places in 91 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 27 places in 70 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 40 places in 91 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 23 places in 83 ms
[2020-05-16 01:27:27] [INFO ] Deduced a trap composed of 29 places in 128 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 28 places in 125 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 24 places in 121 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 26 places in 119 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 9 places in 75 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 33 places in 75 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 28 places in 83 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 31 places in 86 ms
[2020-05-16 01:27:28] [INFO ] Deduced a trap composed of 31 places in 119 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 24 places in 169 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 19 places in 85 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 26 places in 137 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 17 places in 131 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 9 places in 85 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 32 places in 80 ms
[2020-05-16 01:27:29] [INFO ] Deduced a trap composed of 25 places in 131 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 31 places in 138 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 24 places in 168 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 28 places in 138 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 25 places in 93 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 22 places in 88 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 19 places in 94 ms
[2020-05-16 01:27:30] [INFO ] Deduced a trap composed of 33 places in 77 ms
[2020-05-16 01:27:31] [INFO ] Deduced a trap composed of 28 places in 176 ms
[2020-05-16 01:27:31] [INFO ] Deduced a trap composed of 13 places in 194 ms
[2020-05-16 01:27:31] [INFO ] Deduced a trap composed of 37 places in 94 ms
[2020-05-16 01:27:31] [INFO ] Deduced a trap composed of 33 places in 120 ms
[2020-05-16 01:27:31] [INFO ] Deduced a trap composed of 9 places in 192 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 29 places in 151 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 19 places in 178 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 35 places in 152 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 27 places in 87 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 16 places in 93 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 30 places in 90 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 9 places in 94 ms
[2020-05-16 01:27:32] [INFO ] Deduced a trap composed of 19 places in 84 ms
[2020-05-16 01:27:33] [INFO ] Deduced a trap composed of 18 places in 126 ms
[2020-05-16 01:27:33] [INFO ] Deduced a trap composed of 18 places in 96 ms
[2020-05-16 01:27:33] [INFO ] Deduced a trap composed of 16 places in 179 ms
[2020-05-16 01:27:33] [INFO ] Deduced a trap composed of 20 places in 102 ms
[2020-05-16 01:27:33] [INFO ] Deduced a trap composed of 10 places in 204 ms
[2020-05-16 01:27:33] [INFO ] Deduced a trap composed of 37 places in 99 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 46 places in 80 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 31 places in 86 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 39 places in 128 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 29 places in 88 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 38 places in 109 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 22 places in 94 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 35 places in 132 ms
[2020-05-16 01:27:34] [INFO ] Deduced a trap composed of 36 places in 95 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 32 places in 102 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 25 places in 92 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 18 places in 92 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 37 places in 167 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 32 places in 88 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 22 places in 93 ms
[2020-05-16 01:27:35] [INFO ] Deduced a trap composed of 22 places in 91 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 39 places in 301 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 24 places in 79 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 25 places in 163 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 35 places in 103 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 30 places in 84 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 32 places in 82 ms
[2020-05-16 01:27:36] [INFO ] Deduced a trap composed of 42 places in 77 ms
[2020-05-16 01:27:37] [INFO ] Deduced a trap composed of 25 places in 81 ms
[2020-05-16 01:27:37] [INFO ] Deduced a trap composed of 17 places in 230 ms
[2020-05-16 01:27:37] [INFO ] Deduced a trap composed of 24 places in 91 ms
[2020-05-16 01:27:37] [INFO ] Deduced a trap composed of 22 places in 107 ms
[2020-05-16 01:27:37] [INFO ] Deduced a trap composed of 24 places in 99 ms
[2020-05-16 01:27:37] [INFO ] Deduced a trap composed of 39 places in 103 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 36 places in 74 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 35 places in 100 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 27 places in 104 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 38 places in 90 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 24 places in 92 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 7 places in 81 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 28 places in 73 ms
[2020-05-16 01:27:38] [INFO ] Deduced a trap composed of 18 places in 141 ms
[2020-05-16 01:27:39] [INFO ] Deduced a trap composed of 21 places in 163 ms
[2020-05-16 01:27:39] [INFO ] Deduced a trap composed of 16 places in 164 ms
[2020-05-16 01:27:39] [INFO ] Deduced a trap composed of 19 places in 98 ms
[2020-05-16 01:27:39] [INFO ] Deduced a trap composed of 28 places in 100 ms
[2020-05-16 01:27:39] [INFO ] Deduced a trap composed of 25 places in 102 ms
[2020-05-16 01:27:40] [INFO ] Deduced a trap composed of 16 places in 271 ms
[2020-05-16 01:27:40] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream closed (> (+ s17 s18 s19 s20 s21 s22 s23 s25 s28 s43 s51 s59 s80 s88 s139 s248) 0)") while checking expression at index 0
Support contains 64 out of 258 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 258/258 places, 576/576 transitions.
Applied a total of 0 rules in 16 ms. Remains 258 /258 variables (removed 0) and now considering 576/576 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 258/258 places, 576/576 transitions.
Starting structural reductions, iteration 0 : 258/258 places, 576/576 transitions.
Applied a total of 0 rules in 9 ms. Remains 258 /258 variables (removed 0) and now considering 576/576 (removed 0) transitions.
[2020-05-16 01:27:40] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 258 cols
[2020-05-16 01:27:40] [INFO ] Computed 82 place invariants in 2 ms
[2020-05-16 01:27:40] [INFO ] Implicit Places using invariants in 317 ms returned [154, 155, 156, 157, 158, 159, 160, 161]
Discarding 8 places :
Implicit Place search using SMT only with invariants took 320 ms to find 8 implicit places.
[2020-05-16 01:27:40] [INFO ] Redundant transitions in 25 ms returned []
[2020-05-16 01:27:40] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:27:40] [INFO ] Computed 74 place invariants in 2 ms
[2020-05-16 01:27:41] [INFO ] Dead Transitions using invariants and state equation in 541 ms returned []
Starting structural reductions, iteration 1 : 250/258 places, 576/576 transitions.
Applied a total of 0 rules in 24 ms. Remains 250 /250 variables (removed 0) and now considering 576/576 (removed 0) transitions.
[2020-05-16 01:27:41] [INFO ] Redundant transitions in 10 ms returned []
[2020-05-16 01:27:41] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:27:41] [INFO ] Computed 74 place invariants in 1 ms
[2020-05-16 01:27:41] [INFO ] Dead Transitions using invariants and state equation in 423 ms returned []
Finished structural reductions, in 2 iterations. Remains : 250/258 places, 576/576 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 2167 ms. (steps per millisecond=461 ) properties seen :[0]
Incomplete Best-First random walk after 1000001 steps, including 0 resets, run finished after 2658 ms. (steps per millisecond=376 ) properties seen :[0]
Interrupted probabilistic random walk after 14788682 steps, run timeout after 30001 ms. (steps per millisecond=492 ) properties seen :[0]
Probabilistic random walk after 14788682 steps, saw 1848455 distinct states, run finished after 30001 ms. (steps per millisecond=492 ) properties seen :[0]
[2020-05-16 01:28:16] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:28:16] [INFO ] Computed 74 place invariants in 2 ms
[2020-05-16 01:28:16] [INFO ] [Real]Absence check using 74 positive place invariants in 52 ms returned sat
[2020-05-16 01:28:16] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:28:17] [INFO ] [Real]Absence check using state equation in 749 ms returned sat
[2020-05-16 01:28:17] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:28:17] [INFO ] [Nat]Absence check using 74 positive place invariants in 47 ms returned sat
[2020-05-16 01:28:17] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:28:17] [INFO ] [Nat]Absence check using state equation in 432 ms returned sat
[2020-05-16 01:28:17] [INFO ] State equation strengthened by 64 read => feed constraints.
[2020-05-16 01:28:17] [INFO ] [Nat]Added 64 Read/Feed constraints in 18 ms returned sat
[2020-05-16 01:28:17] [INFO ] Deduced a trap composed of 27 places in 195 ms
[2020-05-16 01:28:18] [INFO ] Deduced a trap composed of 18 places in 439 ms
[2020-05-16 01:28:18] [INFO ] Deduced a trap composed of 8 places in 77 ms
[2020-05-16 01:28:18] [INFO ] Deduced a trap composed of 27 places in 83 ms
[2020-05-16 01:28:18] [INFO ] Deduced a trap composed of 28 places in 103 ms
[2020-05-16 01:28:18] [INFO ] Deduced a trap composed of 40 places in 105 ms
[2020-05-16 01:28:19] [INFO ] Deduced a trap composed of 8 places in 167 ms
[2020-05-16 01:28:19] [INFO ] Deduced a trap composed of 33 places in 82 ms
[2020-05-16 01:28:19] [INFO ] Deduced a trap composed of 25 places in 100 ms
[2020-05-16 01:28:19] [INFO ] Deduced a trap composed of 8 places in 511 ms
[2020-05-16 01:28:20] [INFO ] Deduced a trap composed of 42 places in 504 ms
[2020-05-16 01:28:20] [INFO ] Deduced a trap composed of 43 places in 386 ms
[2020-05-16 01:28:20] [INFO ] Deduced a trap composed of 24 places in 219 ms
[2020-05-16 01:28:21] [INFO ] Deduced a trap composed of 33 places in 299 ms
[2020-05-16 01:28:21] [INFO ] Deduced a trap composed of 37 places in 175 ms
[2020-05-16 01:28:21] [INFO ] Deduced a trap composed of 39 places in 173 ms
[2020-05-16 01:28:21] [INFO ] Deduced a trap composed of 28 places in 175 ms
[2020-05-16 01:28:22] [INFO ] Deduced a trap composed of 24 places in 248 ms
[2020-05-16 01:28:22] [INFO ] Deduced a trap composed of 28 places in 84 ms
[2020-05-16 01:28:22] [INFO ] Deduced a trap composed of 27 places in 273 ms
[2020-05-16 01:28:22] [INFO ] Deduced a trap composed of 39 places in 207 ms
[2020-05-16 01:28:22] [INFO ] Deduced a trap composed of 33 places in 158 ms
[2020-05-16 01:28:23] [INFO ] Deduced a trap composed of 24 places in 184 ms
[2020-05-16 01:28:23] [INFO ] Deduced a trap composed of 40 places in 648 ms
[2020-05-16 01:28:24] [INFO ] Deduced a trap composed of 8 places in 442 ms
[2020-05-16 01:28:24] [INFO ] Deduced a trap composed of 29 places in 186 ms
[2020-05-16 01:28:24] [INFO ] Deduced a trap composed of 40 places in 235 ms
[2020-05-16 01:28:24] [INFO ] Deduced a trap composed of 24 places in 180 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 40 places in 166 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 8 places in 97 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 42 places in 98 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 32 places in 100 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 32 places in 99 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 29 places in 94 ms
[2020-05-16 01:28:25] [INFO ] Deduced a trap composed of 26 places in 97 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 38 places in 161 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 24 places in 161 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 38 places in 99 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 18 places in 89 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 23 places in 91 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 31 places in 166 ms
[2020-05-16 01:28:26] [INFO ] Deduced a trap composed of 31 places in 170 ms
[2020-05-16 01:28:27] [INFO ] Deduced a trap composed of 32 places in 702 ms
[2020-05-16 01:28:28] [INFO ] Deduced a trap composed of 8 places in 487 ms
[2020-05-16 01:28:28] [INFO ] Deduced a trap composed of 12 places in 144 ms
[2020-05-16 01:28:28] [INFO ] Deduced a trap composed of 27 places in 261 ms
[2020-05-16 01:28:28] [INFO ] Deduced a trap composed of 19 places in 80 ms
[2020-05-16 01:28:28] [INFO ] Deduced a trap composed of 39 places in 80 ms
[2020-05-16 01:28:29] [INFO ] Deduced a trap composed of 26 places in 264 ms
[2020-05-16 01:28:29] [INFO ] Deduced a trap composed of 17 places in 166 ms
[2020-05-16 01:28:29] [INFO ] Deduced a trap composed of 27 places in 355 ms
[2020-05-16 01:28:29] [INFO ] Deduced a trap composed of 22 places in 78 ms
[2020-05-16 01:28:29] [INFO ] Deduced a trap composed of 37 places in 74 ms
[2020-05-16 01:28:29] [INFO ] Deduced a trap composed of 39 places in 59 ms
[2020-05-16 01:28:30] [INFO ] Deduced a trap composed of 34 places in 538 ms
[2020-05-16 01:28:30] [INFO ] Deduced a trap composed of 22 places in 189 ms
[2020-05-16 01:28:31] [INFO ] Deduced a trap composed of 22 places in 356 ms
[2020-05-16 01:28:31] [INFO ] Deduced a trap composed of 37 places in 167 ms
[2020-05-16 01:28:31] [INFO ] Deduced a trap composed of 27 places in 259 ms
[2020-05-16 01:28:32] [INFO ] Deduced a trap composed of 36 places in 515 ms
[2020-05-16 01:28:32] [INFO ] Deduced a trap composed of 30 places in 86 ms
[2020-05-16 01:28:32] [INFO ] Deduced a trap composed of 25 places in 234 ms
[2020-05-16 01:28:32] [INFO ] Deduced a trap composed of 39 places in 333 ms
[2020-05-16 01:28:35] [INFO ] Deduced a trap composed of 38 places in 2519 ms
[2020-05-16 01:28:38] [INFO ] Deduced a trap composed of 36 places in 2595 ms
[2020-05-16 01:28:38] [INFO ] Deduced a trap composed of 39 places in 194 ms
[2020-05-16 01:28:38] [INFO ] Deduced a trap composed of 30 places in 409 ms
[2020-05-16 01:28:38] [INFO ] Deduced a trap composed of 33 places in 92 ms
[2020-05-16 01:28:38] [INFO ] Deduced a trap composed of 36 places in 115 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 24 places in 102 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 32 places in 85 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 8 places in 138 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 40 places in 94 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 28 places in 68 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 18 places in 91 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 13 places in 162 ms
[2020-05-16 01:28:39] [INFO ] Deduced a trap composed of 20 places in 118 ms
[2020-05-16 01:28:40] [INFO ] Deduced a trap composed of 25 places in 145 ms
[2020-05-16 01:28:40] [INFO ] Deduced a trap composed of 19 places in 173 ms
[2020-05-16 01:28:40] [INFO ] Deduced a trap composed of 31 places in 90 ms
[2020-05-16 01:28:40] [INFO ] Deduced a trap composed of 33 places in 210 ms
[2020-05-16 01:28:40] [INFO ] Deduced a trap composed of 10 places in 106 ms
[2020-05-16 01:28:40] [INFO ] Deduced a trap composed of 9 places in 110 ms
[2020-05-16 01:28:41] [INFO ] Deduced a trap composed of 30 places in 184 ms
[2020-05-16 01:28:41] [INFO ] Deduced a trap composed of 27 places in 107 ms
[2020-05-16 01:28:41] [INFO ] Deduced a trap composed of 32 places in 147 ms
[2020-05-16 01:28:41] [INFO ] Deduced a trap composed of 23 places in 175 ms
[2020-05-16 01:28:41] [INFO ] Deduced a trap composed of 26 places in 66 ms
[2020-05-16 01:28:41] [INFO ] Deduced a trap composed of 22 places in 122 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 32 places in 203 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 16 places in 98 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 22 places in 65 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 27 places in 160 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 21 places in 144 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 17 places in 64 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 19 places in 85 ms
[2020-05-16 01:28:42] [INFO ] Deduced a trap composed of 24 places in 83 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 25 places in 125 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 18 places in 187 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 36 places in 92 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 21 places in 102 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 26 places in 79 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 27 places in 125 ms
[2020-05-16 01:28:43] [INFO ] Deduced a trap composed of 21 places in 113 ms
[2020-05-16 01:28:44] [INFO ] Deduced a trap composed of 28 places in 249 ms
[2020-05-16 01:28:44] [INFO ] Deduced a trap composed of 42 places in 70 ms
[2020-05-16 01:28:44] [INFO ] Deduced a trap composed of 22 places in 105 ms
[2020-05-16 01:28:44] [INFO ] Deduced a trap composed of 17 places in 68 ms
[2020-05-16 01:28:44] [INFO ] Deduced a trap composed of 36 places in 116 ms
[2020-05-16 01:28:44] [INFO ] Deduced a trap composed of 25 places in 106 ms
[2020-05-16 01:28:45] [INFO ] Deduced a trap composed of 28 places in 332 ms
[2020-05-16 01:28:45] [INFO ] Deduced a trap composed of 30 places in 127 ms
[2020-05-16 01:28:45] [INFO ] Deduced a trap composed of 23 places in 75 ms
[2020-05-16 01:28:45] [INFO ] Deduced a trap composed of 18 places in 135 ms
[2020-05-16 01:28:45] [INFO ] Deduced a trap composed of 22 places in 126 ms
[2020-05-16 01:28:45] [INFO ] Deduced a trap composed of 18 places in 94 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 22 places in 120 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 34 places in 84 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 19 places in 115 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 34 places in 153 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 21 places in 142 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 27 places in 100 ms
[2020-05-16 01:28:46] [INFO ] Deduced a trap composed of 28 places in 86 ms
[2020-05-16 01:28:47] [INFO ] Deduced a trap composed of 35 places in 149 ms
[2020-05-16 01:28:47] [INFO ] Deduced a trap composed of 17 places in 228 ms
[2020-05-16 01:28:47] [INFO ] Deduced a trap composed of 17 places in 121 ms
[2020-05-16 01:28:47] [INFO ] Deduced a trap composed of 25 places in 78 ms
[2020-05-16 01:28:47] [INFO ] Deduced a trap composed of 17 places in 85 ms
[2020-05-16 01:28:47] [INFO ] Deduced a trap composed of 17 places in 159 ms
[2020-05-16 01:28:48] [INFO ] Deduced a trap composed of 25 places in 120 ms
[2020-05-16 01:28:48] [INFO ] Deduced a trap composed of 31 places in 472 ms
[2020-05-16 01:28:48] [INFO ] Deduced a trap composed of 31 places in 72 ms
[2020-05-16 01:28:48] [INFO ] Deduced a trap composed of 31 places in 131 ms
[2020-05-16 01:28:48] [INFO ] Deduced a trap composed of 27 places in 58 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 30 places in 201 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 22 places in 142 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 9 places in 100 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 17 places in 70 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 11 places in 126 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 25 places in 81 ms
[2020-05-16 01:28:49] [INFO ] Deduced a trap composed of 26 places in 142 ms
[2020-05-16 01:28:50] [INFO ] Deduced a trap composed of 25 places in 143 ms
[2020-05-16 01:28:50] [INFO ] Deduced a trap composed of 33 places in 158 ms
[2020-05-16 01:28:50] [INFO ] Deduced a trap composed of 24 places in 195 ms
[2020-05-16 01:28:50] [INFO ] Deduced a trap composed of 28 places in 135 ms
[2020-05-16 01:28:50] [INFO ] Deduced a trap composed of 22 places in 152 ms
[2020-05-16 01:28:50] [INFO ] Deduced a trap composed of 13 places in 85 ms
[2020-05-16 01:28:51] [INFO ] Deduced a trap composed of 24 places in 151 ms
[2020-05-16 01:28:51] [INFO ] Deduced a trap composed of 27 places in 130 ms
[2020-05-16 01:28:51] [INFO ] Deduced a trap composed of 23 places in 95 ms
[2020-05-16 01:28:51] [INFO ] Deduced a trap composed of 8 places in 378 ms
[2020-05-16 01:28:51] [INFO ] Deduced a trap composed of 37 places in 83 ms
[2020-05-16 01:28:52] [INFO ] Deduced a trap composed of 35 places in 867 ms
[2020-05-16 01:28:52] [INFO ] Deduced a trap composed of 26 places in 139 ms
[2020-05-16 01:28:53] [INFO ] Deduced a trap composed of 19 places in 332 ms
[2020-05-16 01:28:53] [INFO ] Deduced a trap composed of 21 places in 325 ms
[2020-05-16 01:28:53] [INFO ] Deduced a trap composed of 28 places in 205 ms
[2020-05-16 01:28:54] [INFO ] Deduced a trap composed of 33 places in 89 ms
[2020-05-16 01:28:54] [INFO ] Deduced a trap composed of 28 places in 86 ms
[2020-05-16 01:28:54] [INFO ] Deduced a trap composed of 23 places in 204 ms
[2020-05-16 01:28:54] [INFO ] Deduced a trap composed of 34 places in 114 ms
[2020-05-16 01:28:54] [INFO ] Deduced a trap composed of 27 places in 181 ms
[2020-05-16 01:28:54] [INFO ] Deduced a trap composed of 28 places in 247 ms
[2020-05-16 01:28:55] [INFO ] Deduced a trap composed of 17 places in 752 ms
[2020-05-16 01:28:55] [INFO ] Deduced a trap composed of 24 places in 171 ms
[2020-05-16 01:28:56] [INFO ] Deduced a trap composed of 19 places in 372 ms
[2020-05-16 01:28:56] [INFO ] Deduced a trap composed of 17 places in 212 ms
[2020-05-16 01:28:56] [INFO ] Deduced a trap composed of 17 places in 78 ms
[2020-05-16 01:28:56] [INFO ] Deduced a trap composed of 34 places in 79 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 23 places in 278 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 30 places in 96 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 19 places in 91 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 21 places in 101 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 22 places in 97 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 26 places in 84 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 27 places in 78 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 29 places in 79 ms
[2020-05-16 01:28:57] [INFO ] Deduced a trap composed of 32 places in 83 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 24 places in 82 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 9 places in 86 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 27 places in 86 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 22 places in 90 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 30 places in 92 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 30 places in 105 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 28 places in 81 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 20 places in 97 ms
[2020-05-16 01:28:58] [INFO ] Deduced a trap composed of 29 places in 87 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 18 places in 88 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 32 places in 89 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 34 places in 90 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 23 places in 87 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 31 places in 86 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 16 places in 101 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 32 places in 87 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 31 places in 82 ms
[2020-05-16 01:28:59] [INFO ] Deduced a trap composed of 34 places in 83 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 19 places in 82 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 34 places in 80 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 18 places in 84 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 31 places in 88 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 37 places in 88 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 34 places in 83 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 37 places in 84 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 24 places in 86 ms
[2020-05-16 01:29:00] [INFO ] Deduced a trap composed of 31 places in 88 ms
[2020-05-16 01:29:01] [INFO ] Deduced a trap composed of 30 places in 89 ms
[2020-05-16 01:29:01] [INFO ] Deduced a trap composed of 22 places in 89 ms
[2020-05-16 01:29:01] [INFO ] Deduced a trap composed of 21 places in 88 ms
[2020-05-16 01:29:01] [INFO ] Deduced a trap composed of 35 places in 107 ms
[2020-05-16 01:29:01] [INFO ] Deduced a trap composed of 40 places in 541 ms
[2020-05-16 01:29:02] [INFO ] Deduced a trap composed of 30 places in 77 ms
[2020-05-16 01:29:02] [INFO ] Deduced a trap composed of 22 places in 69 ms
[2020-05-16 01:29:02] [INFO ] Deduced a trap composed of 29 places in 92 ms
[2020-05-16 01:29:02] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream closed (> (+ s9 s10 s12 s15 s16 s17 s18 s19 s20 s22 s24 s25 s32 s45 s52 s54 s55 s60 s62 s63 s77 s79 s85 s87 s133 s228 s230 s231 s239) 0)") while checking expression at index 0
Support contains 64 out of 250 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 250/250 places, 576/576 transitions.
Applied a total of 0 rules in 9 ms. Remains 250 /250 variables (removed 0) and now considering 576/576 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 250/250 places, 576/576 transitions.
Starting structural reductions, iteration 0 : 250/250 places, 576/576 transitions.
Applied a total of 0 rules in 8 ms. Remains 250 /250 variables (removed 0) and now considering 576/576 (removed 0) transitions.
[2020-05-16 01:29:02] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:29:02] [INFO ] Computed 74 place invariants in 1 ms
[2020-05-16 01:29:02] [INFO ] Implicit Places using invariants in 468 ms returned []
[2020-05-16 01:29:02] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:29:02] [INFO ] Computed 74 place invariants in 2 ms
[2020-05-16 01:29:03] [INFO ] State equation strengthened by 64 read => feed constraints.
[2020-05-16 01:29:03] [INFO ] Implicit Places using invariants and state equation in 1048 ms returned []
Implicit Place search using SMT with State Equation took 1519 ms to find 0 implicit places.
[2020-05-16 01:29:03] [INFO ] Redundant transitions in 13 ms returned []
[2020-05-16 01:29:03] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:29:03] [INFO ] Computed 74 place invariants in 1 ms
[2020-05-16 01:29:04] [INFO ] Dead Transitions using invariants and state equation in 562 ms returned []
Finished structural reductions, in 1 iterations. Remains : 250/250 places, 576/576 transitions.
Incomplete random walk after 100000 steps, including 0 resets, run finished after 214 ms. (steps per millisecond=467 ) properties seen :[0]
[2020-05-16 01:29:04] [INFO ] Flow matrix only has 408 transitions (discarded 168 similar events)
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:29:04] [INFO ] Computed 74 place invariants in 1 ms
[2020-05-16 01:29:04] [INFO ] [Real]Absence check using 74 positive place invariants in 55 ms returned sat
[2020-05-16 01:29:04] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:29:05] [INFO ] [Real]Absence check using state equation in 352 ms returned sat
[2020-05-16 01:29:05] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:29:05] [INFO ] [Nat]Absence check using 74 positive place invariants in 62 ms returned sat
[2020-05-16 01:29:05] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:29:05] [INFO ] [Nat]Absence check using state equation in 509 ms returned sat
[2020-05-16 01:29:05] [INFO ] State equation strengthened by 64 read => feed constraints.
[2020-05-16 01:29:05] [INFO ] [Nat]Added 64 Read/Feed constraints in 22 ms returned sat
[2020-05-16 01:29:05] [INFO ] Deduced a trap composed of 27 places in 134 ms
[2020-05-16 01:29:06] [INFO ] Deduced a trap composed of 18 places in 96 ms
[2020-05-16 01:29:06] [INFO ] Deduced a trap composed of 8 places in 133 ms
[2020-05-16 01:29:06] [INFO ] Deduced a trap composed of 27 places in 378 ms
[2020-05-16 01:29:06] [INFO ] Deduced a trap composed of 28 places in 101 ms
[2020-05-16 01:29:07] [INFO ] Deduced a trap composed of 40 places in 451 ms
[2020-05-16 01:29:07] [INFO ] Deduced a trap composed of 8 places in 144 ms
[2020-05-16 01:29:07] [INFO ] Deduced a trap composed of 33 places in 86 ms
[2020-05-16 01:29:07] [INFO ] Deduced a trap composed of 25 places in 117 ms
[2020-05-16 01:29:08] [INFO ] Deduced a trap composed of 8 places in 628 ms
[2020-05-16 01:29:08] [INFO ] Deduced a trap composed of 42 places in 212 ms
[2020-05-16 01:29:08] [INFO ] Deduced a trap composed of 43 places in 258 ms
[2020-05-16 01:29:08] [INFO ] Deduced a trap composed of 24 places in 152 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 33 places in 110 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 37 places in 173 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 39 places in 146 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 28 places in 157 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 24 places in 150 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 28 places in 86 ms
[2020-05-16 01:29:09] [INFO ] Deduced a trap composed of 27 places in 91 ms
[2020-05-16 01:29:10] [INFO ] Deduced a trap composed of 39 places in 88 ms
[2020-05-16 01:29:10] [INFO ] Deduced a trap composed of 33 places in 100 ms
[2020-05-16 01:29:10] [INFO ] Deduced a trap composed of 24 places in 111 ms
[2020-05-16 01:29:10] [INFO ] Deduced a trap composed of 40 places in 73 ms
[2020-05-16 01:29:10] [INFO ] Deduced a trap composed of 8 places in 475 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 29 places in 153 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 40 places in 76 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 24 places in 160 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 40 places in 82 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 8 places in 136 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 42 places in 176 ms
[2020-05-16 01:29:11] [INFO ] Deduced a trap composed of 32 places in 97 ms
[2020-05-16 01:29:12] [INFO ] Deduced a trap composed of 32 places in 134 ms
[2020-05-16 01:29:12] [INFO ] Deduced a trap composed of 29 places in 256 ms
[2020-05-16 01:29:12] [INFO ] Deduced a trap composed of 26 places in 105 ms
[2020-05-16 01:29:12] [INFO ] Deduced a trap composed of 38 places in 121 ms
[2020-05-16 01:29:12] [INFO ] Deduced a trap composed of 24 places in 137 ms
[2020-05-16 01:29:12] [INFO ] Deduced a trap composed of 38 places in 91 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 18 places in 168 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 23 places in 137 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 31 places in 128 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 31 places in 140 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 32 places in 68 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 8 places in 112 ms
[2020-05-16 01:29:13] [INFO ] Deduced a trap composed of 12 places in 122 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 27 places in 131 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 19 places in 125 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 39 places in 124 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 26 places in 163 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 17 places in 151 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 27 places in 124 ms
[2020-05-16 01:29:14] [INFO ] Deduced a trap composed of 22 places in 124 ms
[2020-05-16 01:29:15] [INFO ] Deduced a trap composed of 37 places in 111 ms
[2020-05-16 01:29:15] [INFO ] Deduced a trap composed of 39 places in 57 ms
[2020-05-16 01:29:15] [INFO ] Deduced a trap composed of 34 places in 88 ms
[2020-05-16 01:29:15] [INFO ] Deduced a trap composed of 22 places in 113 ms
[2020-05-16 01:29:15] [INFO ] Deduced a trap composed of 22 places in 163 ms
[2020-05-16 01:29:15] [INFO ] Deduced a trap composed of 37 places in 280 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 27 places in 102 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 36 places in 84 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 30 places in 90 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 25 places in 117 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 39 places in 85 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 38 places in 74 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 36 places in 73 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 39 places in 81 ms
[2020-05-16 01:29:16] [INFO ] Deduced a trap composed of 30 places in 177 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 33 places in 97 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 36 places in 113 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 24 places in 88 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 32 places in 85 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 8 places in 96 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 40 places in 85 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 28 places in 77 ms
[2020-05-16 01:29:17] [INFO ] Deduced a trap composed of 18 places in 106 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 13 places in 62 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 20 places in 66 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 25 places in 105 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 19 places in 87 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 31 places in 88 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 33 places in 73 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 10 places in 64 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 9 places in 105 ms
[2020-05-16 01:29:18] [INFO ] Deduced a trap composed of 30 places in 105 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 27 places in 88 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 32 places in 161 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 23 places in 96 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 26 places in 97 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 22 places in 80 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 32 places in 96 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 16 places in 74 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 22 places in 64 ms
[2020-05-16 01:29:19] [INFO ] Deduced a trap composed of 27 places in 66 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 21 places in 72 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 17 places in 87 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 19 places in 95 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 24 places in 80 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 25 places in 80 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 18 places in 65 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 36 places in 76 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 21 places in 58 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 26 places in 69 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 27 places in 76 ms
[2020-05-16 01:29:20] [INFO ] Deduced a trap composed of 21 places in 117 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 28 places in 75 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 42 places in 103 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 22 places in 72 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 17 places in 68 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 36 places in 59 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 25 places in 55 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 28 places in 76 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 30 places in 72 ms
[2020-05-16 01:29:21] [INFO ] Deduced a trap composed of 23 places in 135 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 18 places in 136 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 22 places in 81 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 18 places in 103 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 22 places in 61 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 34 places in 65 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 19 places in 65 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 34 places in 80 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 21 places in 81 ms
[2020-05-16 01:29:22] [INFO ] Deduced a trap composed of 27 places in 72 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 28 places in 75 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 35 places in 82 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 17 places in 102 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 17 places in 85 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 25 places in 79 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 17 places in 103 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 17 places in 155 ms
[2020-05-16 01:29:23] [INFO ] Deduced a trap composed of 25 places in 71 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 31 places in 101 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 31 places in 124 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 31 places in 129 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 27 places in 60 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 30 places in 81 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 22 places in 113 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 9 places in 89 ms
[2020-05-16 01:29:24] [INFO ] Deduced a trap composed of 17 places in 163 ms
[2020-05-16 01:29:25] [INFO ] Deduced a trap composed of 11 places in 81 ms
[2020-05-16 01:29:25] [INFO ] Deduced a trap composed of 25 places in 123 ms
[2020-05-16 01:29:25] [WARNING] SMT solver failed with error :java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream closed (> (+ s6 s17 s18 s19 s20 s22 s23 s25 s36 s39 s47 s52 s55 s63 s77 s80 s85 s88 s119 s143 s228 s231 s232 s237 s240) 0)") while checking expression at index 0
Ensure Unique test removed 168 transitions
Reduce isomorphic transitions removed 168 transitions.
Iterating post reduction 0 with 168 rules applied. Total rules applied 168 place count 250 transition count 408
Performed 64 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 1 with 64 Pre rules applied. Total rules applied 168 place count 250 transition count 344
Deduced a syphon composed of 64 places in 1 ms
Ensure Unique test removed 56 places
Reduce places removed 120 places and 0 transitions.
Iterating global reduction 1 with 184 rules applied. Total rules applied 352 place count 130 transition count 344
Performed 8 Post agglomeration using F-continuation condition.Transition count delta: 8
Deduced a syphon composed of 8 places in 0 ms
Reduce places removed 8 places and 0 transitions.
Iterating global reduction 1 with 16 rules applied. Total rules applied 368 place count 122 transition count 336
Free-agglomeration rule applied 8 times.
Iterating global reduction 1 with 8 rules applied. Total rules applied 376 place count 122 transition count 328
Reduce places removed 8 places and 0 transitions.
Iterating post reduction 1 with 8 rules applied. Total rules applied 384 place count 114 transition count 328
Partial Free-agglomeration rule applied 8 times.
Drop transitions removed 8 transitions
Iterating global reduction 2 with 8 rules applied. Total rules applied 392 place count 114 transition count 328
Applied a total of 392 rules in 26 ms. Remains 114 /250 variables (removed 136) and now considering 328/576 (removed 248) transitions.
// Phase 1: matrix 328 rows 114 cols
[2020-05-16 01:29:25] [INFO ] Computed 18 place invariants in 1 ms
[2020-05-16 01:29:25] [INFO ] [Real]Absence check using 18 positive place invariants in 10 ms returned sat
[2020-05-16 01:29:25] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 01:29:25] [INFO ] [Real]Absence check using state equation in 91 ms returned sat
[2020-05-16 01:29:25] [INFO ] Computed and/alt/rep : 312/2800/312 causal constraints in 17 ms.
[2020-05-16 01:29:25] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 01:29:25] [INFO ] [Nat]Absence check using 18 positive place invariants in 9 ms returned sat
[2020-05-16 01:29:25] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 01:29:25] [INFO ] [Nat]Absence check using state equation in 113 ms returned sat
[2020-05-16 01:29:25] [INFO ] Computed and/alt/rep : 312/2800/312 causal constraints in 27 ms.
[2020-05-16 01:29:28] [INFO ] Added : 274 causal constraints over 55 iterations in 2413 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 33 ms.
[2020-05-16 01:29:28] [INFO ] Flatten gal took : 129 ms
Using solver Z3 to compute partial order matrices.
[2020-05-16 01:29:28] [INFO ] Applying decomposition
Built C files in :
/home/mcc/execution
[2020-05-16 01:29:28] [INFO ] Flatten gal took : 140 ms
[2020-05-16 01:29:28] [INFO ] Flatten gal took : 164 ms
[2020-05-16 01:29:28] [INFO ] Input system was already deterministic with 576 transitions.
[2020-05-16 01:29:28] [INFO ] Input system was already deterministic with 576 transitions.
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/convert-linux64, -i, /tmp/graph10844644272961841104.txt, -o, /tmp/graph10844644272961841104.bin, -w, /tmp/graph10844644272961841104.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/louvain-linux64, /tmp/graph10844644272961841104.bin, -l, -1, -v, -w, /tmp/graph10844644272961841104.weights, -q, 0, -e, 0.001], workingDir=null]
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 408 out of 576 initially.
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:29:29] [INFO ] Computed 74 place invariants in 15 ms
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_62 + done_62 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_22 + done_22 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_21 + done_21 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : y_0 + y_1 + y_2 + y_3 + y_4 + y_5 + y_6 + y_7 + y_8 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_65 + done_65 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_42 + done_42 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_40 + done_40 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_67 + done_67 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_43 + done_43 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_64 + done_64 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : b_12 + b_13 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_61 + done_61 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : b_2 + b_3 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_46 + done_46 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_48 + done_48 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_69 + done_69 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_28 + done_28 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : b_4 + b_5 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_15 + done_15 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_38 + done_38 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_79 + done_79 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_59 + done_59 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_16 + done_16 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_80 + done_80 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_66 + done_66 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_41 + done_41 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_44 + done_44 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : b_10 + b_11 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_23 + done_23 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_26 + done_26 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : x_0 + x_1 + x_2 + x_3 + x_4 + x_5 + x_6 + x_7 + x_8 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_20 + done_20 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : b_6 + b_7 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_55 + done_55 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : b_16 + b_17 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_31 + done_31 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_12 + done_12 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_76 + done_76 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_56 + done_56 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_51 + done_51 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_74 + done_74 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_33 + done_33 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_71 + done_71 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_77 + done_77 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_30 + done_30 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_13 + done_13 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_10 + done_10 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_70 + done_70 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_73 + done_73 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_34 + done_34 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_37 + done_37 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_58 + done_58 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_52 + done_52 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_49 + done_49 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_35 + done_35 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_25 + done_25 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : b_8 + b_9 = 1
inv : b_14 + b_15 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_19 + done_19 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_24 + done_24 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_39 + done_39 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_68 + done_68 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_50 + done_50 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_17 + done_17 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_53 + done_53 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_47 + done_47 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_60 + done_60 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_57 + done_57 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_14 + done_14 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_78 + done_78 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_29 + done_29 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_11 + done_11 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_32 + done_32 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_75 + done_75 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
Total of 74 invariants.
[2020-05-16 01:29:29] [INFO ] Computed 74 place invariants in 17 ms
[2020-05-16 01:29:29] [INFO ] Decomposing Gal with order
[2020-05-16 01:29:29] [INFO ] Rewriting arrays to variables to allow decomposition.
[2020-05-16 01:29:29] [INFO ] Ran tautology test, simplified 0 / 1 in 855 ms.
[2020-05-16 01:29:29] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=0 took 138 ms
[2020-05-16 01:29:29] [INFO ] Removed a total of 977 redundant transitions.
[2020-05-16 01:29:29] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=1 took 38 ms
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 408 out of 576 initially.
// Phase 1: matrix 408 rows 250 cols
[2020-05-16 01:29:30] [INFO ] Computed 74 place invariants in 1 ms
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_62 + done_62 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_22 + done_22 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_21 + done_21 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : y_0 + y_1 + y_2 + y_3 + y_4 + y_5 + y_6 + y_7 + y_8 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_65 + done_65 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_42 + done_42 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_40 + done_40 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_67 + done_67 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_43 + done_43 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_64 + done_64 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : b_12 + b_13 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_61 + done_61 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : b_2 + b_3 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_46 + done_46 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_48 + done_48 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_69 + done_69 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_28 + done_28 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : b_4 + b_5 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_15 + done_15 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_38 + done_38 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_79 + done_79 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_59 + done_59 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_16 + done_16 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_80 + done_80 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_66 + done_66 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_41 + done_41 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_44 + done_44 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : b_10 + b_11 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_23 + done_23 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_26 + done_26 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : x_0 + x_1 + x_2 + x_3 + x_4 + x_5 + x_6 + x_7 + x_8 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_20 + done_20 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : b_6 + b_7 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_55 + done_55 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : b_16 + b_17 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_31 + done_31 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_12 + done_12 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_76 + done_76 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_56 + done_56 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_51 + done_51 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_74 + done_74 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_33 + done_33 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_71 + done_71 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_77 + done_77 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_30 + done_30 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_13 + done_13 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_10 + done_10 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_70 + done_70 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_73 + done_73 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_34 + done_34 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_37 + done_37 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_58 + done_58 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_52 + done_52 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_49 + done_49 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_35 + done_35 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_25 + done_25 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : b_8 + b_9 = 1
inv : b_14 + b_15 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_19 + done_19 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_2 + P_setx_3_2 + P_setbi_5_2 + P_ify0_4_2 + P_sety_9_2 + P_ifxi_10_2 + P_setbi_11_2 + wait_24 + done_24 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 1
inv : P_start_1_4 + P_setx_3_4 + P_setbi_5_4 + P_ify0_4_4 + P_sety_9_4 + P_ifxi_10_4 + P_setbi_11_4 + wait_39 + done_39 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 1
inv : P_start_1_7 + P_setx_3_7 + P_setbi_5_7 + P_ify0_4_7 + P_sety_9_7 + P_ifxi_10_7 + P_setbi_11_7 + wait_68 + done_68 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_50 + done_50 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_17 + done_17 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_53 + done_53 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_5 + P_setx_3_5 + P_setbi_5_5 + P_ify0_4_5 + P_sety_9_5 + P_ifxi_10_5 + P_setbi_11_5 + wait_47 + done_47 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_60 + done_60 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_6 + P_setx_3_6 + P_setbi_5_6 + P_ify0_4_6 + P_sety_9_6 + P_ifxi_10_6 + P_setbi_11_6 + wait_57 + done_57 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_14 + done_14 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_78 + done_78 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_29 + done_29 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_1 + P_setx_3_1 + P_setbi_5_1 + P_ify0_4_1 + P_sety_9_1 + P_ifxi_10_1 + P_setbi_11_1 + wait_11 + done_11 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
inv : P_start_1_3 + P_setx_3_3 + P_setbi_5_3 + P_ify0_4_3 + P_sety_9_3 + P_ifxi_10_3 + P_setbi_11_3 + wait_32 + done_32 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_start_1_8 + P_setx_3_8 + P_setbi_5_8 + P_ify0_4_8 + P_sety_9_8 + P_ifxi_10_8 + P_setbi_11_8 + wait_75 + done_75 + P_ifyi_15_8 + P_awaity_8 + P_CS_21_8 + P_setbi_24_8 = 1
Total of 74 invariants.
[2020-05-16 01:29:30] [INFO ] Computed 74 place invariants in 2 ms
[2020-05-16 01:29:30] [INFO ] Flatten gal took : 568 ms
[2020-05-16 01:29:30] [INFO ] Fuse similar labels procedure discarded/fused a total of 61 labels/synchronizations in 85 ms.
[2020-05-16 01:29:30] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityFireability.pnml.gal : 46 ms
[2020-05-16 01:29:30] [INFO ] Time to serialize properties into /home/mcc/execution/ReachabilityFireability.prop : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/ReachabilityFireability.pnml.gal, -t, CGAL, -reachable-file, ReachabilityFireability.prop, --nowitness], workingDir=/home/mcc/execution]
its-reach command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/ReachabilityFireability.pnml.gal -t CGAL -reachable-file ReachabilityFireability.prop --nowitness
Loading property file ReachabilityFireability.prop.
Read [reachable] property : LamportFastMutEx-COL-8-ReachabilityFireability-05 with value :((((((((((((((((((((i5.u7.b_5>=1)&&(i5.u13.P_setbi_5_2>=1))||((i7.u5.b_15>=1)&&(i7.u14.P_setbi_5_7>=1)))||((i4.u6.b_17>=1)&&(i4.u15.P_setbi_5_8>=1)))||((i0.u0.b_3>=1)&&(i0.u8.P_setbi_5_1>=1)))||((i2.u3.b_11>=1)&&(i2.u11.P_setbi_5_5>=1)))||((i3.u4.b_13>=1)&&(i3.u12.P_setbi_5_6>=1)))||((i6.u1.b_7>=1)&&(i6.u9.P_setbi_5_3>=1)))||((i1.u2.b_9>=1)&&(i1.u10.P_setbi_5_4>=1)))||((i7.u5.b_14>=1)&&(i7.u14.P_setbi_5_7>=1)))||((i3.u4.b_12>=1)&&(i3.u12.P_setbi_5_6>=1)))||((i0.u0.b_2>=1)&&(i0.u8.P_setbi_5_1>=1)))||((i5.u7.b_4>=1)&&(i5.u13.P_setbi_5_2>=1)))||((i6.u1.b_6>=1)&&(i6.u9.P_setbi_5_3>=1)))||((i4.u6.b_16>=1)&&(i4.u15.P_setbi_5_8>=1)))||((i1.u2.b_8>=1)&&(i1.u10.P_setbi_5_4>=1)))||((i2.u3.b_10>=1)&&(i2.u11.P_setbi_5_5>=1)))&&(((((((((u16.y_1>=1)&&(i0.u88.P_ifyi_15_1>=1))||((i12.u17.y_3>=1)&&(i6.u95.P_ifyi_15_3>=1)))||((i12.u19.y_5>=1)&&(i2.u90.P_ifyi_15_5>=1)))||((u23.y_7>=1)&&(i7.u92.P_ifyi_15_7>=1)))||((u21.y_2>=1)&&(i5.u94.P_ifyi_15_2>=1)))||((u18.y_4>=1)&&(i1.u89.P_ifyi_15_4>=1)))||((u22.y_6>=1)&&(i3.u91.P_ifyi_15_6>=1)))||((u20.y_8>=1)&&(i4.u93.P_ifyi_15_8>=1))))&&(((((((((i7.u14.x_7>=1)&&(u23.P_ifxi_10_7>=1))||((i4.u15.x_8>=1)&&(u20.P_ifxi_10_8>=1)))||((i0.u8.x_1>=1)&&(u16.P_ifxi_10_1>=1)))||((i5.u13.x_2>=1)&&(u21.P_ifxi_10_2>=1)))||((i6.u9.x_3>=1)&&(i12.u17.P_ifxi_10_3>=1)))||((i1.u10.x_4>=1)&&(u18.P_ifxi_10_4>=1)))||((i2.u11.x_5>=1)&&(i12.u19.P_ifxi_10_5>=1)))||((i3.u12.x_6>=1)&&(u22.P_ifxi_10_6>=1))))&&(((((((((((((((((i3.u4.b_12>=1)&&(i3.u102.P_setbi_24_6>=1))||((i0.u0.b_2>=1)&&(i0.u96.P_setbi_24_1>=1)))||((i4.u6.b_17>=1)&&(i4.u103.P_setbi_24_8>=1)))||((i5.u7.b_5>=1)&&(i5.u97.P_setbi_24_2>=1)))||((i7.u5.b_15>=1)&&(i7.u98.P_setbi_24_7>=1)))||((i2.u3.b_11>=1)&&(i12.u101.P_setbi_24_5>=1)))||((i3.u4.b_13>=1)&&(i3.u102.P_setbi_24_6>=1)))||((i6.u1.b_7>=1)&&(i12.u99.P_setbi_24_3>=1)))||((i1.u2.b_9>=1)&&(i12.u100.P_setbi_24_4>=1)))||((i0.u0.b_3>=1)&&(i0.u96.P_setbi_24_1>=1)))||((i4.u6.b_16>=1)&&(i4.u103.P_setbi_24_8>=1)))||((i7.u5.b_14>=1)&&(i7.u98.P_setbi_24_7>=1)))||((i6.u1.b_6>=1)&&(i12.u99.P_setbi_24_3>=1)))||((i5.u7.b_4>=1)&&(i5.u97.P_setbi_24_2>=1)))||((i1.u2.b_8>=1)&&(i12.u100.P_setbi_24_4>=1)))||((i2.u3.b_10>=1)&&(i12.u101.P_setbi_24_5>=1))))
built 144 ordering constraints for composite.
built 40 ordering constraints for composite.
built 40 ordering constraints for composite.
built 40 ordering constraints for composite.
built 41 ordering constraints for composite.
built 38 ordering constraints for composite.
built 40 ordering constraints for composite.
built 38 ordering constraints for composite.
built 37 ordering constraints for composite.
built 37 ordering constraints for composite.
SDD proceeding with computation, new max is 4
SDD proceeding with computation, new max is 8
SDD proceeding with computation, new max is 16
SDD proceeding with computation, new max is 32
SDD proceeding with computation, new max is 64
SDD proceeding with computation, new max is 128
SDD proceeding with computation, new max is 256
SDD proceeding with computation, new max is 512
[2020-05-16 01:29:30] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=2 took 973 ms
SDD proceeding with computation, new max is 1024
SDD proceeding with computation, new max is 2048
[2020-05-16 01:29:31] [INFO ] Proved 250 variables to be positive in 2699 ms
[2020-05-16 01:29:31] [INFO ] Computing symmetric may disable matrix : 576 transitions.
[2020-05-16 01:29:31] [INFO ] Computation of disable matrix completed :0/576 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 01:29:32] [INFO ] Computation of Complete disable matrix. took 70 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 01:29:32] [INFO ] Computing symmetric may enable matrix : 576 transitions.
[2020-05-16 01:29:32] [INFO ] Computation of Complete enable matrix. took 66 ms. Total solver calls (SAT/UNSAT): 0(0/0)
SDD proceeding with computation, new max is 4096
[2020-05-16 01:29:32] [INFO ] Proved 250 variables to be positive in 2744 ms
[2020-05-16 01:29:32] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:29:32] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=0 took 20 ms
[2020-05-16 01:29:32] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:29:32] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=1 took 140 ms
SDD proceeding with computation, new max is 8192
SDD proceeding with computation, new max is 16384
[2020-05-16 01:29:41] [INFO ] Computing symmetric co enabling matrix : 576 transitions.
[2020-05-16 01:29:41] [INFO ] Computation of co-enabling matrix(0/576) took 260 ms. Total solver calls (SAT/UNSAT): 78(7/71)
[2020-05-16 01:29:43] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=3 took 13020 ms
[2020-05-16 01:29:44] [INFO ] Computation of co-enabling matrix(18/576) took 3407 ms. Total solver calls (SAT/UNSAT): 1822(95/1727)
SDD proceeding with computation, new max is 32768
[2020-05-16 01:29:47] [INFO ] Computation of co-enabling matrix(33/576) took 6452 ms. Total solver calls (SAT/UNSAT): 4597(251/4346)
[2020-05-16 01:29:50] [INFO ] Computation of co-enabling matrix(42/576) took 9636 ms. Total solver calls (SAT/UNSAT): 6154(347/5807)
[2020-05-16 01:29:53] [INFO ] Computation of co-enabling matrix(55/576) took 12670 ms. Total solver calls (SAT/UNSAT): 8260(476/7784)
[2020-05-16 01:29:56] [INFO ] Computation of co-enabling matrix(80/576) took 15675 ms. Total solver calls (SAT/UNSAT): 11835(742/11093)
SDD proceeding with computation, new max is 65536
[2020-05-16 01:30:00] [INFO ] Computation of co-enabling matrix(94/576) took 19128 ms. Total solver calls (SAT/UNSAT): 14936(1008/13928)
[2020-05-16 01:30:04] [INFO ] Computation of co-enabling matrix(98/576) took 22880 ms. Total solver calls (SAT/UNSAT): 16178(1117/15061)
[2020-05-16 01:30:05] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:30:05] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=2 took 32170 ms
[2020-05-16 01:30:07] [INFO ] Computation of co-enabling matrix(100/576) took 26496 ms. Total solver calls (SAT/UNSAT): 16793(1171/15622)
[2020-05-16 01:30:11] [INFO ] Computation of co-enabling matrix(104/576) took 30063 ms. Total solver calls (SAT/UNSAT): 18011(1278/16733)
[2020-05-16 01:30:14] [INFO ] Computation of co-enabling matrix(108/576) took 33136 ms. Total solver calls (SAT/UNSAT): 19213(1382/17831)
[2020-05-16 01:30:17] [INFO ] Computation of co-enabling matrix(112/576) took 36808 ms. Total solver calls (SAT/UNSAT): 20399(1485/18914)
SDD proceeding with computation, new max is 131072
[2020-05-16 01:30:21] [INFO ] Computation of co-enabling matrix(116/576) took 40456 ms. Total solver calls (SAT/UNSAT): 21569(1585/19984)
[2020-05-16 01:30:25] [INFO ] Computation of co-enabling matrix(120/576) took 44108 ms. Total solver calls (SAT/UNSAT): 22723(1684/21039)
[2020-05-16 01:30:29] [INFO ] Computation of co-enabling matrix(124/576) took 47960 ms. Total solver calls (SAT/UNSAT): 23861(1780/22081)
[2020-05-16 01:30:32] [INFO ] Computation of co-enabling matrix(128/576) took 51804 ms. Total solver calls (SAT/UNSAT): 24983(1875/23108)
[2020-05-16 01:30:36] [INFO ] Computation of co-enabling matrix(131/576) took 54964 ms. Total solver calls (SAT/UNSAT): 25814(1944/23870)
[2020-05-16 01:30:39] [INFO ] Computation of co-enabling matrix(134/576) took 58080 ms. Total solver calls (SAT/UNSAT): 26636(2013/24623)
[2020-05-16 01:30:42] [INFO ] Computation of co-enabling matrix(138/576) took 61608 ms. Total solver calls (SAT/UNSAT): 27718(2102/25616)
[2020-05-16 01:30:45] [INFO ] Computation of co-enabling matrix(140/576) took 64788 ms. Total solver calls (SAT/UNSAT): 28253(2146/26107)
[2020-05-16 01:30:49] [INFO ] Computation of co-enabling matrix(144/576) took 68044 ms. Total solver calls (SAT/UNSAT): 29311(2233/27078)
[2020-05-16 01:30:52] [INFO ] Computation of co-enabling matrix(148/576) took 71376 ms. Total solver calls (SAT/UNSAT): 30353(2317/28036)
[2020-05-16 01:30:56] [INFO ] Computation of co-enabling matrix(153/576) took 75253 ms. Total solver calls (SAT/UNSAT): 31242(2394/28848)
[2020-05-16 01:30:59] [INFO ] Computation of co-enabling matrix(171/576) took 78381 ms. Total solver calls (SAT/UNSAT): 33066(2570/30496)
[2020-05-16 01:31:02] [INFO ] Computation of co-enabling matrix(182/576) took 81782 ms. Total solver calls (SAT/UNSAT): 35750(2863/32887)
SDD proceeding with computation, new max is 262144
[2020-05-16 01:31:06] [INFO ] Computation of co-enabling matrix(185/576) took 85148 ms. Total solver calls (SAT/UNSAT): 36461(2926/33535)
[2020-05-16 01:31:09] [INFO ] Computation of co-enabling matrix(189/576) took 88792 ms. Total solver calls (SAT/UNSAT): 37395(3010/34385)
[2020-05-16 01:31:14] [INFO ] Computation of co-enabling matrix(194/576) took 92858 ms. Total solver calls (SAT/UNSAT): 38540(3113/35427)
[2020-05-16 01:31:17] [INFO ] Computation of co-enabling matrix(196/576) took 96444 ms. Total solver calls (SAT/UNSAT): 38991(3153/35838)
[2020-05-16 01:31:23] [INFO ] Computation of co-enabling matrix(198/576) took 102209 ms. Total solver calls (SAT/UNSAT): 39438(3193/36245)
[2020-05-16 01:31:27] [INFO ] Computation of co-enabling matrix(200/576) took 106773 ms. Total solver calls (SAT/UNSAT): 39881(3233/36648)
[2020-05-16 01:31:32] [INFO ] Computation of co-enabling matrix(208/576) took 111244 ms. Total solver calls (SAT/UNSAT): 41613(3386/38227)
[2020-05-16 01:31:35] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:31:35] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=3 took 89933 ms
[2020-05-16 01:31:35] [INFO ] Computation of co-enabling matrix(210/576) took 114454 ms. Total solver calls (SAT/UNSAT): 42036(3424/38612)
[2020-05-16 01:31:39] [INFO ] Computation of co-enabling matrix(213/576) took 118344 ms. Total solver calls (SAT/UNSAT): 42663(3478/39185)
[2020-05-16 01:31:42] [INFO ] Computation of co-enabling matrix(216/576) took 121360 ms. Total solver calls (SAT/UNSAT): 43281(3532/39749)
[2020-05-16 01:31:46] [INFO ] Computation of co-enabling matrix(219/576) took 125762 ms. Total solver calls (SAT/UNSAT): 43890(3586/40304)
[2020-05-16 01:31:50] [INFO ] Computation of co-enabling matrix(228/576) took 129284 ms. Total solver calls (SAT/UNSAT): 45663(3739/41924)
[2020-05-16 01:31:53] [INFO ] Computation of co-enabling matrix(236/576) took 132343 ms. Total solver calls (SAT/UNSAT): 47171(3867/43304)
[2020-05-16 01:31:56] [INFO ] Computation of co-enabling matrix(256/576) took 135397 ms. Total solver calls (SAT/UNSAT): 50598(4151/46447)
[2020-05-16 01:31:59] [INFO ] Computation of co-enabling matrix(290/576) took 138559 ms. Total solver calls (SAT/UNSAT): 53471(4283/49188)
[2020-05-16 01:32:02] [INFO ] Computation of co-enabling matrix(303/576) took 141756 ms. Total solver calls (SAT/UNSAT): 54264(4337/49927)
[2020-05-16 01:32:05] [INFO ] Computation of co-enabling matrix(316/576) took 144800 ms. Total solver calls (SAT/UNSAT): 54888(4390/50498)
[2020-05-16 01:32:09] [INFO ] Computation of co-enabling matrix(330/576) took 147874 ms. Total solver calls (SAT/UNSAT): 55354(4460/50894)
[2020-05-16 01:32:12] [INFO ] Computation of co-enabling matrix(347/576) took 150919 ms. Total solver calls (SAT/UNSAT): 55882(4550/51332)
[2020-05-16 01:32:14] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=4 took 150214 ms
[2020-05-16 01:32:15] [INFO ] Computation of co-enabling matrix(366/576) took 154036 ms. Total solver calls (SAT/UNSAT): 56468(4646/51822)
[2020-05-16 01:32:18] [INFO ] Computation of co-enabling matrix(384/576) took 157142 ms. Total solver calls (SAT/UNSAT): 57015(4732/52283)
[2020-05-16 01:32:22] [INFO ] Computation of co-enabling matrix(393/576) took 161120 ms. Total solver calls (SAT/UNSAT): 57471(4760/52711)
[2020-05-16 01:32:25] [INFO ] Computation of co-enabling matrix(398/576) took 164641 ms. Total solver calls (SAT/UNSAT): 58191(4830/53361)
[2020-05-16 01:32:29] [INFO ] Computation of co-enabling matrix(405/576) took 168064 ms. Total solver calls (SAT/UNSAT): 59157(4923/54234)
[2020-05-16 01:32:32] [INFO ] Computation of co-enabling matrix(412/576) took 171109 ms. Total solver calls (SAT/UNSAT): 60074(5011/55063)
[2020-05-16 01:32:35] [INFO ] Computation of co-enabling matrix(432/576) took 174388 ms. Total solver calls (SAT/UNSAT): 62424(5231/57193)
[2020-05-16 01:32:38] [INFO ] Computation of co-enabling matrix(441/576) took 177708 ms. Total solver calls (SAT/UNSAT): 63351(5316/58035)
SDD proceeding with computation, new max is 524288
[2020-05-16 01:32:42] [INFO ] Computation of co-enabling matrix(447/576) took 181172 ms. Total solver calls (SAT/UNSAT): 63924(5369/58555)
[2020-05-16 01:32:45] [INFO ] Computation of co-enabling matrix(460/576) took 184440 ms. Total solver calls (SAT/UNSAT): 65042(5467/59575)
[2020-05-16 01:32:48] [INFO ] Computation of co-enabling matrix(494/576) took 187508 ms. Total solver calls (SAT/UNSAT): 66880(5630/61250)
[2020-05-16 01:32:51] [INFO ] Computation of co-enabling matrix(531/576) took 190549 ms. Total solver calls (SAT/UNSAT): 68138(5737/62401)
[2020-05-16 01:32:52] [INFO ] Computation of Finished co-enabling matrix. took 191544 ms. Total solver calls (SAT/UNSAT): 68300(5740/62560)
[2020-05-16 01:32:52] [INFO ] Computing Do-Not-Accords matrix : 576 transitions.
[2020-05-16 01:32:52] [INFO ] Computation of Completed DNA matrix. took 39 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 01:32:52] [INFO ] Built C files in 204124ms conformant to PINS in folder :/home/mcc/execution
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
Compilation finished in 10797 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 74 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, LamportFastMutExCOL8ReachabilityFireability05==true], workingDir=/home/mcc/execution]
/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc: error while loading shared libraries: libltdl.so.7: cannot open shared object file: No such file or directory
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, LamportFastMutExCOL8ReachabilityFireability05==true], workingDir=/home/mcc/execution]
127
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, LamportFastMutExCOL8ReachabilityFireability05==true], workingDir=/home/mcc/execution]
127
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:170)
at fr.lip6.move.gal.application.LTSminRunner.access$10(LTSminRunner.java:124)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:93)
at java.base/java.lang.Thread.run(Thread.java:834)
[2020-05-16 01:35:25] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:35:25] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=4 took 230374 ms
SDD proceeding with computation, new max is 1048576
[2020-05-16 01:40:45] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:40:45] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=5 took 319499 ms
[2020-05-16 01:41:47] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=5 took 573291 ms
SDD proceeding with computation, new max is 2097152
[2020-05-16 01:50:18] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 01:50:18] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=6 took 573470 ms
Detected timeout of ITS tools.
[2020-05-16 01:50:56] [INFO ] Applying decomposition
[2020-05-16 01:50:56] [INFO ] Flatten gal took : 93 ms
[2020-05-16 01:50:56] [INFO ] Decomposing Gal with order
[2020-05-16 01:50:56] [INFO ] Rewriting arrays to variables to allow decomposition.
[2020-05-16 01:50:56] [INFO ] Removed a total of 955 redundant transitions.
[2020-05-16 01:50:56] [INFO ] Flatten gal took : 97 ms
[2020-05-16 01:50:56] [INFO ] Fuse similar labels procedure discarded/fused a total of 32 labels/synchronizations in 18 ms.
[2020-05-16 01:50:56] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityFireability.pnml.gal : 4 ms
[2020-05-16 01:50:56] [INFO ] Time to serialize properties into /home/mcc/execution/ReachabilityFireability.prop : 0 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/ReachabilityFireability.pnml.gal, -t, CGAL, -reachable-file, ReachabilityFireability.prop, --nowitness], workingDir=/home/mcc/execution]
its-reach command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/ReachabilityFireability.pnml.gal -t CGAL -reachable-file ReachabilityFireability.prop --nowitness
Loading property file ReachabilityFireability.prop.
Read [reachable] property : LamportFastMutEx-COL-8-ReachabilityFireability-05 with value :((((((((((((((((((((pid_x_bool5.b_5>=1)&&(pid2.P_setbi_5_2>=1))||((pid_x_bool15.b_15>=1)&&(pid7.P_setbi_5_7>=1)))||((pid_x_bool17.b_17>=1)&&(pid8.P_setbi_5_8>=1)))||((pid_x_bool3.b_3>=1)&&(pid1.P_setbi_5_1>=1)))||((pid_x_bool11.b_11>=1)&&(pid5.P_setbi_5_5>=1)))||((pid_x_bool13.b_13>=1)&&(pid6.P_setbi_5_6>=1)))||((pid_x_bool7.b_7>=1)&&(pid3.P_setbi_5_3>=1)))||((pid_x_bool9.b_9>=1)&&(pid4.P_setbi_5_4>=1)))||((pid_x_bool14.b_14>=1)&&(pid7.P_setbi_5_7>=1)))||((pid_x_bool12.b_12>=1)&&(pid6.P_setbi_5_6>=1)))||((pid_x_bool2.b_2>=1)&&(pid1.P_setbi_5_1>=1)))||((pid_x_bool4.b_4>=1)&&(pid2.P_setbi_5_2>=1)))||((pid_x_bool6.b_6>=1)&&(pid3.P_setbi_5_3>=1)))||((pid_x_bool16.b_16>=1)&&(pid8.P_setbi_5_8>=1)))||((pid_x_bool8.b_8>=1)&&(pid4.P_setbi_5_4>=1)))||((pid_x_bool10.b_10>=1)&&(pid5.P_setbi_5_5>=1)))&&(((((((((pid1.y_1>=1)&&(pid1.P_ifyi_15_1>=1))||((pid3.y_3>=1)&&(pid3.P_ifyi_15_3>=1)))||((pid5.y_5>=1)&&(pid5.P_ifyi_15_5>=1)))||((pid7.y_7>=1)&&(pid7.P_ifyi_15_7>=1)))||((pid2.y_2>=1)&&(pid2.P_ifyi_15_2>=1)))||((pid4.y_4>=1)&&(pid4.P_ifyi_15_4>=1)))||((pid6.y_6>=1)&&(pid6.P_ifyi_15_6>=1)))||((pid8.y_8>=1)&&(pid8.P_ifyi_15_8>=1))))&&(((((((((pid7.x_7>=1)&&(pid7.P_ifxi_10_7>=1))||((pid8.x_8>=1)&&(pid8.P_ifxi_10_8>=1)))||((pid1.x_1>=1)&&(pid1.P_ifxi_10_1>=1)))||((pid2.x_2>=1)&&(pid2.P_ifxi_10_2>=1)))||((pid3.x_3>=1)&&(pid3.P_ifxi_10_3>=1)))||((pid4.x_4>=1)&&(pid4.P_ifxi_10_4>=1)))||((pid5.x_5>=1)&&(pid5.P_ifxi_10_5>=1)))||((pid6.x_6>=1)&&(pid6.P_ifxi_10_6>=1))))&&(((((((((((((((((pid_x_bool12.b_12>=1)&&(pid6.P_setbi_24_6>=1))||((pid_x_bool2.b_2>=1)&&(pid1.P_setbi_24_1>=1)))||((pid_x_bool17.b_17>=1)&&(pid8.P_setbi_24_8>=1)))||((pid_x_bool5.b_5>=1)&&(pid2.P_setbi_24_2>=1)))||((pid_x_bool15.b_15>=1)&&(pid7.P_setbi_24_7>=1)))||((pid_x_bool11.b_11>=1)&&(pid5.P_setbi_24_5>=1)))||((pid_x_bool13.b_13>=1)&&(pid6.P_setbi_24_6>=1)))||((pid_x_bool7.b_7>=1)&&(pid3.P_setbi_24_3>=1)))||((pid_x_bool9.b_9>=1)&&(pid4.P_setbi_24_4>=1)))||((pid_x_bool3.b_3>=1)&&(pid1.P_setbi_24_1>=1)))||((pid_x_bool16.b_16>=1)&&(pid8.P_setbi_24_8>=1)))||((pid_x_bool14.b_14>=1)&&(pid7.P_setbi_24_7>=1)))||((pid_x_bool6.b_6>=1)&&(pid3.P_setbi_24_3>=1)))||((pid_x_bool4.b_4>=1)&&(pid2.P_setbi_24_2>=1)))||((pid_x_bool8.b_8>=1)&&(pid4.P_setbi_24_4>=1)))||((pid_x_bool10.b_10>=1)&&(pid5.P_setbi_24_5>=1))))
built 176 ordering constraints for composite.
SDD proceeding with computation, new max is 4
SDD proceeding with computation, new max is 8
SDD proceeding with computation, new max is 16
SDD proceeding with computation, new max is 32
SDD proceeding with computation, new max is 64
SDD proceeding with computation, new max is 128
SDD proceeding with computation, new max is 256
SDD proceeding with computation, new max is 512
SDD proceeding with computation, new max is 1024
SDD proceeding with computation, new max is 2048
SDD proceeding with computation, new max is 4096
SDD proceeding with computation, new max is 8192
SDD proceeding with computation, new max is 16384
SDD proceeding with computation, new max is 32768
SDD proceeding with computation, new max is 65536
SDD proceeding with computation, new max is 131072
SDD proceeding with computation, new max is 262144
SDD proceeding with computation, new max is 524288
[2020-05-16 02:00:36] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-COL-8-ReachabilityFireability-05
[2020-05-16 02:00:36] [INFO ] KInduction solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(SAT) depth K=7 took 617881 ms
SDD proceeding with computation, new max is 1048576
Detected timeout of ITS tools.
[2020-05-16 02:12:23] [INFO ] Flatten gal took : 28 ms
[2020-05-16 02:12:23] [INFO ] Input system was already deterministic with 576 transitions.
[2020-05-16 02:12:23] [INFO ] Transformed 250 places.
[2020-05-16 02:12:23] [INFO ] Transformed 576 transitions.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
[2020-05-16 02:12:23] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityFireability.pnml.gal : 21 ms
[2020-05-16 02:12:23] [INFO ] Time to serialize properties into /home/mcc/execution/ReachabilityFireability.prop : 16 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/ReachabilityFireability.pnml.gal, -t, CGAL, -reachable-file, ReachabilityFireability.prop, --nowitness, --load-order, /home/mcc/execution/model.ord, --gen-order, FOLLOW], workingDir=/home/mcc/execution]
its-reach command run as :
/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/ReachabilityFireability.pnml.gal -t CGAL -reachable-file ReachabilityFireability.prop --nowitness --load-order /home/mcc/execution/model.ord --gen-order FOLLOW
Successfully loaded order from file /home/mcc/execution/model.ord
Loading property file ReachabilityFireability.prop.
Read [reachable] property : LamportFastMutEx-COL-8-ReachabilityFireability-05 with value :((((((((((((((((((((b_5>=1)&&(P_setbi_5_2>=1))||((b_15>=1)&&(P_setbi_5_7>=1)))||((b_17>=1)&&(P_setbi_5_8>=1)))||((b_3>=1)&&(P_setbi_5_1>=1)))||((b_11>=1)&&(P_setbi_5_5>=1)))||((b_13>=1)&&(P_setbi_5_6>=1)))||((b_7>=1)&&(P_setbi_5_3>=1)))||((b_9>=1)&&(P_setbi_5_4>=1)))||((b_14>=1)&&(P_setbi_5_7>=1)))||((b_12>=1)&&(P_setbi_5_6>=1)))||((b_2>=1)&&(P_setbi_5_1>=1)))||((b_4>=1)&&(P_setbi_5_2>=1)))||((b_6>=1)&&(P_setbi_5_3>=1)))||((b_16>=1)&&(P_setbi_5_8>=1)))||((b_8>=1)&&(P_setbi_5_4>=1)))||((b_10>=1)&&(P_setbi_5_5>=1)))&&(((((((((y_1>=1)&&(P_ifyi_15_1>=1))||((y_3>=1)&&(P_ifyi_15_3>=1)))||((y_5>=1)&&(P_ifyi_15_5>=1)))||((y_7>=1)&&(P_ifyi_15_7>=1)))||((y_2>=1)&&(P_ifyi_15_2>=1)))||((y_4>=1)&&(P_ifyi_15_4>=1)))||((y_6>=1)&&(P_ifyi_15_6>=1)))||((y_8>=1)&&(P_ifyi_15_8>=1))))&&(((((((((x_7>=1)&&(P_ifxi_10_7>=1))||((x_8>=1)&&(P_ifxi_10_8>=1)))||((x_1>=1)&&(P_ifxi_10_1>=1)))||((x_2>=1)&&(P_ifxi_10_2>=1)))||((x_3>=1)&&(P_ifxi_10_3>=1)))||((x_4>=1)&&(P_ifxi_10_4>=1)))||((x_5>=1)&&(P_ifxi_10_5>=1)))||((x_6>=1)&&(P_ifxi_10_6>=1))))&&(((((((((((((((((b_12>=1)&&(P_setbi_24_6>=1))||((b_2>=1)&&(P_setbi_24_1>=1)))||((b_17>=1)&&(P_setbi_24_8>=1)))||((b_5>=1)&&(P_setbi_24_2>=1)))||((b_15>=1)&&(P_setbi_24_7>=1)))||((b_11>=1)&&(P_setbi_24_5>=1)))||((b_13>=1)&&(P_setbi_24_6>=1)))||((b_7>=1)&&(P_setbi_24_3>=1)))||((b_9>=1)&&(P_setbi_24_4>=1)))||((b_3>=1)&&(P_setbi_24_1>=1)))||((b_16>=1)&&(P_setbi_24_8>=1)))||((b_14>=1)&&(P_setbi_24_7>=1)))||((b_6>=1)&&(P_setbi_24_3>=1)))||((b_4>=1)&&(P_setbi_24_2>=1)))||((b_8>=1)&&(P_setbi_24_4>=1)))||((b_10>=1)&&(P_setbi_24_5>=1))))
SDD proceeding with computation, new max is 4
SDD proceeding with computation, new max is 8
[2020-05-16 02:12:26] [INFO ] BMC solution for property LamportFastMutEx-COL-8-ReachabilityFireability-05(UNSAT) depth K=6 took 1839112 ms
SDD proceeding with computation, new max is 16
SDD proceeding with computation, new max is 32
SDD proceeding with computation, new max is 64
SDD proceeding with computation, new max is 128
SDD proceeding with computation, new max is 256
SDD proceeding with computation, new max is 512
SDD proceeding with computation, new max is 1024
SDD proceeding with computation, new max is 2048
SDD proceeding with computation, new max is 4096
BK_TIME_CONFINEMENT_REACHED
--------------------
content from stderr:
+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ ReachabilityFireability = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution ReachabilityFireability -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination ReachabilityFireability -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -timeout 3600 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
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="LamportFastMutEx-COL-8"
export BK_EXAMINATION="ReachabilityFireability"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
# this is specific to your benchmark or test
export BIN_DIR="$HOME/BenchKit/bin"
# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi
# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itstools"
echo " Input is LamportFastMutEx-COL-8, examination is ReachabilityFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r096-oct2-158940145400639"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/LamportFastMutEx-COL-8.tgz
mv LamportFastMutEx-COL-8 execution
cd execution
if [ "ReachabilityFireability" = "ReachabilityDeadlock" ] || [ "ReachabilityFireability" = "UpperBounds" ] || [ "ReachabilityFireability" = "QuasiLiveness" ] || [ "ReachabilityFireability" = "StableMarking" ] || [ "ReachabilityFireability" = "Liveness" ] || [ "ReachabilityFireability" = "OneSafe" ] || [ "ReachabilityFireability" = "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 [ "ReachabilityFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityFireability" != "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 "ReachabilityFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityFireability.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '
echo "FORMULA_NAME $x"
done
elif [ "ReachabilityFireability" = "ReachabilityDeadlock" ] || [ "ReachabilityFireability" = "QuasiLiveness" ] || [ "ReachabilityFireability" = "StableMarking" ] || [ "ReachabilityFireability" = "Liveness" ] || [ "ReachabilityFireability" = "OneSafe" ] ; then
echo "FORMULA_NAME ReachabilityFireability"
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 ;