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-158940145400686.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-PT-7, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r096-oct2-158940145400686
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 836K
-rw-r--r-- 1 mcc users 9.3K Apr 30 13:04 CTLCardinality.txt
-rw-r--r-- 1 mcc users 42K Apr 30 13:04 CTLCardinality.xml
-rw-r--r-- 1 mcc users 19K Apr 30 13:04 CTLFireability.txt
-rw-r--r-- 1 mcc users 82K 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 18K Apr 30 13:04 LTLCardinality.txt
-rw-r--r-- 1 mcc users 81K Apr 30 13:04 LTLCardinality.xml
-rw-r--r-- 1 mcc users 17K Apr 30 13:04 LTLFireability.txt
-rw-r--r-- 1 mcc users 81K Apr 30 13:04 LTLFireability.xml
-rw-r--r-- 1 mcc users 13K Apr 30 13:04 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 51K Apr 30 13:04 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 20K Apr 30 13:04 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 85K Apr 30 13:04 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 3.1K Apr 30 13:04 UpperBounds.txt
-rw-r--r-- 1 mcc users 7.8K Apr 30 13:04 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Apr 30 13:04 equiv_col
-rw-r--r-- 1 mcc users 2 Apr 30 13:04 instance
-rw-r--r-- 1 mcc users 6 Apr 30 13:04 iscolored
-rw-r--r-- 1 mcc users 255K 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-PT-7-ReachabilityCardinality-00
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-01
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-02
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-03
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-04
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-05
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-06
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-07
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-08
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-09
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-10
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-11
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-12
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-13
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-14
FORMULA_NAME LamportFastMutEx-PT-7-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1589594946509

[2020-05-16 02:09:09] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityCardinality, -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 02:09:09] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-05-16 02:09:10] [INFO ] Load time of PNML (sax parser for PT used): 127 ms
[2020-05-16 02:09:10] [INFO ] Transformed 264 places.
[2020-05-16 02:09:10] [INFO ] Transformed 536 transitions.
[2020-05-16 02:09:10] [INFO ] Parsed PT model containing 264 places and 536 transitions in 201 ms.
Deduced a syphon composed of 45 places in 4 ms
Reduce places removed 45 places and 74 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 82 ms.
Working with output stream class java.io.PrintStream
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-08 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 0 resets, run finished after 78 ms. (steps per millisecond=128 ) properties seen :[1, 1, 1, 1, 1, 0, 0, 1, 0, 1, 1, 0, 1, 0]
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-13 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-11 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-07 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-04 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-03 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-02 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-00 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10000 steps, including 0 resets, run finished after 25 ms. (steps per millisecond=400 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 31 ms. (steps per millisecond=322 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 10 ms. (steps per millisecond=1000 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 11 ms. (steps per millisecond=909 ) properties seen :[0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 0 resets, run finished after 10 ms. (steps per millisecond=1000 ) properties seen :[0, 0, 0, 0, 0]
[2020-05-16 02:09:10] [INFO ] Flow matrix only has 336 transitions (discarded 126 similar events)
// Phase 1: matrix 336 rows 219 cols
[2020-05-16 02:09:10] [INFO ] Computed 65 place invariants in 12 ms
[2020-05-16 02:09:10] [INFO ] [Real]Absence check using 65 positive place invariants in 27 ms returned unsat
[2020-05-16 02:09:10] [INFO ] [Real]Absence check using 65 positive place invariants in 25 ms returned sat
[2020-05-16 02:09:10] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 02:09:11] [INFO ] [Real]Absence check using state equation in 360 ms returned sat
[2020-05-16 02:09:11] [INFO ] State equation strengthened by 105 read => feed constraints.
[2020-05-16 02:09:11] [INFO ] [Real]Added 105 Read/Feed constraints in 35 ms returned sat
[2020-05-16 02:09:11] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 02:09:11] [INFO ] [Nat]Absence check using 65 positive place invariants in 31 ms returned sat
[2020-05-16 02:09:11] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 02:09:11] [INFO ] [Nat]Absence check using state equation in 241 ms returned sat
[2020-05-16 02:09:11] [INFO ] [Nat]Added 105 Read/Feed constraints in 36 ms returned sat
[2020-05-16 02:09:12] [INFO ] Deduced a trap composed of 9 places in 347 ms
[2020-05-16 02:09:12] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 415 ms
[2020-05-16 02:09:12] [INFO ] Computed and/alt/rep : 455/3647/329 causal constraints in 25 ms.
[2020-05-16 02:09:16] [INFO ] Added : 313 causal constraints over 64 iterations in 4013 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 66 ms.
[2020-05-16 02:09:16] [INFO ] [Real]Absence check using 65 positive place invariants in 2 ms returned unsat
[2020-05-16 02:09:16] [INFO ] [Real]Absence check using 65 positive place invariants in 43 ms returned unsat
[2020-05-16 02:09:16] [INFO ] [Real]Absence check using 65 positive place invariants in 49 ms returned unsat
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-14 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-12 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-09 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA LamportFastMutEx-PT-7-ReachabilityCardinality-05 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Incomplete Parikh walk after 86200 steps, including 1000 resets, run finished after 256 ms. (steps per millisecond=336 ) properties seen :[0] could not realise parikh vector
Support contains 28 out of 219 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 219/219 places, 462/462 transitions.
Performed 7 Post agglomeration using F-continuation condition.Transition count delta: 7
Deduced a syphon composed of 7 places in 1 ms
Reduce places removed 7 places and 0 transitions.
Iterating global reduction 0 with 14 rules applied. Total rules applied 14 place count 212 transition count 455
Applied a total of 14 rules in 95 ms. Remains 212 /219 variables (removed 7) and now considering 455/462 (removed 7) transitions.
Finished structural reductions, in 1 iterations. Remains : 212/219 places, 455/462 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 2099 ms. (steps per millisecond=476 ) properties seen :[0]
Incomplete Best-First random walk after 1000001 steps, including 0 resets, run finished after 1028 ms. (steps per millisecond=972 ) properties seen :[0]
Interrupted probabilistic random walk after 16637143 steps, run timeout after 30001 ms. (steps per millisecond=554 ) properties seen :[0]
Probabilistic random walk after 16637143 steps, saw 2530026 distinct states, run finished after 30001 ms. (steps per millisecond=554 ) properties seen :[0]
[2020-05-16 02:09:49] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 212 cols
[2020-05-16 02:09:49] [INFO ] Computed 65 place invariants in 5 ms
[2020-05-16 02:09:50] [INFO ] [Real]Absence check using 65 positive place invariants in 189 ms returned sat
[2020-05-16 02:09:50] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 02:09:50] [INFO ] [Real]Absence check using state equation in 371 ms returned sat
[2020-05-16 02:09:50] [INFO ] State equation strengthened by 105 read => feed constraints.
[2020-05-16 02:09:50] [INFO ] [Real]Added 105 Read/Feed constraints in 19 ms returned sat
[2020-05-16 02:09:50] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 02:09:50] [INFO ] [Nat]Absence check using 65 positive place invariants in 18 ms returned sat
[2020-05-16 02:09:50] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 02:09:50] [INFO ] [Nat]Absence check using state equation in 143 ms returned sat
[2020-05-16 02:09:50] [INFO ] [Nat]Added 105 Read/Feed constraints in 14 ms returned sat
[2020-05-16 02:09:50] [INFO ] Deduced a trap composed of 8 places in 114 ms
[2020-05-16 02:09:51] [INFO ] Deduced a trap composed of 40 places in 690 ms
[2020-05-16 02:09:51] [INFO ] Deduced a trap composed of 8 places in 97 ms
[2020-05-16 02:09:51] [INFO ] Deduced a trap composed of 14 places in 85 ms
[2020-05-16 02:09:52] [INFO ] Deduced a trap composed of 21 places in 979 ms
[2020-05-16 02:09:54] [INFO ] Deduced a trap composed of 18 places in 1741 ms
[2020-05-16 02:09:54] [INFO ] Deduced a trap composed of 30 places in 133 ms
[2020-05-16 02:09:54] [INFO ] Deduced a trap composed of 35 places in 65 ms
[2020-05-16 02:09:54] [INFO ] Deduced a trap composed of 7 places in 15 ms
[2020-05-16 02:09:54] [INFO ] Trap strengthening (SAT) tested/added 10/9 trap constraints in 4057 ms
[2020-05-16 02:09:54] [INFO ] Computed and/alt/rep : 448/3738/322 causal constraints in 21 ms.
[2020-05-16 02:09:57] [INFO ] Added : 210 causal constraints over 42 iterations in 2271 ms. Result :sat
[2020-05-16 02:09:58] [INFO ] Deduced a trap composed of 32 places in 1593 ms
[2020-05-16 02:10:00] [INFO ] Deduced a trap composed of 31 places in 1460 ms
[2020-05-16 02:10:00] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 3175 ms
Attempting to minimize the solution found.
Minimization took 63 ms.
Incomplete Parikh walk after 57900 steps, including 1000 resets, run finished after 151 ms. (steps per millisecond=383 ) properties seen :[0] could not realise parikh vector
Support contains 28 out of 212 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 212/212 places, 455/455 transitions.
Applied a total of 0 rules in 12 ms. Remains 212 /212 variables (removed 0) and now considering 455/455 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 212/212 places, 455/455 transitions.
Starting structural reductions, iteration 0 : 212/212 places, 455/455 transitions.
Applied a total of 0 rules in 13 ms. Remains 212 /212 variables (removed 0) and now considering 455/455 (removed 0) transitions.
[2020-05-16 02:10:00] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 212 cols
[2020-05-16 02:10:00] [INFO ] Computed 65 place invariants in 3 ms
[2020-05-16 02:10:00] [INFO ] Implicit Places using invariants in 325 ms returned [128, 129, 130, 131, 132, 133, 134]
Discarding 7 places :
Implicit Place search using SMT only with invariants took 346 ms to find 7 implicit places.
[2020-05-16 02:10:00] [INFO ] Redundant transitions in 19 ms returned []
[2020-05-16 02:10:00] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:00] [INFO ] Computed 58 place invariants in 2 ms
[2020-05-16 02:10:03] [INFO ] Dead Transitions using invariants and state equation in 2565 ms returned []
Starting structural reductions, iteration 1 : 205/212 places, 455/455 transitions.
Applied a total of 0 rules in 10 ms. Remains 205 /205 variables (removed 0) and now considering 455/455 (removed 0) transitions.
[2020-05-16 02:10:03] [INFO ] Redundant transitions in 6 ms returned []
[2020-05-16 02:10:03] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:03] [INFO ] Computed 58 place invariants in 1 ms
[2020-05-16 02:10:04] [INFO ] Dead Transitions using invariants and state equation in 552 ms returned []
Finished structural reductions, in 2 iterations. Remains : 205/212 places, 455/455 transitions.
Incomplete random walk after 1000000 steps, including 0 resets, run finished after 1820 ms. (steps per millisecond=549 ) properties seen :[0]
Incomplete Best-First random walk after 1000001 steps, including 0 resets, run finished after 865 ms. (steps per millisecond=1156 ) properties seen :[0]
Interrupted probabilistic random walk after 17531264 steps, run timeout after 30001 ms. (steps per millisecond=584 ) properties seen :[0]
Probabilistic random walk after 17531264 steps, saw 2669199 distinct states, run finished after 30014 ms. (steps per millisecond=584 ) properties seen :[0]
[2020-05-16 02:10:36] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:36] [INFO ] Computed 58 place invariants in 2 ms
[2020-05-16 02:10:36] [INFO ] [Real]Absence check using 58 positive place invariants in 41 ms returned sat
[2020-05-16 02:10:36] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 02:10:37] [INFO ] [Real]Absence check using state equation in 201 ms returned sat
[2020-05-16 02:10:37] [INFO ] State equation strengthened by 56 read => feed constraints.
[2020-05-16 02:10:37] [INFO ] [Real]Added 56 Read/Feed constraints in 14 ms returned sat
[2020-05-16 02:10:37] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 02:10:37] [INFO ] [Nat]Absence check using 58 positive place invariants in 27 ms returned sat
[2020-05-16 02:10:37] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 02:10:37] [INFO ] [Nat]Absence check using state equation in 190 ms returned sat
[2020-05-16 02:10:37] [INFO ] [Nat]Added 56 Read/Feed constraints in 11 ms returned sat
[2020-05-16 02:10:37] [INFO ] Deduced a trap composed of 8 places in 68 ms
[2020-05-16 02:10:37] [INFO ] Deduced a trap composed of 30 places in 127 ms
[2020-05-16 02:10:37] [INFO ] Deduced a trap composed of 32 places in 81 ms
[2020-05-16 02:10:37] [INFO ] Deduced a trap composed of 28 places in 74 ms
[2020-05-16 02:10:37] [INFO ] Deduced a trap composed of 43 places in 74 ms
[2020-05-16 02:10:37] [INFO ] Deduced a trap composed of 20 places in 71 ms
[2020-05-16 02:10:38] [INFO ] Deduced a trap composed of 15 places in 122 ms
[2020-05-16 02:10:38] [INFO ] Deduced a trap composed of 24 places in 70 ms
[2020-05-16 02:10:38] [INFO ] Deduced a trap composed of 20 places in 71 ms
[2020-05-16 02:10:38] [INFO ] Deduced a trap composed of 20 places in 260 ms
[2020-05-16 02:10:38] [INFO ] Deduced a trap composed of 29 places in 365 ms
[2020-05-16 02:10:39] [INFO ] Deduced a trap composed of 8 places in 480 ms
[2020-05-16 02:10:39] [INFO ] Deduced a trap composed of 32 places in 89 ms
[2020-05-16 02:10:40] [INFO ] Deduced a trap composed of 8 places in 425 ms
[2020-05-16 02:10:40] [INFO ] Trap strengthening (SAT) tested/added 15/14 trap constraints in 2594 ms
[2020-05-16 02:10:40] [INFO ] Computed and/alt/rep : 448/3626/322 causal constraints in 17 ms.
[2020-05-16 02:10:41] [INFO ] Added : 226 causal constraints over 46 iterations in 1674 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 47 ms.
Incomplete Parikh walk after 67600 steps, including 1000 resets, run finished after 149 ms. (steps per millisecond=453 ) properties seen :[0] could not realise parikh vector
Support contains 28 out of 205 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 205/205 places, 455/455 transitions.
Applied a total of 0 rules in 19 ms. Remains 205 /205 variables (removed 0) and now considering 455/455 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 205/205 places, 455/455 transitions.
Starting structural reductions, iteration 0 : 205/205 places, 455/455 transitions.
Applied a total of 0 rules in 9 ms. Remains 205 /205 variables (removed 0) and now considering 455/455 (removed 0) transitions.
[2020-05-16 02:10:42] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:42] [INFO ] Computed 58 place invariants in 1 ms
[2020-05-16 02:10:42] [INFO ] Implicit Places using invariants in 437 ms returned []
[2020-05-16 02:10:42] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:42] [INFO ] Computed 58 place invariants in 1 ms
[2020-05-16 02:10:42] [INFO ] State equation strengthened by 56 read => feed constraints.
[2020-05-16 02:10:43] [INFO ] Implicit Places using invariants and state equation in 811 ms returned []
Implicit Place search using SMT with State Equation took 1260 ms to find 0 implicit places.
[2020-05-16 02:10:43] [INFO ] Redundant transitions in 5 ms returned []
[2020-05-16 02:10:43] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:43] [INFO ] Computed 58 place invariants in 2 ms
[2020-05-16 02:10:43] [INFO ] Dead Transitions using invariants and state equation in 461 ms returned []
Finished structural reductions, in 1 iterations. Remains : 205/205 places, 455/455 transitions.
Incomplete random walk after 100000 steps, including 0 resets, run finished after 186 ms. (steps per millisecond=537 ) properties seen :[0]
[2020-05-16 02:10:43] [INFO ] Flow matrix only has 329 transitions (discarded 126 similar events)
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:43] [INFO ] Computed 58 place invariants in 1 ms
[2020-05-16 02:10:44] [INFO ] [Real]Absence check using 58 positive place invariants in 98 ms returned sat
[2020-05-16 02:10:44] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 02:10:44] [INFO ] [Real]Absence check using state equation in 246 ms returned sat
[2020-05-16 02:10:44] [INFO ] State equation strengthened by 56 read => feed constraints.
[2020-05-16 02:10:44] [INFO ] [Real]Added 56 Read/Feed constraints in 17 ms returned sat
[2020-05-16 02:10:44] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 02:10:44] [INFO ] [Nat]Absence check using 58 positive place invariants in 20 ms returned sat
[2020-05-16 02:10:44] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 02:10:44] [INFO ] [Nat]Absence check using state equation in 134 ms returned sat
[2020-05-16 02:10:44] [INFO ] [Nat]Added 56 Read/Feed constraints in 10 ms returned sat
[2020-05-16 02:10:44] [INFO ] Deduced a trap composed of 8 places in 126 ms
[2020-05-16 02:10:44] [INFO ] Deduced a trap composed of 30 places in 63 ms
[2020-05-16 02:10:44] [INFO ] Deduced a trap composed of 32 places in 67 ms
[2020-05-16 02:10:44] [INFO ] Deduced a trap composed of 28 places in 68 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 43 places in 63 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 20 places in 76 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 15 places in 62 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 24 places in 74 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 20 places in 64 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 20 places in 82 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 29 places in 68 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 8 places in 71 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 32 places in 76 ms
[2020-05-16 02:10:45] [INFO ] Deduced a trap composed of 8 places in 10 ms
[2020-05-16 02:10:45] [INFO ] Trap strengthening (SAT) tested/added 15/14 trap constraints in 1190 ms
[2020-05-16 02:10:45] [INFO ] Computed and/alt/rep : 448/3626/322 causal constraints in 16 ms.
[2020-05-16 02:10:47] [INFO ] Added : 226 causal constraints over 46 iterations in 1693 ms. Result :sat
Ensure Unique test removed 126 transitions
Reduce isomorphic transitions removed 126 transitions.
Iterating post reduction 0 with 126 rules applied. Total rules applied 126 place count 205 transition count 329
Performed 49 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 1 with 49 Pre rules applied. Total rules applied 126 place count 205 transition count 280
Deduced a syphon composed of 49 places in 0 ms
Ensure Unique test removed 42 places
Reduce places removed 91 places and 0 transitions.
Iterating global reduction 1 with 140 rules applied. Total rules applied 266 place count 114 transition count 280
Performed 7 Post agglomeration using F-continuation condition.Transition count delta: 7
Deduced a syphon composed of 7 places in 0 ms
Reduce places removed 7 places and 0 transitions.
Iterating global reduction 1 with 14 rules applied. Total rules applied 280 place count 107 transition count 273
Free-agglomeration rule applied 14 times.
Iterating global reduction 1 with 14 rules applied. Total rules applied 294 place count 107 transition count 259
Reduce places removed 14 places and 0 transitions.
Iterating post reduction 1 with 14 rules applied. Total rules applied 308 place count 93 transition count 259
Partial Free-agglomeration rule applied 7 times.
Drop transitions removed 7 transitions
Iterating global reduction 2 with 7 rules applied. Total rules applied 315 place count 93 transition count 259
Drop transitions removed 7 transitions
Redundant transition composition rules discarded 7 transitions
Iterating global reduction 2 with 7 rules applied. Total rules applied 322 place count 93 transition count 252
Applied a total of 322 rules in 21 ms. Remains 93 /205 variables (removed 112) and now considering 252/455 (removed 203) transitions.
// Phase 1: matrix 252 rows 93 cols
[2020-05-16 02:10:47] [INFO ] Computed 16 place invariants in 0 ms
[2020-05-16 02:10:47] [INFO ] [Real]Absence check using 16 positive place invariants in 81 ms returned sat
[2020-05-16 02:10:47] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-05-16 02:10:47] [INFO ] [Real]Absence check using state equation in 155 ms returned sat
[2020-05-16 02:10:47] [INFO ] Computed and/alt/rep : 238/1897/238 causal constraints in 11 ms.
[2020-05-16 02:10:47] [INFO ] Solution in real domain found non-integer solution.
[2020-05-16 02:10:47] [INFO ] [Nat]Absence check using 16 positive place invariants in 32 ms returned sat
[2020-05-16 02:10:47] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-05-16 02:10:47] [INFO ] [Nat]Absence check using state equation in 67 ms returned sat
[2020-05-16 02:10:47] [INFO ] Computed and/alt/rep : 238/1897/238 causal constraints in 26 ms.
[2020-05-16 02:10:49] [INFO ] Added : 189 causal constraints over 38 iterations in 1120 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 19 ms.
[2020-05-16 02:10:49] [INFO ] Flatten gal took : 121 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
[2020-05-16 02:10:49] [INFO ] Applying decomposition
[2020-05-16 02:10:49] [INFO ] Flatten gal took : 114 ms
[2020-05-16 02:10:49] [INFO ] Flatten gal took : 142 ms
[2020-05-16 02:10:49] [INFO ] Input system was already deterministic with 455 transitions.
[2020-05-16 02:10:49] [INFO ] Input system was already deterministic with 455 transitions.
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 329 out of 455 initially.
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:50] [INFO ] Computed 58 place invariants in 6 ms
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 + P_wait_2_2 + P_done_2_2 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 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 + P_wait_1_7 + P_done_1_7 + 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 + P_wait_4_6 + P_done_4_6 + 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 + P_wait_7_6 + P_done_7_6 + 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 + P_wait_5_2 + P_done_5_2 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 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 + P_wait_4_7 + P_done_4_7 + 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 + P_wait_7_5 + P_done_7_5 + 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 + P_wait_5_1 + P_done_5_1 + 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 + P_wait_1_5 + P_done_1_5 + 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 + P_wait_5_3 + P_done_5_3 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : y_0 + y_1 + y_2 + y_3 + y_4 + y_5 + y_6 + y_7 = 1
inv : P_b_4_false + P_b_4_true = 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 + P_wait_2_3 + P_done_2_3 + 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 + P_wait_4_5 + P_done_4_5 + 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 + P_wait_6_7 + P_done_6_7 + 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 + P_wait_5_5 + P_done_5_5 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 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 + P_wait_4_3 + P_done_4_3 + 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 + P_wait_6_1 + P_done_6_1 + 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 + P_wait_1_4 + P_done_1_4 + 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 + P_wait_7_4 + P_done_7_4 + 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 + P_wait_3_6 + P_done_3_6 + 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 + P_wait_2_7 + P_done_2_7 + 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 + P_wait_2_4 + P_done_2_4 + 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 + P_wait_2_1 + P_done_2_1 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 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 + P_wait_7_1 + P_done_7_1 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_b_5_false + P_b_5_true = 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 + P_wait_7_7 + P_done_7_7 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_b_7_false + P_b_7_true = 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 + P_wait_3_4 + P_done_3_4 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_b_2_false + P_b_2_true = 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 + P_wait_6_4 + P_done_6_4 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : x_0 + x_1 + x_2 + x_3 + x_4 + x_5 + x_6 + x_7 = 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 + P_wait_1_1 + P_done_1_1 + 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 + P_wait_3_3 + P_done_3_3 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_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 + P_wait_5_7 + P_done_5_7 + 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 + P_wait_6_5 + P_done_6_5 + 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 + P_wait_6_2 + P_done_6_2 + 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 + P_wait_1_2 + P_done_1_2 + 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 + P_wait_4_2 + P_done_4_2 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 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 + P_wait_3_7 + P_done_3_7 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_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 + P_wait_5_6 + P_done_5_6 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_b_1_false + P_b_1_true = 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 + P_wait_3_1 + P_done_3_1 + 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 + P_wait_7_2 + P_done_7_2 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 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 + P_wait_2_6 + P_done_2_6 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 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 + P_wait_5_4 + P_done_5_4 + 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 + P_wait_7_3 + P_done_7_3 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_b_3_false + P_b_3_true = 1
inv : P_b_6_false + P_b_6_true = 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 + P_wait_2_5 + P_done_2_5 + 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 + P_wait_4_1 + P_done_4_1 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 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 + P_wait_3_2 + P_done_3_2 + 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 + P_wait_4_4 + P_done_4_4 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 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 + P_wait_3_5 + P_done_3_5 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 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 + P_wait_6_6 + P_done_6_6 + 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 + P_wait_1_3 + P_done_1_3 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 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 + P_wait_6_3 + P_done_6_3 + 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 + P_wait_1_6 + P_done_1_6 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
Total of 58 invariants.
[2020-05-16 02:10:50] [INFO ] Computed 58 place invariants in 10 ms
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/graph4046704378312624708.txt, -o, /tmp/graph4046704378312624708.bin, -w, /tmp/graph4046704378312624708.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/graph4046704378312624708.bin, -l, -1, -v, -w, /tmp/graph4046704378312624708.weights, -q, 0, -e, 0.001], workingDir=null]
[2020-05-16 02:10:50] [INFO ] Decomposing Gal with order
[2020-05-16 02:10:50] [INFO ] Rewriting arrays to variables to allow decomposition.
[2020-05-16 02:10:50] [INFO ] Ran tautology test, simplified 0 / 1 in 730 ms.
[2020-05-16 02:10:50] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=0 took 30 ms
[2020-05-16 02:10:50] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=1 took 6 ms
[2020-05-16 02:10:50] [INFO ] Removed a total of 506 redundant transitions.
[2020-05-16 02:10:50] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=2 took 259 ms
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 329 out of 455 initially.
// Phase 1: matrix 329 rows 205 cols
[2020-05-16 02:10:50] [INFO ] Computed 58 place invariants in 1 ms
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 + P_wait_2_2 + P_done_2_2 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 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 + P_wait_1_7 + P_done_1_7 + 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 + P_wait_4_6 + P_done_4_6 + 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 + P_wait_7_6 + P_done_7_6 + 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 + P_wait_5_2 + P_done_5_2 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 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 + P_wait_4_7 + P_done_4_7 + 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 + P_wait_7_5 + P_done_7_5 + 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 + P_wait_5_1 + P_done_5_1 + 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 + P_wait_1_5 + P_done_1_5 + 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 + P_wait_5_3 + P_done_5_3 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : y_0 + y_1 + y_2 + y_3 + y_4 + y_5 + y_6 + y_7 = 1
inv : P_b_4_false + P_b_4_true = 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 + P_wait_2_3 + P_done_2_3 + 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 + P_wait_4_5 + P_done_4_5 + 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 + P_wait_6_7 + P_done_6_7 + 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 + P_wait_5_5 + P_done_5_5 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 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 + P_wait_4_3 + P_done_4_3 + 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 + P_wait_6_1 + P_done_6_1 + 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 + P_wait_1_4 + P_done_1_4 + 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 + P_wait_7_4 + P_done_7_4 + 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 + P_wait_3_6 + P_done_3_6 + 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 + P_wait_2_7 + P_done_2_7 + 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 + P_wait_2_4 + P_done_2_4 + 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 + P_wait_2_1 + P_done_2_1 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 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 + P_wait_7_1 + P_done_7_1 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_b_5_false + P_b_5_true = 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 + P_wait_7_7 + P_done_7_7 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_b_7_false + P_b_7_true = 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 + P_wait_3_4 + P_done_3_4 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 1
inv : P_b_2_false + P_b_2_true = 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 + P_wait_6_4 + P_done_6_4 + P_ifyi_15_6 + P_awaity_6 + P_CS_21_6 + P_setbi_24_6 = 1
inv : x_0 + x_1 + x_2 + x_3 + x_4 + x_5 + x_6 + x_7 = 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 + P_wait_1_1 + P_done_1_1 + 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 + P_wait_3_3 + P_done_3_3 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_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 + P_wait_5_7 + P_done_5_7 + 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 + P_wait_6_5 + P_done_6_5 + 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 + P_wait_6_2 + P_done_6_2 + 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 + P_wait_1_2 + P_done_1_2 + 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 + P_wait_4_2 + P_done_4_2 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 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 + P_wait_3_7 + P_done_3_7 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_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 + P_wait_5_6 + P_done_5_6 + P_ifyi_15_5 + P_awaity_5 + P_CS_21_5 + P_setbi_24_5 = 1
inv : P_b_1_false + P_b_1_true = 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 + P_wait_3_1 + P_done_3_1 + 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 + P_wait_7_2 + P_done_7_2 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 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 + P_wait_2_6 + P_done_2_6 + P_ifyi_15_2 + P_awaity_2 + P_CS_21_2 + P_setbi_24_2 = 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 + P_wait_5_4 + P_done_5_4 + 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 + P_wait_7_3 + P_done_7_3 + P_ifyi_15_7 + P_awaity_7 + P_CS_21_7 + P_setbi_24_7 = 1
inv : P_b_3_false + P_b_3_true = 1
inv : P_b_6_false + P_b_6_true = 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 + P_wait_2_5 + P_done_2_5 + 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 + P_wait_4_1 + P_done_4_1 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 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 + P_wait_3_2 + P_done_3_2 + 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 + P_wait_4_4 + P_done_4_4 + P_ifyi_15_4 + P_awaity_4 + P_CS_21_4 + P_setbi_24_4 = 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 + P_wait_3_5 + P_done_3_5 + P_ifyi_15_3 + P_awaity_3 + P_CS_21_3 + P_setbi_24_3 = 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 + P_wait_6_6 + P_done_6_6 + 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 + P_wait_1_3 + P_done_1_3 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 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 + P_wait_6_3 + P_done_6_3 + 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 + P_wait_1_6 + P_done_1_6 + P_ifyi_15_1 + P_awaity_1 + P_CS_21_1 + P_setbi_24_1 = 1
Total of 58 invariants.
[2020-05-16 02:10:50] [INFO ] Computed 58 place invariants in 2 ms
[2020-05-16 02:10:51] [INFO ] Flatten gal took : 554 ms
[2020-05-16 02:10:51] [INFO ] Fuse similar labels procedure discarded/fused a total of 299 labels/synchronizations in 80 ms.
[2020-05-16 02:10:51] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityCardinality.pnml.gal : 6 ms
[2020-05-16 02:10:51] [INFO ] Time to serialize properties into /home/mcc/execution/ReachabilityCardinality.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/ReachabilityCardinality.pnml.gal, -t, CGAL, -reachable-file, ReachabilityCardinality.prop, --nowitness, --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/ReachabilityCardinality.pnml.gal -t CGAL -reachable-file ReachabilityCardinality.prop --nowitness --gen-order FOLLOW
Loading property file ReachabilityCardinality.prop.
Read [invariant] property : LamportFastMutEx-PT-7-ReachabilityCardinality-06 with value :((((((((((gu61.P_ifyi_15_1+gu61.P_ifyi_15_2)+gu61.P_ifyi_15_3)+gu61.P_ifyi_15_4)+gu61.P_ifyi_15_5)+gu61.P_ifyi_15_6)+gu61.P_ifyi_15_7)>((((((gu61.P_CS_21_1+gu61.P_CS_21_2)+gu61.P_CS_21_3)+gu61.P_CS_21_4)+gu61.P_CS_21_5)+gu61.P_CS_21_6)+gu61.P_CS_21_7))||(((((((gu61.P_CS_21_1+gu61.P_CS_21_2)+gu61.P_CS_21_3)+gu61.P_CS_21_4)+gu61.P_CS_21_5)+gu61.P_CS_21_6)+gu61.P_CS_21_7)<2))||(((((((gu4.P_setbi_5_1+gu4.P_setbi_5_2)+gu4.P_setbi_5_3)+gu4.P_setbi_5_4)+gu4.P_setbi_5_5)+gu4.P_setbi_5_6)+gu4.P_setbi_5_7)<3))||(((((((gu3.P_setx_3_1+gu3.P_setx_3_2)+gu3.P_setx_3_3)+gu3.P_setx_3_4)+gu3.P_setx_3_5)+gu3.P_setx_3_6)+gu3.P_setx_3_7)<1))
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
[2020-05-16 02:10:52] [INFO ] Proved 205 variables to be positive in 2038 ms
[2020-05-16 02:10:52] [INFO ] Computing symmetric may disable matrix : 455 transitions.
[2020-05-16 02:10:52] [INFO ] Computation of disable matrix completed :0/455 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 02:10:52] [INFO ] Computation of Complete disable matrix. took 93 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 02:10:52] [INFO ] Computing symmetric may enable matrix : 455 transitions.
[2020-05-16 02:10:52] [INFO ] Computation of Complete enable matrix. took 40 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 02:10:52] [INFO ] Proved 205 variables to be positive in 1666 ms
[2020-05-16 02:10:52] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:10:52] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=0 took 11 ms
[2020-05-16 02:10:52] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:10:52] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=1 took 73 ms
SDD proceeding with computation, new max is 4096
[2020-05-16 02:10:54] [INFO ] Computing symmetric co enabling matrix : 455 transitions.
SDD proceeding with computation, new max is 8192
[2020-05-16 02:10:54] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=3 took 4160 ms
[2020-05-16 02:10:55] [INFO ] Computation of co-enabling matrix(14/455) took 1128 ms. Total solver calls (SAT/UNSAT): 1131(54/1077)
SDD proceeding with computation, new max is 16384
[2020-05-16 02:10:58] [INFO ] Computation of co-enabling matrix(35/455) took 4202 ms. Total solver calls (SAT/UNSAT): 4218(286/3932)
[2020-05-16 02:11:01] [INFO ] Computation of co-enabling matrix(58/455) took 7300 ms. Total solver calls (SAT/UNSAT): 7093(477/6616)
SDD proceeding with computation, new max is 32768
[2020-05-16 02:11:04] [INFO ] Computation of co-enabling matrix(79/455) took 10499 ms. Total solver calls (SAT/UNSAT): 10756(783/9973)
[2020-05-16 02:11:07] [INFO ] Computation of co-enabling matrix(92/455) took 13556 ms. Total solver calls (SAT/UNSAT): 13824(1071/12753)
[2020-05-16 02:11:10] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:11:10] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=2 took 17307 ms
[2020-05-16 02:11:12] [INFO ] Computation of co-enabling matrix(99/455) took 18523 ms. Total solver calls (SAT/UNSAT): 15406(1216/14190)
[2020-05-16 02:11:16] [INFO ] Computation of co-enabling matrix(101/455) took 22677 ms. Total solver calls (SAT/UNSAT): 15849(1256/14593)
SDD proceeding with computation, new max is 65536
[2020-05-16 02:11:20] [INFO ] Computation of co-enabling matrix(103/455) took 25869 ms. Total solver calls (SAT/UNSAT): 16288(1296/14992)
[2020-05-16 02:11:24] [INFO ] Computation of co-enabling matrix(106/455) took 29842 ms. Total solver calls (SAT/UNSAT): 16939(1354/15585)
[2020-05-16 02:11:27] [INFO ] Computation of co-enabling matrix(110/455) took 33479 ms. Total solver calls (SAT/UNSAT): 17793(1430/16363)
[2020-05-16 02:11:32] [INFO ] Computation of co-enabling matrix(113/455) took 37747 ms. Total solver calls (SAT/UNSAT): 18423(1485/16938)
[2020-05-16 02:11:36] [INFO ] Computation of co-enabling matrix(116/455) took 41743 ms. Total solver calls (SAT/UNSAT): 19044(1539/17505)
[2020-05-16 02:11:39] [INFO ] Computation of co-enabling matrix(121/455) took 45003 ms. Total solver calls (SAT/UNSAT): 19611(1587/18024)
[2020-05-16 02:11:42] [INFO ] Computation of co-enabling matrix(130/455) took 48299 ms. Total solver calls (SAT/UNSAT): 20083(1611/18472)
[2020-05-16 02:11:45] [INFO ] Computation of co-enabling matrix(135/455) took 51463 ms. Total solver calls (SAT/UNSAT): 20788(1704/19084)
[2020-05-16 02:11:47] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:11:47] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=3 took 37489 ms
[2020-05-16 02:11:50] [INFO ] Computation of co-enabling matrix(139/455) took 55807 ms. Total solver calls (SAT/UNSAT): 21574(1806/19768)
SDD proceeding with computation, new max is 131072
[2020-05-16 02:11:50] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=4 took 55686 ms
[2020-05-16 02:11:53] [INFO ] Computation of co-enabling matrix(142/455) took 59271 ms. Total solver calls (SAT/UNSAT): 22153(1875/20278)
[2020-05-16 02:11:56] [INFO ] Computation of co-enabling matrix(145/455) took 62615 ms. Total solver calls (SAT/UNSAT): 22723(1935/20788)
[2020-05-16 02:12:00] [INFO ] Computation of co-enabling matrix(149/455) took 66256 ms. Total solver calls (SAT/UNSAT): 23469(2007/21462)
[2020-05-16 02:12:04] [INFO ] Computation of co-enabling matrix(155/455) took 70231 ms. Total solver calls (SAT/UNSAT): 24558(2114/22444)
[2020-05-16 02:12:08] [INFO ] Computation of co-enabling matrix(157/455) took 74052 ms. Total solver calls (SAT/UNSAT): 24913(2148/22765)
[2020-05-16 02:12:11] [INFO ] Computation of co-enabling matrix(171/455) took 77197 ms. Total solver calls (SAT/UNSAT): 27286(2376/24910)
[2020-05-16 02:12:15] [INFO ] Computation of co-enabling matrix(201/455) took 80859 ms. Total solver calls (SAT/UNSAT): 31711(2781/28930)
[2020-05-16 02:12:18] [INFO ] Computation of co-enabling matrix(259/455) took 83875 ms. Total solver calls (SAT/UNSAT): 34985(3022/31963)
[2020-05-16 02:12:21] [INFO ] Computation of co-enabling matrix(334/455) took 87235 ms. Total solver calls (SAT/UNSAT): 39055(3483/35572)
[2020-05-16 02:12:24] [INFO ] Computation of co-enabling matrix(343/455) took 90348 ms. Total solver calls (SAT/UNSAT): 39820(3559/36261)
[2020-05-16 02:12:27] [INFO ] Computation of co-enabling matrix(353/455) took 93483 ms. Total solver calls (SAT/UNSAT): 40575(3633/36942)
[2020-05-16 02:12:30] [INFO ] Computation of co-enabling matrix(366/455) took 96503 ms. Total solver calls (SAT/UNSAT): 41281(3696/37585)
[2020-05-16 02:12:33] [INFO ] Computation of Finished co-enabling matrix. took 99348 ms. Total solver calls (SAT/UNSAT): 43141(3864/39277)
[2020-05-16 02:12:33] [INFO ] Computing Do-Not-Accords matrix : 455 transitions.
[2020-05-16 02:12:33] [INFO ] Computation of Completed DNA matrix. took 37 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-16 02:12:33] [INFO ] Built C files in 104093ms 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 9405 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 79 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, LamportFastMutExPT7ReachabilityCardinality06==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, LamportFastMutExPT7ReachabilityCardinality06==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, LamportFastMutExPT7ReachabilityCardinality06==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)
SDD proceeding with computation, new max is 262144
[2020-05-16 02:13:59] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:13:59] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=4 took 131608 ms
[2020-05-16 02:14:03] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:14:03] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=5 took 4028 ms
[2020-05-16 02:14:14] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=5 took 143431 ms
SDD proceeding with computation, new max is 524288
[2020-05-16 02:18:11] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=6 took 237267 ms
SDD proceeding with computation, new max is 1048576
[2020-05-16 02:19:55] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:19:55] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=6 took 351744 ms
[2020-05-16 02:24:00] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=7 took 348833 ms
[2020-05-16 02:27:32] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:27:32] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=7 took 457569 ms
SDD proceeding with computation, new max is 2097152
Detected timeout of ITS tools.
[2020-05-16 02:31:25] [INFO ] Flatten gal took : 458 ms
[2020-05-16 02:31:26] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityCardinality.pnml.gal : 30 ms
[2020-05-16 02:31:26] [INFO ] Time to serialize properties into /home/mcc/execution/ReachabilityCardinality.prop : 2 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/ReachabilityCardinality.pnml.gal, -t, CGAL, -reachable-file, ReachabilityCardinality.prop, --nowitness, --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/ReachabilityCardinality.pnml.gal -t CGAL -reachable-file ReachabilityCardinality.prop --nowitness --gen-order FOLLOW
Loading property file ReachabilityCardinality.prop.
Read [invariant] property : LamportFastMutEx-PT-7-ReachabilityCardinality-06 with value :((((((((((P_ifyi_15_1+P_ifyi_15_2)+P_ifyi_15_3)+P_ifyi_15_4)+P_ifyi_15_5)+P_ifyi_15_6)+P_ifyi_15_7)>((((((P_CS_21_1+P_CS_21_2)+P_CS_21_3)+P_CS_21_4)+P_CS_21_5)+P_CS_21_6)+P_CS_21_7))||(((((((P_CS_21_1+P_CS_21_2)+P_CS_21_3)+P_CS_21_4)+P_CS_21_5)+P_CS_21_6)+P_CS_21_7)<2))||(((((((P_setbi_5_1+P_setbi_5_2)+P_setbi_5_3)+P_setbi_5_4)+P_setbi_5_5)+P_setbi_5_6)+P_setbi_5_7)<3))||(((((((P_setx_3_1+P_setx_3_2)+P_setx_3_3)+P_setx_3_4)+P_setx_3_5)+P_setx_3_6)+P_setx_3_7)<1))
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:37:07] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:37:07] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=8 took 575022 ms
SDD proceeding with computation, new max is 1048576
[2020-05-16 02:39:12] [INFO ] BMC solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(UNSAT) depth K=8 took 911822 ms
SDD proceeding with computation, new max is 2097152
[2020-05-16 02:49:19] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesLamportFastMutEx-PT-7-ReachabilityCardinality-06
[2020-05-16 02:49:19] [INFO ] KInduction solution for property LamportFastMutEx-PT-7-ReachabilityCardinality-06(SAT) depth K=9 took 731744 ms
Detected timeout of ITS tools.
[2020-05-16 02:51:59] [INFO ] Flatten gal took : 48 ms
[2020-05-16 02:51:59] [INFO ] Input system was already deterministic with 455 transitions.
[2020-05-16 02:51:59] [INFO ] Transformed 205 places.
[2020-05-16 02:51:59] [INFO ] Transformed 455 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:52:00] [INFO ] Time to serialize gal into /home/mcc/execution/ReachabilityCardinality.pnml.gal : 2 ms
[2020-05-16 02:52:00] [INFO ] Time to serialize properties into /home/mcc/execution/ReachabilityCardinality.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/ReachabilityCardinality.pnml.gal, -t, CGAL, -reachable-file, ReachabilityCardinality.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/ReachabilityCardinality.pnml.gal -t CGAL -reachable-file ReachabilityCardinality.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 ReachabilityCardinality.prop.
Read [invariant] property : LamportFastMutEx-PT-7-ReachabilityCardinality-06 with value :((((((((((P_ifyi_15_1+P_ifyi_15_2)+P_ifyi_15_3)+P_ifyi_15_4)+P_ifyi_15_5)+P_ifyi_15_6)+P_ifyi_15_7)>((((((P_CS_21_1+P_CS_21_2)+P_CS_21_3)+P_CS_21_4)+P_CS_21_5)+P_CS_21_6)+P_CS_21_7))||(((((((P_CS_21_1+P_CS_21_2)+P_CS_21_3)+P_CS_21_4)+P_CS_21_5)+P_CS_21_6)+P_CS_21_7)<2))||(((((((P_setbi_5_1+P_setbi_5_2)+P_setbi_5_3)+P_setbi_5_4)+P_setbi_5_5)+P_setbi_5_6)+P_setbi_5_7)<3))||(((((((P_setx_3_1+P_setx_3_2)+P_setx_3_3)+P_setx_3_4)+P_setx_3_5)+P_setx_3_6)+P_setx_3_7)<1))
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

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
+ [[ ReachabilityCardinality = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution ReachabilityCardinality -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 ReachabilityCardinality -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-PT-7"
export BK_EXAMINATION="ReachabilityCardinality"
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-PT-7, examination is ReachabilityCardinality"
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-158940145400686"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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