Execution Chart

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

Trace from the execution

Formatting '/data/fko/mcc2021-input.r159-oct2-162089268400446.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2021-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 PolyORBNT-PT-S05J20, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r159-oct2-162089268400446
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 3.7M
-rw-r--r-- 1 mcc users 57K May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 260K May 10 09:43 CTLCardinality.xml
-rw-r--r-- 1 mcc users 286K May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 1.2M May 10 09:43 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 6 14:48 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K May 6 14:48 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 10K Mar 28 16:27 LTLCardinality.txt
-rw-r--r-- 1 mcc users 42K Mar 28 16:27 LTLCardinality.xml
-rw-r--r-- 1 mcc users 39K Mar 28 16:27 LTLFireability.txt
-rw-r--r-- 1 mcc users 129K Mar 28 16:27 LTLFireability.xml
-rw-r--r-- 1 mcc users 9.8K Mar 27 09:31 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 35K Mar 27 09:31 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 21K Mar 25 12:18 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 63K Mar 25 12:18 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 3.0K Mar 22 08:12 UpperBounds.txt
-rw-r--r-- 1 mcc users 6.3K Mar 22 08:12 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_col
-rw-r--r-- 1 mcc users 7 May 5 16:51 instance
-rw-r--r-- 1 mcc users 6 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 1.6M May 5 16:51 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

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

=== Now, execution of the tool begins

BK_START 1621221306460

Running Version 0
[2021-05-17 03:15:09] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityCardinality, -spotpath, /home/mcc/BenchKit/bin//..//ltlfilt, -z3path, /home/mcc/BenchKit/bin//..//z3/bin/z3, -yices2path, /home/mcc/BenchKit/bin//..//yices/bin/yices, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2021-05-17 03:15:09] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-17 03:15:09] [INFO ] Load time of PNML (sax parser for PT used): 118 ms
[2021-05-17 03:15:09] [INFO ] Transformed 349 places.
[2021-05-17 03:15:09] [INFO ] Transformed 1210 transitions.
[2021-05-17 03:15:09] [INFO ] Parsed PT model containing 349 places and 1210 transitions in 163 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 26 ms.
Working with output stream class java.io.PrintStream
Ensure Unique test removed 655 transitions
Reduce redundant transitions removed 655 transitions.
Incomplete random walk after 10000 steps, including 703 resets, run finished after 172 ms. (steps per millisecond=58 ) properties (out of 16) seen :5
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-12 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-08 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-03 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-00 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 251 resets, run finished after 36 ms. (steps per millisecond=277 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 161 resets, run finished after 23 ms. (steps per millisecond=434 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 303 resets, run finished after 46 ms. (steps per millisecond=217 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 189 resets, run finished after 20 ms. (steps per millisecond=500 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 287 resets, run finished after 44 ms. (steps per millisecond=227 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 187 resets, run finished after 56 ms. (steps per millisecond=178 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 17 ms. (steps per millisecond=588 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 181 resets, run finished after 35 ms. (steps per millisecond=285 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 201 resets, run finished after 21 ms. (steps per millisecond=476 ) properties (out of 11) seen :1
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-11 FALSE TECHNIQUES TOPOLOGICAL BESTFIRST_WALK
Incomplete Best-First random walk after 10001 steps, including 157 resets, run finished after 16 ms. (steps per millisecond=625 ) properties (out of 10) seen :0
Incomplete Best-First random walk after 10001 steps, including 28 resets, run finished after 15 ms. (steps per millisecond=666 ) properties (out of 10) seen :1
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-10 TRUE TECHNIQUES TOPOLOGICAL BESTFIRST_WALK
Running SMT prover for 9 properties.
[2021-05-17 03:15:10] [INFO ] Flow matrix only has 551 transitions (discarded 4 similar events)
// Phase 1: matrix 551 rows 349 cols
[2021-05-17 03:15:10] [INFO ] Computed 62 place invariants in 99 ms
[2021-05-17 03:15:10] [INFO ] [Real]Absence check using 42 positive place invariants in 32 ms returned sat
[2021-05-17 03:15:10] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 20 ms returned sat
[2021-05-17 03:15:10] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:15:11] [INFO ] [Real]Absence check using state equation in 481 ms returned sat
[2021-05-17 03:15:11] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:15:11] [INFO ] [Nat]Absence check using 42 positive place invariants in 9 ms returned sat
[2021-05-17 03:15:11] [INFO ] [Nat]Absence check using 42 positive and 20 generalized place invariants in 15 ms returned sat
[2021-05-17 03:15:11] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:15:11] [INFO ] [Nat]Absence check using state equation in 307 ms returned sat
[2021-05-17 03:15:11] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:15:11] [INFO ] [Nat]Added 1 Read/Feed constraints in 132 ms returned sat
[2021-05-17 03:15:11] [INFO ] Computed and/alt/rep : 349/889/349 causal constraints (skipped 196 transitions) in 109 ms.
[2021-05-17 03:15:12] [INFO ] Added : 13 causal constraints over 3 iterations in 407 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 6 ms.
[2021-05-17 03:15:12] [INFO ] [Real]Absence check using 42 positive place invariants in 12 ms returned sat
[2021-05-17 03:15:12] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 9 ms returned sat
[2021-05-17 03:15:12] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:15:12] [INFO ] [Real]Absence check using state equation in 170 ms returned sat
[2021-05-17 03:15:12] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:15:12] [INFO ] [Nat]Absence check using 42 positive place invariants in 8 ms returned sat
[2021-05-17 03:15:12] [INFO ] [Nat]Absence check using 42 positive and 20 generalized place invariants in 17 ms returned sat
[2021-05-17 03:15:12] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:15:13] [INFO ] [Nat]Absence check using state equation in 358 ms returned sat
[2021-05-17 03:15:13] [INFO ] [Nat]Added 1 Read/Feed constraints in 1 ms returned sat
[2021-05-17 03:15:13] [INFO ] Computed and/alt/rep : 349/889/349 causal constraints (skipped 196 transitions) in 97 ms.
[2021-05-17 03:15:14] [INFO ] Added : 38 causal constraints over 8 iterations in 938 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 5 ms.
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive place invariants in 9 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 9 ms returned unsat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive place invariants in 7 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 10 ms returned unsat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive place invariants in 8 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 10 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using state equation in 229 ms returned sat
[2021-05-17 03:15:14] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:15:14] [INFO ] [Nat]Absence check using 42 positive place invariants in 9 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Nat]Absence check using 42 positive and 20 generalized place invariants in 13 ms returned unsat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive place invariants in 19 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 15 ms returned unsat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive place invariants in 8 ms returned unsat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive place invariants in 10 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 10 ms returned sat
[2021-05-17 03:15:14] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:15:15] [INFO ] [Real]Absence check using state equation in 175 ms returned sat
[2021-05-17 03:15:15] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:15:15] [INFO ] [Nat]Absence check using 42 positive place invariants in 3 ms returned unsat
[2021-05-17 03:15:15] [INFO ] [Real]Absence check using 42 positive place invariants in 7 ms returned sat
[2021-05-17 03:15:15] [INFO ] [Real]Absence check using 42 positive and 20 generalized place invariants in 39 ms returned unsat
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-14 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-13 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-09 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-07 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-06 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-05 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-04 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Fused 9 Parikh solutions to 2 different solutions.
Incomplete Parikh walk after 3500 steps, including 203 resets, run finished after 20 ms. (steps per millisecond=175 ) properties (out of 2) seen :0 could not realise parikh vector
Incomplete Parikh walk after 14500 steps, including 996 resets, run finished after 56 ms. (steps per millisecond=258 ) properties (out of 2) seen :0 could not realise parikh vector
Support contains 91 out of 349 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 349/349 places, 555/555 transitions.
Ensure Unique test removed 5 places
Drop transitions removed 3 transitions
Trivial Post-agglo rules discarded 3 transitions
Performed 3 trivial Post agglomeration. Transition count delta: 3
Iterating post reduction 0 with 8 rules applied. Total rules applied 8 place count 344 transition count 552
Reduce places removed 3 places and 0 transitions.
Iterating post reduction 1 with 3 rules applied. Total rules applied 11 place count 341 transition count 552
Performed 3 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 3 Pre rules applied. Total rules applied 11 place count 341 transition count 549
Deduced a syphon composed of 3 places in 1 ms
Reduce places removed 3 places and 0 transitions.
Iterating global reduction 2 with 6 rules applied. Total rules applied 17 place count 338 transition count 549
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 2 with 4 rules applied. Total rules applied 21 place count 336 transition count 547
Applied a total of 21 rules in 78 ms. Remains 336 /349 variables (removed 13) and now considering 547/555 (removed 8) transitions.
[2021-05-17 03:15:15] [INFO ] Flow matrix only has 543 transitions (discarded 4 similar events)
// Phase 1: matrix 543 rows 336 cols
[2021-05-17 03:15:15] [INFO ] Computed 57 place invariants in 12 ms
[2021-05-17 03:15:22] [INFO ] Dead Transitions using invariants and state equation in 7503 ms returned [415, 416, 417, 418, 419, 421, 422, 423, 424, 426, 428, 429, 431, 432, 433, 434, 435, 436, 438, 442, 445, 446, 447, 448, 450, 451, 452, 453, 454, 455, 456, 457, 459, 460, 461, 463, 465, 466, 467, 468, 469, 470, 471, 472, 473, 475, 476, 477, 478, 479, 480, 481, 482, 485, 486, 487, 489, 490, 492, 493, 494, 495, 496, 497, 498, 499, 500, 501, 503, 504, 505, 506, 507, 508, 509, 510, 511, 513, 515, 517, 518, 521, 522, 523, 526, 527, 530, 531, 532, 533, 535, 536, 537, 538, 539]
Found 95 dead transitions using SMT.
Drop transitions removed 95 transitions
Dead transitions reduction (with SMT) triggered by suspicious arc values removed 95 transitions :[539, 538, 537, 536, 535, 533, 532, 531, 530, 527, 526, 523, 522, 521, 518, 517, 515, 513, 511, 510, 509, 508, 507, 506, 505, 504, 503, 501, 500, 499, 498, 497, 496, 495, 494, 493, 492, 490, 489, 487, 486, 485, 482, 481, 480, 479, 478, 477, 476, 475, 473, 472, 471, 470, 469, 468, 467, 466, 465, 463, 461, 460, 459, 457, 456, 455, 454, 453, 452, 451, 450, 448, 447, 446, 445, 442, 438, 436, 435, 434, 433, 432, 431, 429, 428, 426, 424, 423, 422, 421, 419, 418, 417, 416, 415]
Starting structural reductions, iteration 1 : 336/349 places, 452/555 transitions.
Applied a total of 0 rules in 55 ms. Remains 336 /336 variables (removed 0) and now considering 452/452 (removed 0) transitions.
Finished structural reductions, in 2 iterations. Remains : 336/349 places, 452/555 transitions.
[2021-05-17 03:15:23] [INFO ] Flatten gal took : 275 ms
[2021-05-17 03:15:23] [INFO ] Flatten gal took : 87 ms
[2021-05-17 03:15:24] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality3903533536973092849.gal : 80 ms
[2021-05-17 03:15:24] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality3113831616019602473.prop : 0 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality3903533536973092849.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality3113831616019602473.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality3903533536973092849.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality3113831616019602473.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality3113831616019602473.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 31
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :31 after 32
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :32 after 129
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :129 after 134
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :134 after 144
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :144 after 159
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :159 after 78046
Detected timeout of ITS tools.
[2021-05-17 03:15:39] [INFO ] Flatten gal took : 71 ms
[2021-05-17 03:15:39] [INFO ] Applying decomposition
[2021-05-17 03:15:39] [INFO ] Flatten gal took : 60 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph9254267022677118013.txt, -o, /tmp/graph9254267022677118013.bin, -w, /tmp/graph9254267022677118013.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph9254267022677118013.bin, -l, -1, -v, -w, /tmp/graph9254267022677118013.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-17 03:15:39] [INFO ] Decomposing Gal with order
[2021-05-17 03:15:39] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:15:40] [INFO ] Removed a total of 744 redundant transitions.
[2021-05-17 03:15:40] [INFO ] Flatten gal took : 408 ms
[2021-05-17 03:15:40] [INFO ] Fuse similar labels procedure discarded/fused a total of 73 labels/synchronizations in 42 ms.
[2021-05-17 03:15:40] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality15956078680891634438.gal : 20 ms
[2021-05-17 03:15:40] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality16707073643293757288.prop : 0 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality15956078680891634438.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality16707073643293757288.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality15956078680891634438.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality16707073643293757288.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality16707073643293757288.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 4
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :4 after 5
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :5 after 88
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :88 after 152
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :152 after 205
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :205 after 207
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :207 after 210
SDD proceeding with computation,2 properties remain. new max is 512
SDD size :210 after 417
SDD proceeding with computation,2 properties remain. new max is 1024
SDD size :417 after 586
SDD proceeding with computation,2 properties remain. new max is 2048
SDD size :586 after 650
SDD proceeding with computation,2 properties remain. new max is 4096
SDD size :650 after 5033
SDD proceeding with computation,2 properties remain. new max is 8192
SDD size :5033 after 9264
SDD proceeding with computation,2 properties remain. new max is 16384
SDD size :9264 after 11306
SDD proceeding with computation,2 properties remain. new max is 32768
SDD size :11306 after 93172
SDD proceeding with computation,2 properties remain. new max is 65536
SDD size :93172 after 386002
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin10059524064294802141
[2021-05-17 03:15:55] [INFO ] Built C files in 28ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin10059524064294802141
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin10059524064294802141]
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin10059524064294802141] killed by timeout after 1 SECONDS
java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin10059524064294802141] killed by timeout after 1 SECONDS
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:79)
at java.base/java.lang.Thread.run(Thread.java:834)
Incomplete random walk after 1000000 steps, including 74875 resets, run finished after 2658 ms. (steps per millisecond=376 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 1000001 steps, including 26174 resets, run finished after 1343 ms. (steps per millisecond=744 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 1000001 steps, including 14923 resets, run finished after 943 ms. (steps per millisecond=1060 ) properties (out of 2) seen :0
Interrupted probabilistic random walk after 5659331 steps, run timeout after 30001 ms. (steps per millisecond=188 ) properties seen :{}
Probabilistic random walk after 5659331 steps, saw 1610091 distinct states, run finished after 30069 ms. (steps per millisecond=188 ) properties seen :{}
Running SMT prover for 2 properties.
[2021-05-17 03:16:31] [INFO ] Flow matrix only has 448 transitions (discarded 4 similar events)
// Phase 1: matrix 448 rows 336 cols
[2021-05-17 03:16:31] [INFO ] Computed 57 place invariants in 24 ms
[2021-05-17 03:16:32] [INFO ] [Real]Absence check using 43 positive place invariants in 139 ms returned sat
[2021-05-17 03:16:32] [INFO ] [Real]Absence check using 43 positive and 14 generalized place invariants in 65 ms returned sat
[2021-05-17 03:16:32] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:16:32] [INFO ] [Real]Absence check using state equation in 358 ms returned sat
[2021-05-17 03:16:32] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:16:32] [INFO ] [Nat]Absence check using 43 positive place invariants in 9 ms returned sat
[2021-05-17 03:16:32] [INFO ] [Nat]Absence check using 43 positive and 14 generalized place invariants in 29 ms returned sat
[2021-05-17 03:16:32] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:16:36] [INFO ] [Nat]Absence check using state equation in 3783 ms returned sat
[2021-05-17 03:16:36] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:16:36] [INFO ] [Nat]Added 1 Read/Feed constraints in 19 ms returned sat
[2021-05-17 03:16:36] [INFO ] Deduced a trap composed of 138 places in 356 ms of which 15 ms to minimize.
[2021-05-17 03:16:37] [INFO ] Deduced a trap composed of 132 places in 462 ms of which 1 ms to minimize.
[2021-05-17 03:16:37] [INFO ] Deduced a trap composed of 144 places in 206 ms of which 3 ms to minimize.
[2021-05-17 03:16:39] [INFO ] Deduced a trap composed of 126 places in 1980 ms of which 1 ms to minimize.
[2021-05-17 03:16:40] [INFO ] Deduced a trap composed of 139 places in 919 ms of which 1 ms to minimize.
[2021-05-17 03:16:40] [INFO ] Deduced a trap composed of 138 places in 127 ms of which 0 ms to minimize.
[2021-05-17 03:16:41] [INFO ] Deduced a trap composed of 129 places in 170 ms of which 1 ms to minimize.
[2021-05-17 03:16:41] [INFO ] Deduced a trap composed of 157 places in 190 ms of which 1 ms to minimize.
[2021-05-17 03:16:41] [INFO ] Deduced a trap composed of 156 places in 172 ms of which 0 ms to minimize.
[2021-05-17 03:16:41] [INFO ] Deduced a trap composed of 135 places in 107 ms of which 0 ms to minimize.
[2021-05-17 03:16:41] [INFO ] Deduced a trap composed of 132 places in 135 ms of which 0 ms to minimize.
[2021-05-17 03:16:43] [INFO ] Deduced a trap composed of 139 places in 180 ms of which 0 ms to minimize.
[2021-05-17 03:16:43] [INFO ] Deduced a trap composed of 145 places in 187 ms of which 0 ms to minimize.
[2021-05-17 03:16:43] [INFO ] Deduced a trap composed of 135 places in 137 ms of which 1 ms to minimize.
[2021-05-17 03:16:44] [INFO ] Deduced a trap composed of 138 places in 138 ms of which 0 ms to minimize.
[2021-05-17 03:17:17] [INFO ] Deduced a trap composed of 6 places in 246 ms of which 1 ms to minimize.
[2021-05-17 03:17:17] [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 close... while checking expression at index 0
[2021-05-17 03:17:17] [INFO ] [Real]Absence check using 43 positive place invariants in 9 ms returned sat
[2021-05-17 03:17:17] [INFO ] [Real]Absence check using 43 positive and 14 generalized place invariants in 11 ms returned sat
[2021-05-17 03:17:17] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:17:18] [INFO ] [Real]Absence check using state equation in 289 ms returned sat
[2021-05-17 03:17:18] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:17:18] [INFO ] [Nat]Absence check using 43 positive place invariants in 11 ms returned sat
[2021-05-17 03:17:18] [INFO ] [Nat]Absence check using 43 positive and 14 generalized place invariants in 8 ms returned sat
[2021-05-17 03:17:18] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:17:18] [INFO ] [Nat]Absence check using state equation in 567 ms returned sat
[2021-05-17 03:17:19] [INFO ] [Nat]Added 1 Read/Feed constraints in 91 ms returned sat
[2021-05-17 03:17:19] [INFO ] Computed and/alt/rep : 246/573/246 causal constraints (skipped 196 transitions) in 28 ms.
[2021-05-17 03:17:20] [INFO ] Added : 27 causal constraints over 6 iterations in 1611 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 2 ms.
Incomplete Parikh walk after 9300 steps, including 842 resets, run finished after 23 ms. (steps per millisecond=404 ) properties (out of 2) seen :0 could not realise parikh vector
Support contains 91 out of 336 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 336/336 places, 452/452 transitions.
Applied a total of 0 rules in 14 ms. Remains 336 /336 variables (removed 0) and now considering 452/452 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 336/336 places, 452/452 transitions.
Starting structural reductions, iteration 0 : 336/336 places, 452/452 transitions.
Applied a total of 0 rules in 12 ms. Remains 336 /336 variables (removed 0) and now considering 452/452 (removed 0) transitions.
[2021-05-17 03:17:20] [INFO ] Flow matrix only has 448 transitions (discarded 4 similar events)
// Phase 1: matrix 448 rows 336 cols
[2021-05-17 03:17:20] [INFO ] Computed 57 place invariants in 5 ms
[2021-05-17 03:17:30] [INFO ] Implicit Places using invariants in 9363 ms returned []
[2021-05-17 03:17:30] [INFO ] Flow matrix only has 448 transitions (discarded 4 similar events)
// Phase 1: matrix 448 rows 336 cols
[2021-05-17 03:17:30] [INFO ] Computed 57 place invariants in 6 ms
[2021-05-17 03:17:31] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:17:40] [INFO ] Implicit Places using invariants and state equation in 10240 ms returned []
Implicit Place search using SMT with State Equation took 19618 ms to find 0 implicit places.
[2021-05-17 03:17:40] [INFO ] Redundant transitions in 33 ms returned []
[2021-05-17 03:17:40] [INFO ] Flow matrix only has 448 transitions (discarded 4 similar events)
// Phase 1: matrix 448 rows 336 cols
[2021-05-17 03:17:40] [INFO ] Computed 57 place invariants in 5 ms
[2021-05-17 03:17:49] [INFO ] Dead Transitions using invariants and state equation in 9371 ms returned []
Finished structural reductions, in 1 iterations. Remains : 336/336 places, 452/452 transitions.
Incomplete random walk after 100000 steps, including 7385 resets, run finished after 762 ms. (steps per millisecond=131 ) properties (out of 2) seen :0
Running SMT prover for 2 properties.
[2021-05-17 03:17:50] [INFO ] Flow matrix only has 448 transitions (discarded 4 similar events)
// Phase 1: matrix 448 rows 336 cols
[2021-05-17 03:17:50] [INFO ] Computed 57 place invariants in 4 ms
[2021-05-17 03:17:50] [INFO ] [Real]Absence check using 43 positive place invariants in 239 ms returned sat
[2021-05-17 03:17:51] [INFO ] [Real]Absence check using 43 positive and 14 generalized place invariants in 111 ms returned sat
[2021-05-17 03:17:51] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:17:52] [INFO ] [Real]Absence check using state equation in 1506 ms returned sat
[2021-05-17 03:17:52] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:17:52] [INFO ] [Nat]Absence check using 43 positive place invariants in 10 ms returned sat
[2021-05-17 03:17:52] [INFO ] [Nat]Absence check using 43 positive and 14 generalized place invariants in 42 ms returned sat
[2021-05-17 03:17:52] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:17:56] [INFO ] [Nat]Absence check using state equation in 3575 ms returned sat
[2021-05-17 03:17:56] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-17 03:17:56] [INFO ] [Nat]Added 1 Read/Feed constraints in 3 ms returned sat
[2021-05-17 03:17:57] [INFO ] Deduced a trap composed of 138 places in 1273 ms of which 1 ms to minimize.
[2021-05-17 03:18:00] [INFO ] Deduced a trap composed of 132 places in 2988 ms of which 1 ms to minimize.
[2021-05-17 03:18:01] [INFO ] Deduced a trap composed of 144 places in 813 ms of which 0 ms to minimize.
[2021-05-17 03:18:07] [INFO ] Deduced a trap composed of 126 places in 6047 ms of which 51 ms to minimize.
[2021-05-17 03:18:07] [INFO ] Deduced a trap composed of 139 places in 204 ms of which 1 ms to minimize.
[2021-05-17 03:18:08] [INFO ] Deduced a trap composed of 138 places in 168 ms of which 0 ms to minimize.
[2021-05-17 03:18:13] [INFO ] Deduced a trap composed of 129 places in 5625 ms of which 0 ms to minimize.
[2021-05-17 03:18:13] [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 close... while checking expression at index 0
[2021-05-17 03:18:14] [INFO ] [Real]Absence check using 43 positive place invariants in 13 ms returned sat
[2021-05-17 03:18:14] [INFO ] [Real]Absence check using 43 positive and 14 generalized place invariants in 26 ms returned sat
[2021-05-17 03:18:14] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:18:14] [INFO ] [Real]Absence check using state equation in 280 ms returned sat
[2021-05-17 03:18:14] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:18:14] [INFO ] [Nat]Absence check using 43 positive place invariants in 105 ms returned sat
[2021-05-17 03:18:14] [INFO ] [Nat]Absence check using 43 positive and 14 generalized place invariants in 20 ms returned sat
[2021-05-17 03:18:14] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:18:15] [INFO ] [Nat]Absence check using state equation in 547 ms returned sat
[2021-05-17 03:18:15] [INFO ] [Nat]Added 1 Read/Feed constraints in 61 ms returned sat
[2021-05-17 03:18:15] [INFO ] Computed and/alt/rep : 246/573/246 causal constraints (skipped 196 transitions) in 72 ms.
[2021-05-17 03:18:16] [INFO ] Added : 27 causal constraints over 6 iterations in 1552 ms. Result :sat
[2021-05-17 03:18:16] [INFO ] Flatten gal took : 74 ms
[2021-05-17 03:18:16] [INFO ] Flatten gal took : 57 ms
[2021-05-17 03:18:16] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality15179067311280388728.gal : 13 ms
[2021-05-17 03:18:17] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality6764307991956972411.prop : 46 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality15179067311280388728.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality6764307991956972411.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality15179067311280388728.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality6764307991956972411.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality6764307991956972411.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 31
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :31 after 32
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :32 after 129
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :129 after 134
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :134 after 144
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :144 after 159
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :159 after 78046
Detected timeout of ITS tools.
[2021-05-17 03:18:32] [INFO ] Flatten gal took : 73 ms
[2021-05-17 03:18:32] [INFO ] Applying decomposition
[2021-05-17 03:18:32] [INFO ] Flatten gal took : 40 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph15553189811207977451.txt, -o, /tmp/graph15553189811207977451.bin, -w, /tmp/graph15553189811207977451.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph15553189811207977451.bin, -l, -1, -v, -w, /tmp/graph15553189811207977451.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-17 03:18:32] [INFO ] Decomposing Gal with order
[2021-05-17 03:18:32] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:18:32] [INFO ] Removed a total of 730 redundant transitions.
[2021-05-17 03:18:32] [INFO ] Flatten gal took : 247 ms
[2021-05-17 03:18:32] [INFO ] Fuse similar labels procedure discarded/fused a total of 42 labels/synchronizations in 41 ms.
[2021-05-17 03:18:33] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality4848704624200026532.gal : 28 ms
[2021-05-17 03:18:33] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality15173874756308068223.prop : 2 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality4848704624200026532.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality15173874756308068223.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality4848704624200026532.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality15173874756308068223.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality15173874756308068223.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 8
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :8 after 32
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :32 after 68
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :68 after 84
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :84 after 25250
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :25250 after 40555
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :40555 after 57625
SDD proceeding with computation,2 properties remain. new max is 512
SDD size :57625 after 77878
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin982871264272927634
[2021-05-17 03:18:48] [INFO ] Built C files in 8ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin982871264272927634
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin982871264272927634]
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin982871264272927634] killed by timeout after 1 SECONDS
java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin982871264272927634] killed by timeout after 1 SECONDS
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:79)
at java.base/java.lang.Thread.run(Thread.java:834)
Ensure Unique test removed 4 transitions
Reduce isomorphic transitions removed 4 transitions.
Iterating post reduction 0 with 4 rules applied. Total rules applied 4 place count 336 transition count 448
Free-agglomeration rule applied 1 times.
Iterating global reduction 1 with 1 rules applied. Total rules applied 5 place count 336 transition count 447
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 1 with 1 rules applied. Total rules applied 6 place count 335 transition count 447
Free-agglomeration rule (complex) applied 5 times.
Iterating global reduction 2 with 5 rules applied. Total rules applied 11 place count 335 transition count 442
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 2 with 5 rules applied. Total rules applied 16 place count 330 transition count 442
Applied a total of 16 rules in 132 ms. Remains 330 /336 variables (removed 6) and now considering 442/452 (removed 10) transitions.
Running SMT prover for 2 properties.
// Phase 1: matrix 442 rows 330 cols
[2021-05-17 03:18:49] [INFO ] Computed 57 place invariants in 4 ms
[2021-05-17 03:18:49] [INFO ] [Real]Absence check using 44 positive place invariants in 255 ms returned sat
[2021-05-17 03:18:49] [INFO ] [Real]Absence check using 44 positive and 13 generalized place invariants in 58 ms returned sat
[2021-05-17 03:18:49] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:18:50] [INFO ] [Real]Absence check using state equation in 310 ms returned sat
[2021-05-17 03:18:50] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:18:50] [INFO ] [Nat]Absence check using 44 positive place invariants in 18 ms returned sat
[2021-05-17 03:18:50] [INFO ] [Nat]Absence check using 44 positive and 13 generalized place invariants in 47 ms returned sat
[2021-05-17 03:18:50] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:18:50] [INFO ] [Nat]Absence check using state equation in 703 ms returned sat
[2021-05-17 03:18:51] [INFO ] Deduced a trap composed of 138 places in 149 ms of which 0 ms to minimize.
[2021-05-17 03:18:51] [INFO ] Deduced a trap composed of 138 places in 152 ms of which 0 ms to minimize.
[2021-05-17 03:18:51] [INFO ] Deduced a trap composed of 134 places in 171 ms of which 1 ms to minimize.
[2021-05-17 03:18:51] [INFO ] Deduced a trap composed of 134 places in 270 ms of which 0 ms to minimize.
[2021-05-17 03:18:52] [INFO ] Deduced a trap composed of 132 places in 219 ms of which 1 ms to minimize.
[2021-05-17 03:18:53] [INFO ] Deduced a trap composed of 137 places in 1662 ms of which 3 ms to minimize.
[2021-05-17 03:18:59] [INFO ] Deduced a trap composed of 132 places in 5975 ms of which 24 ms to minimize.
[2021-05-17 03:18:59] [INFO ] Deduced a trap composed of 132 places in 153 ms of which 1 ms to minimize.
[2021-05-17 03:19:00] [INFO ] Deduced a trap composed of 137 places in 159 ms of which 0 ms to minimize.
[2021-05-17 03:19:06] [INFO ] Deduced a trap composed of 122 places in 5983 ms of which 25 ms to minimize.
[2021-05-17 03:19:07] [INFO ] Deduced a trap composed of 131 places in 1146 ms of which 1 ms to minimize.
[2021-05-17 03:19:08] [INFO ] Deduced a trap composed of 137 places in 201 ms of which 1 ms to minimize.
[2021-05-17 03:19:08] [INFO ] Deduced a trap composed of 143 places in 203 ms of which 0 ms to minimize.
[2021-05-17 03:19:09] [INFO ] Deduced a trap composed of 131 places in 695 ms of which 24 ms to minimize.
[2021-05-17 03:19:11] [INFO ] Deduced a trap composed of 141 places in 128 ms of which 0 ms to minimize.
[2021-05-17 03:19:11] [INFO ] Deduced a trap composed of 128 places in 236 ms of which 1 ms to minimize.
[2021-05-17 03:19:12] [INFO ] Deduced a trap composed of 137 places in 120 ms of which 0 ms to minimize.
[2021-05-17 03:19:12] [INFO ] Deduced a trap composed of 134 places in 83 ms of which 0 ms to minimize.
[2021-05-17 03:19:17] [INFO ] Deduced a trap composed of 140 places in 3623 ms of which 0 ms to minimize.
[2021-05-17 03:19:22] [INFO ] Deduced a trap composed of 137 places in 3077 ms of which 0 ms to minimize.
[2021-05-17 03:19:25] [INFO ] Deduced a trap composed of 134 places in 2420 ms of which 1 ms to minimize.
[2021-05-17 03:19:28] [INFO ] Deduced a trap composed of 125 places in 2748 ms of which 1 ms to minimize.
[2021-05-17 03:19:30] [INFO ] Deduced a trap composed of 128 places in 175 ms of which 1 ms to minimize.
[2021-05-17 03:19:35] [INFO ] Deduced a trap composed of 6 places in 393 ms of which 0 ms to minimize.
[2021-05-17 03:19:35] [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 close... while checking expression at index 0
[2021-05-17 03:19:35] [INFO ] [Real]Absence check using 44 positive place invariants in 7 ms returned sat
[2021-05-17 03:19:35] [INFO ] [Real]Absence check using 44 positive and 13 generalized place invariants in 6 ms returned sat
[2021-05-17 03:19:35] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-17 03:19:37] [INFO ] [Real]Absence check using state equation in 1620 ms returned sat
[2021-05-17 03:19:37] [INFO ] Solution in real domain found non-integer solution.
[2021-05-17 03:19:37] [INFO ] [Nat]Absence check using 44 positive place invariants in 8 ms returned sat
[2021-05-17 03:19:37] [INFO ] [Nat]Absence check using 44 positive and 13 generalized place invariants in 20 ms returned sat
[2021-05-17 03:19:37] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-17 03:19:37] [INFO ] [Nat]Absence check using state equation in 538 ms returned sat
[2021-05-17 03:19:45] [INFO ] Deduced a trap composed of 15 places in 7250 ms of which 27 ms to minimize.
[2021-05-17 03:19:45] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 7282 ms
[2021-05-17 03:19:45] [INFO ] Computed and/alt/rep : 246/498/246 causal constraints (skipped 195 transitions) in 45 ms.
[2021-05-17 03:19:45] [INFO ] Added : 22 causal constraints over 5 iterations in 441 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 3 ms.
[2021-05-17 03:19:45] [INFO ] Flatten gal took : 38 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin13689000153090943140
[2021-05-17 03:19:45] [INFO ] Computing symmetric may disable matrix : 452 transitions.
[2021-05-17 03:19:45] [INFO ] Computation of Complete disable matrix. took 2 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2021-05-17 03:19:45] [INFO ] Applying decomposition
[2021-05-17 03:19:45] [INFO ] Computing symmetric may enable matrix : 452 transitions.
[2021-05-17 03:19:45] [INFO ] Computation of Complete enable matrix. took 2 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2021-05-17 03:19:45] [INFO ] Flatten gal took : 74 ms
[2021-05-17 03:19:45] [INFO ] Computing Do-Not-Accords matrix : 452 transitions.
[2021-05-17 03:19:45] [INFO ] Computation of Completed DNA matrix. took 51 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2021-05-17 03:19:45] [INFO ] Built C files in 256ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin13689000153090943140
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/include/, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/tmp/ltsmin13689000153090943140]
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/convert-linux64, -i, /tmp/graph2358406588648927889.txt, -o, /tmp/graph2358406588648927889.bin, -w, /tmp/graph2358406588648927889.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202104292328/bin/louvain-linux64, /tmp/graph2358406588648927889.bin, -l, -1, -v, -w, /tmp/graph2358406588648927889.weights, -q, 0, -e, 0.001], workingDir=null]
[2021-05-17 03:19:45] [INFO ] Decomposing Gal with order
[2021-05-17 03:19:45] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:19:46] [INFO ] Flatten gal took : 63 ms
[2021-05-17 03:19:46] [INFO ] Removed a total of 625 redundant transitions.
[2021-05-17 03:19:46] [INFO ] Flatten gal took : 391 ms
[2021-05-17 03:19:46] [INFO ] Input system was already deterministic with 452 transitions.
[2021-05-17 03:19:46] [INFO ] Fuse similar labels procedure discarded/fused a total of 29 labels/synchronizations in 40 ms.
[2021-05-17 03:19:46] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality3865787038119101984.gal : 53 ms
[2021-05-17 03:19:46] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality6500229369581685432.prop : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality3865787038119101984.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality6500229369581685432.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality3865787038119101984.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality6500229369581685432.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality6500229369581685432.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 16
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :16 after 32
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :32 after 67
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :67 after 72
[2021-05-17 03:19:47] [INFO ] Ran tautology test, simplified 0 / 2 in 1631 ms.
[2021-05-17 03:19:47] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(UNSAT) depth K=0 took 34 ms
[2021-05-17 03:19:47] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=0 took 45 ms
[2021-05-17 03:19:47] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(UNSAT) depth K=1 took 89 ms
[2021-05-17 03:19:48] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=1 took 55 ms
[2021-05-17 03:19:48] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(UNSAT) depth K=2 took 391 ms
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :72 after 36082
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 448 out of 452 initially.
// Phase 1: matrix 448 rows 336 cols
[2021-05-17 03:19:48] [INFO ] Computed 57 place invariants in 30 ms
inv : -QueueJobB_1_8 + FetchJobB_1 - QueueJobB_1_18 - QueueJobB_1_16 - QueueJobB_1_2 - QueueJobB_1_9 - QueueJobB_1_15 - QueueJobB_1_1 - QueueJobB_1_14 - QueueJobB_1_3 - QueueJobB_1_4 - QueueJobB_1_13 - QueueJobB_1_5 - QueueJobB_1_12 - QueueJobB_1_6 - QueueJobB_1_19 - QueueJobB_1_11 - QueueJobB_1_20 - QueueJobB_1_17 - QueueJobB_1_10 - QueueJobB_1_7 - QueueJobB_1_0 + block - cJobCnt = -7
inv : -2*f3_4 - 2*f3_13 - f2_16 - f2_2 - 2*f3_0 - f2_10 + mi1 - 2*f3_14 - 2*f3_7 - 2*f3_6 - 2*f3_1 - f2_11 - f2_15 - 2*f3_15 - f2_1 - 2*f3_20 - f2_18 - 2*f3_19 - f2_8 - f2_0 - f2_17 - 2*f3_9 - 2*f3_18 - f2_9 - 2*f3_8 - f2_13 - 2*f3_17 - 2*f3_10 - f2_5 - 2*f3_3 - f2_19 - 2*f3_16 - 2*f3_2 - f2_12 - f2_7 - 2*f3_11 - f2_6 - f2_20 - f2_4 - 2*f3_5 - 2*f3_12 + mo2 - block - f2_3 + mo3 - f2_14 = -2
inv : f1_0 + NotifyEventJobQueuedB_1_0 + f3_0 + Perform_Work_B_1_0 + f2_0 + FetchJobE_1_0 + AvailableJobId_0 + Schedule_Task_E_1_PerformWork_0 + QueueJobB_1_0 = 1
inv : CreatedJobs_11_5 + AvailableJobId_11 + CreatedJobs_11_1 + CreatedJobs_11_3 + CreatedJobs_11_2 + CreatedJobs_11_4 = 1
inv : AvailableJobId_2 + f2_2 + QueueJobB_1_2 + f1_2 + FetchJobE_1_2 + NotifyEventJobQueuedB_1_2 + Schedule_Task_E_1_PerformWork_2 + f3_2 + Perform_Work_B_1_2 = 1
inv : mo1 + mo2 + mo3 = 1
inv : Schedule_Task_E_1_PerformWork_6 + NotifyEventJobQueuedB_1_6 + f3_6 + f1_6 + Perform_Work_B_1_6 + AvailableJobId_6 + QueueJobB_1_6 + FetchJobE_1_6 + f2_6 = 1
inv : FetchJobE_1_11 + f2_11 + AvailableJobId_11 + NotifyEventJobQueuedB_1_11 + Schedule_Task_E_1_PerformWork_11 + Perform_Work_B_1_11 + QueueJobB_1_11 + f3_11 + f1_11 = 1
inv : NotifyEventJobQueuedB_1_12 + Schedule_Task_E_1_PerformWork_12 + FetchJobE_1_12 + QueueJobB_1_12 - CreatedJobs_12_3 + f2_12 - CreatedJobs_12_1 + f1_12 + f3_12 - CreatedJobs_12_5 - CreatedJobs_12_4 + Perform_Work_B_1_12 - CreatedJobs_12_2 = 0
inv : CreatedJobs_0_5 + CreatedJobs_0_4 + CreatedJobs_0_1 + AvailableJobId_0 + CreatedJobs_0_2 + CreatedJobs_0_3 = 1
inv : QueueJobB_1_18 + FetchJobE_1_18 + f2_18 + Schedule_Task_E_1_PerformWork_18 + f3_18 + NotifyEventJobQueuedB_1_18 + Perform_Work_B_1_18 + AvailableJobId_18 + f1_18 = 1
inv : CreatedJobs_17_1 + CreatedJobs_17_2 + CreatedJobs_17_4 + CreatedJobs_17_5 + CreatedJobs_17_3 + AvailableJobId_17 = 1
inv : -f3_4 - f1_0 - f3_13 - f1_15 - f2_16 - f2_2 - f1_1 - f3_0 - f1_8 - f2_10 - f3_14 - f3_7 - f3_6 + NotifyEventJobQueuedB_1_19 - f1_2 - f3_1 - f1_16 - f2_11 - f2_15 - f3_15 - f2_1 - f3_20 - f2_18 + FetchJobE_1_19 - f1_3 - f2_8 - f1_7 - f2_0 - f1_6 - f1_13 - f2_17 + Schedule_Task_E_1_PerformWork_19 - f1_4 - f3_9 - f3_18 - f1_5 - f1_14 - f2_9 - f3_8 - f2_13 - f3_17 - f3_10 - f2_5 - f3_3 + AvailableJobId_19 + QueueJobB_1_19 - f3_16 - f3_2 - f2_12 - f2_7 - f3_11 - f1_12 - f1_11 - f2_6 - f2_20 - f1_17 - f1_10 - f2_4 - f3_5 - f3_12 + Perform_Work_B_1_19 - block - f2_3 - f1_18 - f1_9 - f2_14 - f1_20 = -2
inv : CreatedJobs_2_2 + CreatedJobs_16_2 + CreatedJobs_10_2 - CreatedJobs_8_5 + CreatedJobs_9_2 + CreatedJobs_7_2 + CreatedJobs_14_2 + TheSour_2 + CreatedJobs_17_2 - CreatedJobs_8_1 + CreatedJobs_15_2 - CreatedJobs_8_4 + CreatedJobs_6_2 + CreatedJobs_19_2 + place_482_1_2 + CreatedJobs_13_2 + CreatedJobs_5_2 + CreatedJobs_18_2 + CreatedJobs_4_2 + CreatedJobs_0_2 + CreatedJobs_11_2 - AvailableJobId_8 + CreatedJobs_1_2 + CreatedJobs_20_2 + CreatedJobs_3_2 + ModifiedSrc_2 + CreatedJobs_12_2 - CreatedJobs_8_3 = 0
inv : Schedule_Task_E_1_PerformWork_7 - CreatedJobs_7_4 + NotifyEventJobQueuedB_1_7 - CreatedJobs_7_5 + f3_7 + Perform_Work_B_1_7 - CreatedJobs_7_2 + f1_7 + FetchJobE_1_7 + f2_7 - CreatedJobs_7_1 - CreatedJobs_7_3 + QueueJobB_1_7 = 0
inv : AvailableJobId_9 + QueueJobB_1_9 + Schedule_Task_E_1_PerformWork_9 + NotifyEventJobQueuedB_1_9 + f3_9 + f2_9 + FetchJobE_1_9 + Perform_Work_B_1_9 + f1_9 = 1
inv : f3_4 + FetchJobE_1_4 + AvailableJobId_4 + Schedule_Task_E_1_PerformWork_4 + f1_4 + QueueJobB_1_4 + Perform_Work_B_1_4 + NotifyEventJobQueuedB_1_4 + f2_4 = 1
inv : 4*place_522_1 + 3*place_462 + 12*Check_Sources_E_1 + 12*CanInjectEvent + 12*place_456 + 4*place_460 + 3*place_523_1 + 6*place_458 + 6*place_521_1 = 12
inv : QueueJobB_1_8 + f1_8 + NotifyEventJobQueuedB_1_8 + f2_8 + Perform_Work_B_1_8 + f3_8 + AvailableJobId_8 + Schedule_Task_E_1_PerformWork_8 + FetchJobE_1_8 = 1
inv : CreatedJobs_20_5 + CreatedJobs_20_4 + AvailableJobId_20 + CreatedJobs_20_1 + CreatedJobs_20_3 + CreatedJobs_20_2 = 1
inv : FetchJobE_1_17 + Schedule_Task_E_1_PerformWork_17 + f2_17 + NotifyEventJobQueuedB_1_17 + f3_17 + QueueJobB_1_17 + f1_17 + Perform_Work_B_1_17 + AvailableJobId_17 = 1
inv : CreatedJobs_13_4 + CreatedJobs_13_5 + CreatedJobs_13_3 + AvailableJobId_13 + CreatedJobs_13_1 + CreatedJobs_13_2 = 1
inv : AvailableJobId_7 + CreatedJobs_7_4 + CreatedJobs_7_5 + CreatedJobs_7_2 + CreatedJobs_7_1 + CreatedJobs_7_3 = 1
inv : CreatedJobs_4_4 + AvailableJobId_4 + CreatedJobs_4_3 + CreatedJobs_4_2 + CreatedJobs_4_1 + CreatedJobs_4_5 = 1
inv : Schedule_Task_E_1_PerformWork_3 + f1_3 + QueueJobB_1_3 + AvailableJobId_3 + FetchJobE_1_3 + f3_3 + NotifyEventJobQueuedB_1_3 + Perform_Work_B_1_3 + f2_3 = 1
inv : place_482_1_5 + CreatedJobs_7_5 - AvailableJobId_10 - CreatedJobs_10_2 + CreatedJobs_14_5 + CreatedJobs_8_5 - AvailableJobId_11 + CreatedJobs_13_5 - CreatedJobs_20_4 - CreatedJobs_11_1 - CreatedJobs_0_4 + CreatedJobs_16_5 - CreatedJobs_10_1 - CreatedJobs_0_1 + CreatedJobs_15_5 - CreatedJobs_5_3 + CreatedJobs_6_5 - AvailableJobId_20 - CreatedJobs_5_2 - CreatedJobs_11_3 - AvailableJobId_0 - CreatedJobs_10_4 - CreatedJobs_20_1 - CreatedJobs_20_3 + CreatedJobs_3_5 - CreatedJobs_0_2 + CreatedJobs_4_5 - CreatedJobs_11_2 - AvailableJobId_5 + CreatedJobs_17_5 + CreatedJobs_18_5 - CreatedJobs_11_4 - CreatedJobs_10_3 - CreatedJobs_0_3 + ModifiedSrc_5 + CreatedJobs_12_5 + CreatedJobs_2_5 - CreatedJobs_20_2 + CreatedJobs_19_5 + CreatedJobs_9_5 - CreatedJobs_5_4 - CreatedJobs_5_1 + CreatedJobs_1_5 + TheSour_5 = -4
inv : CreatedJobs_5_5 + CreatedJobs_5_3 + CreatedJobs_5_2 + AvailableJobId_5 + CreatedJobs_5_4 + CreatedJobs_5_1 = 1
inv : CreatedJobs_1_3 + CreatedJobs_1_1 + AvailableJobId_1 + CreatedJobs_1_4 + CreatedJobs_1_2 + CreatedJobs_1_5 = 1
inv : CreatedJobs_2_3 + CreatedJobs_2_2 + CreatedJobs_2_1 + AvailableJobId_2 + CreatedJobs_2_4 + CreatedJobs_2_5 = 1
inv : CreatedJobs_18_1 + CreatedJobs_18_4 + CreatedJobs_18_2 + AvailableJobId_18 + CreatedJobs_18_5 + CreatedJobs_18_3 = 1
inv : Perform_Work_B_1_20 + f3_20 + NotifyEventJobQueuedB_1_20 + Schedule_Task_E_1_PerformWork_20 + AvailableJobId_20 + FetchJobE_1_20 + QueueJobB_1_20 + f2_20 + f1_20 = 1
inv : Perform_Work_B_1_10 + f2_10 + AvailableJobId_10 + Schedule_Task_E_1_PerformWork_10 + FetchJobE_1_10 + NotifyEventJobQueuedB_1_10 + f3_10 + f1_10 + QueueJobB_1_10 = 1
inv : AvailableJobId_12 + CreatedJobs_12_3 + CreatedJobs_12_1 + CreatedJobs_12_5 + CreatedJobs_12_4 + CreatedJobs_12_2 = 1
inv : f1_15 + QueueJobB_1_15 + f2_15 + f3_15 + Perform_Work_B_1_15 + NotifyEventJobQueuedB_1_15 + AvailableJobId_15 + FetchJobE_1_15 + Schedule_Task_E_1_PerformWork_15 = 1
inv : f3_13 + NotifyEventJobQueuedB_1_13 + Perform_Work_B_1_13 + f1_13 + QueueJobB_1_13 + f2_13 + AvailableJobId_13 + FetchJobE_1_13 + Schedule_Task_E_1_PerformWork_13 = 1
inv : CreatedJobs_9_1 + AvailableJobId_9 + CreatedJobs_9_3 + CreatedJobs_9_2 + CreatedJobs_9_4 + CreatedJobs_9_5 = 1
inv : CreatedJobs_19_4 + CreatedJobs_19_1 + CreatedJobs_19_2 + CreatedJobs_19_3 + AvailableJobId_19 + CreatedJobs_19_5 = 1
inv : NotifyEventJobQueuedB_1_14 + f3_14 + Perform_Work_B_1_14 + QueueJobB_1_14 + f1_14 + Schedule_Task_E_1_PerformWork_14 + AvailableJobId_14 + FetchJobE_1_14 + f2_14 = 1
inv : CreatedJobs_14_4 + CreatedJobs_14_5 + CreatedJobs_14_3 + CreatedJobs_14_2 + AvailableJobId_14 + CreatedJobs_14_1 = 1
inv : f3_4 + f3_13 - f2_16 - f2_2 + f3_0 - f2_10 + f3_14 + f3_7 + f3_6 + f3_1 - f2_11 - f2_15 + f3_15 - f2_1 + f3_20 + mi3 - f2_18 + f3_19 - f2_8 - f2_0 - f2_17 + f3_9 + f3_18 - f2_9 + f3_8 - f2_13 + f3_17 + f3_10 - f2_5 + f3_3 - f2_19 + f3_16 + f3_2 - f2_12 - f2_7 + f3_11 - f2_6 - f2_20 - f2_4 + f3_5 + f3_12 - f2_3 - mo3 - f2_14 = 0
inv : CreatedJobs_16_1 + AvailableJobId_16 + CreatedJobs_16_2 + CreatedJobs_16_3 + CreatedJobs_16_4 + CreatedJobs_16_5 = 1
inv : CreatedJobs_8_2 + CreatedJobs_8_5 + CreatedJobs_8_1 + CreatedJobs_8_4 + AvailableJobId_8 + CreatedJobs_8_3 = 1
inv : f3_4 + f3_13 + 2*f2_16 + 2*f2_2 + f3_0 + 2*f2_10 + f3_14 + f3_7 + f3_6 + f3_1 + 2*f2_11 + 2*f2_15 + f3_15 + 2*f2_1 + f3_20 + mi2 + 2*f2_18 + f3_19 + 2*f2_8 + 2*f2_0 + 2*f2_17 + f3_9 + f3_18 + 2*f2_9 + f3_8 + 2*f2_13 + f3_17 + f3_10 + 2*f2_5 + f3_3 + 2*f2_19 + f3_16 + f3_2 + 2*f2_12 + 2*f2_7 + f3_11 + 2*f2_6 + 2*f2_20 + 2*f2_4 + f3_5 + f3_12 - mo2 + block + 2*f2_3 + 2*f2_14 = 3
inv : JobCnt + cJobCnt = 10
inv : CreatedJobs_15_3 + CreatedJobs_15_4 + CreatedJobs_15_2 + CreatedJobs_15_5 + AvailableJobId_15 + CreatedJobs_15_1 = 1
inv : -CreatedJobs_2_2 - CreatedJobs_2_1 - AvailableJobId_2 - CreatedJobs_2_4 + ModifiedSrc_3 + CreatedJobs_9_3 + CreatedJobs_16_3 + CreatedJobs_14_3 - CreatedJobs_15_4 - CreatedJobs_1_1 - AvailableJobId_1 + CreatedJobs_3_3 - CreatedJobs_15_2 + DataOnSrc_3 + CreatedJobs_13_3 + place_482_1_3 - CreatedJobs_1_4 - CreatedJobs_15_5 + CreatedJobs_4_3 + CreatedJobs_5_3 + CreatedJobs_12_3 + CreatedJobs_19_3 + CreatedJobs_11_3 + CreatedJobs_6_3 + CreatedJobs_20_3 - AvailableJobId_15 + CreatedJobs_10_3 + CreatedJobs_7_3 + CreatedJobs_17_3 + CreatedJobs_0_3 - CreatedJobs_1_2 - CreatedJobs_2_5 - CreatedJobs_15_1 + CreatedJobs_18_3 - CreatedJobs_1_5 + CreatedJobs_8_3 = -2
inv : AvailableJobId_16 + Schedule_Task_E_1_PerformWork_16 + FetchJobE_1_16 + QueueJobB_1_16 + f2_16 + f1_16 + Perform_Work_B_1_16 + NotifyEventJobQueuedB_1_16 + f3_16 = 1
inv : 12*QueueJobB_1_8 - 12*AvailableJobId_16 + 12*Schedule_Task_E_1_PerformWork_7 + 12*QueueJobB_1_18 - 12*f3_4 - 12*f1_15 + 12*Schedule_Task_E_1_PerformWork_6 - 12*f2_16 - 12*f1_1 + 12*QueueJobB_1_2 + 12*FetchJobE_1_17 + 4*place_522_1 - 12*f2_10 - 12*AvailableJobId_10 + 12*Schedule_Task_E_1_PerformWork_17 + 3*place_462 + 12*QueueJobB_1_9 + 12*FetchJobE_1_11 + 12*Schedule_Task_E_1_PerformWork_3 + 12*Perform_Work_B_1_0 + 12*Perform_Work_B_1_14 + 12*Perform_Work_B_1_7 + 12*Perform_Work_E_1 + 12*FetchJobE_1_18 - 12*f3_1 - 12*f1_16 + 12*QueueJobB_1_14 - 12*f2_15 - 12*AvailableJobId_4 - 12*f3_15 - 12*f2_1 + 12*Perform_Work_B_1_13 + 12*place_787_1 + 12*Schedule_Task_E_1_PerformWork_9 - 12*f3_20 + 12*FetchJobE_1_19 + 12*QueueJobB_1_3 + 12*Schedule_Task_E_1_PerformWork_18 - 12*AvailableJobId_1 + 12*Perform_Work_B_1_8 + 12*Check_Sources_E_1 + 12*FetchJobE_1_2 - 12*NotifyEventJobQueuedB_1_20 + 12*Schedule_Task_E_1_PerformWork_19 - 12*f1_4 - 12*NotifyEventJobQueuedB_1_1 + 12*Schedule_Task_E_1_PerformWork_12 + 12*Schedule_Task_E_1_PerformWork_2 - 12*NotifyEventJobQueuedB_1_10 + 12*Perform_Work_B_1_6 + 12*Try_Check_Sources_B_1 + 12*FetchJobE_1_12 + 12*FetchJobE_1_3 - 12*f1_5 + 12*Schedule_Task_B_1 + 12*QueueJobB_1_13 + 12*place_456 + 12*FetchJobE_1_0 + 12*Schedule_Task_E_1_PerformWork_11 + 12*FetchJobE_1_7 - 12*f3_10 - 12*AvailableJobId_20 + 12*QueueJobB_1_12 + 12*Check_Sources_B_1 - 12*f2_5 - 12*NotifyEventJobQueuedB_1_16 + 12*FetchJobE_1_13 + 12*QueueJobB_1_6 + 12*QueueJobB_1_19 - 12*f3_16 + 12*Perform_Work_B_1_18 + 12*Perform_Work_B_1_11 + 12*QueueJobB_1_11 + 12*FetchJobE_1_6 - 12*NotifyEventJobQueuedB_1_4 + 12*Schedule_Task_E_1_PerformWork_14 - 12*AvailableJobId_5 - 12*NotifyEventJobQueuedB_1_15 - 12*f2_20 + 4*place_460 + 12*FetchJobE_1_14 + 12*Schedule_Task_E_1_CheckSource_0 - 12*AvailableJobId_15 + 12*Schedule_Task_E_1_PerformWork_13 + 12*Schedule_Task_E_1_PerformWork_0 + 12*QueueJobB_1_17 + 12*Perform_Work_B_1_3 - 12*f1_10 + 12*FetchJobE_1_9 - 12*f2_4 - 12*f3_5 + 12*Perform_Work_B_1_19 + 12*Perform_Work_B_1_17 + 12*QueueJobB_1_7 + 12*QueueJobB_1_0 + 12*Schedule_Task_E_1_PerformWork_8 + 12*Perform_Work_B_1_12 - 12*block - 12*NotifyEventJobQueuedB_1_5 + 3*place_523_1 + 12*Perform_Work_B_1_9 + 6*place_458 + 12*Perform_Work_B_1_2 + 12*FetchJobE_1_8 + 6*place_521_1 + 12*cJobCnt - 12*f1_20 = 12
inv : -AvailableJobId_9 - Schedule_Task_E_1_PerformWork_7 + f3_4 + f1_15 + CreatedJobs_7_4 - Schedule_Task_E_1_PerformWork_6 - AvailableJobId_2 + QueueJobB_1_16 + f2_16 + f1_1 + place_482_1_5 - FetchJobE_1_17 + f2_10 + CreatedJobs_7_5 - Schedule_Task_E_1_PerformWork_17 - place_462 - FetchJobE_1_11 - Schedule_Task_E_1_PerformWork_3 - Perform_Work_B_1_0 - Perform_Work_B_1_14 + QueueJobB_1_15 - Perform_Work_B_1_7 - FetchJobE_1_18 + QueueJobB_1_1 + f3_1 + f1_16 + f2_15 + f3_15 + f2_1 - Perform_Work_B_1_13 - Schedule_Task_E_1_PerformWork_9 + f3_20 - AvailableJobId_11 + CreatedJobs_7_2 - FetchJobE_1_19 - Schedule_Task_E_1_PerformWork_18 + place_482_1_4 - Perform_Work_B_1_8 - AvailableJobId_3 - FetchJobE_1_2 + NotifyEventJobQueuedB_1_20 - Schedule_Task_E_1_PerformWork_19 + f1_4 + QueueJobE_1 + place_482_1_3 + NotifyEventJobQueuedB_1_1 + QueueJobB_1_4 - Schedule_Task_E_1_PerformWork_12 - Schedule_Task_E_1_PerformWork_2 + NotifyEventJobQueuedB_1_10 - Perform_Work_B_1_6 - FetchJobE_1_12 - FetchJobE_1_3 + f1_5 - place_456 - FetchJobE_1_0 - Schedule_Task_E_1_PerformWork_11 - FetchJobE_1_7 - AvailableJobId_6 - AvailableJobId_13 + f3_10 + place_482_1_2 + QueueJobB_1_5 + f2_5 + CreatedJobs_12_3 + NotifyEventJobQueuedB_1_16 - FetchJobE_1_13 - AvailableJobId_19 + f3_16 - Perform_Work_B_1_18 - AvailableJobId_0 + place_482_1_1 - Perform_Work_B_1_11 - FetchJobE_1_6 + CreatedJobs_7_1 + CreatedJobs_12_1 + NotifyEventJobQueuedB_1_4 - Schedule_Task_E_1_PerformWork_14 - AvailableJobId_18 - AvailableJobId_14 + QueueJobB_1_20 + NotifyEventJobQueuedB_1_15 + f2_20 - place_460 - FetchJobE_1_14 - Schedule_Task_E_1_PerformWork_13 - Schedule_Task_E_1_PerformWork_0 + CreatedJobs_7_3 - Perform_Work_B_1_3 + f1_10 + QueueJobB_1_10 - FetchJobE_1_9 + f2_4 - AvailableJobId_8 + f3_5 - Perform_Work_B_1_19 - Perform_Work_B_1_17 + CreatedJobs_12_5 + CreatedJobs_12_4 - Schedule_Task_E_1_PerformWork_8 - Perform_Work_B_1_12 + block + NotifyEventJobQueuedB_1_5 - Perform_Work_B_1_9 - place_458 - Perform_Work_B_1_2 - AvailableJobId_17 - FetchJobE_1_8 + CreatedJobs_12_2 + f1_20 = -9
inv : CreatedJobs_6_4 + CreatedJobs_6_1 + CreatedJobs_6_2 + AvailableJobId_6 + CreatedJobs_6_5 + CreatedJobs_6_3 = 1
inv : f1_19 + f3_4 + f1_0 + f3_13 + f1_15 + f2_16 + f2_2 + f1_1 + f3_0 + f1_8 + f2_10 + f3_14 + f3_7 + f3_6 + f1_2 + f3_1 + f1_16 + f2_11 + f2_15 + f3_15 + f2_1 + f3_20 + f2_18 + f3_19 + f1_3 + f2_8 + f1_7 + f2_0 + f1_6 + f1_13 + f2_17 + f1_4 + f3_9 + f3_18 + f1_5 + f1_14 + f2_9 + f3_8 + f2_13 + f3_17 + f3_10 + f2_5 + f3_3 + f2_19 + f3_16 + f3_2 + f2_12 + f2_7 + f3_11 + f1_12 + f1_11 + f2_6 + f2_20 + f1_17 + f1_10 + f2_4 + f3_5 + f3_12 + block + f2_3 + f1_18 + f1_9 + f2_14 + f1_20 = 3
inv : CreatedJobs_7_4 + CreatedJobs_2_4 - CreatedJobs_14_5 - CreatedJobs_14_3 - AvailableJobId_4 + CreatedJobs_15_4 + CreatedJobs_16_4 - CreatedJobs_13_5 - CreatedJobs_14_2 + CreatedJobs_9_4 + CreatedJobs_20_4 + place_482_1_4 + CreatedJobs_0_4 - CreatedJobs_13_3 + CreatedJobs_8_4 + CreatedJobs_1_4 + CreatedJobs_17_4 - CreatedJobs_4_3 + DataOnSrc_4 - CreatedJobs_6_1 - CreatedJobs_6_2 - CreatedJobs_19_1 - AvailableJobId_6 - CreatedJobs_6_5 + CreatedJobs_18_4 - AvailableJobId_13 - CreatedJobs_13_1 - CreatedJobs_19_2 - CreatedJobs_19_3 - AvailableJobId_19 - CreatedJobs_13_2 - CreatedJobs_4_2 + CreatedJobs_10_4 - CreatedJobs_6_3 + CreatedJobs_3_4 - CreatedJobs_4_1 - AvailableJobId_14 - CreatedJobs_4_5 + CreatedJobs_11_4 + CreatedJobs_12_4 - CreatedJobs_19_5 - CreatedJobs_14_1 + ModifiedSrc_4 + CreatedJobs_5_4 = -4
inv : -AvailableJobId_9 - AvailableJobId_16 - CreatedJobs_16_2 + CreatedJobs_2_1 - CreatedJobs_9_3 - CreatedJobs_16_3 - CreatedJobs_9_2 - CreatedJobs_16_4 + CreatedJobs_1_1 - CreatedJobs_9_4 - CreatedJobs_17_2 + CreatedJobs_11_1 - AvailableJobId_3 - CreatedJobs_3_3 + CreatedJobs_8_1 - CreatedJobs_16_5 + CreatedJobs_10_1 + TheSour_1 + CreatedJobs_0_1 - CreatedJobs_17_4 + CreatedJobs_6_1 + CreatedJobs_19_1 - CreatedJobs_18_4 + CreatedJobs_13_1 - CreatedJobs_18_2 + place_482_1_1 + CreatedJobs_20_1 - CreatedJobs_3_4 + CreatedJobs_7_1 + CreatedJobs_12_1 + CreatedJobs_4_1 - CreatedJobs_3_5 - AvailableJobId_18 - CreatedJobs_17_5 - CreatedJobs_18_5 + ModifiedSrc_1 - CreatedJobs_17_3 + CreatedJobs_15_1 - CreatedJobs_3_2 - CreatedJobs_9_5 + CreatedJobs_14_1 - CreatedJobs_18_3 - AvailableJobId_17 + CreatedJobs_5_1 = -4
inv : f1_1 + Perform_Work_B_1_1 + QueueJobB_1_1 + f3_1 + f2_1 + AvailableJobId_1 + Schedule_Task_E_1_PerformWork_1 + NotifyEventJobQueuedB_1_1 + FetchJobE_1_1 = 1
inv : FetchJobE_1_5 + Perform_Work_B_1_5 + f1_5 + QueueJobB_1_5 + f2_5 + AvailableJobId_5 + f3_5 + NotifyEventJobQueuedB_1_5 + Schedule_Task_E_1_PerformWork_5 = 1
inv : CreatedJobs_3_1 + AvailableJobId_3 + CreatedJobs_3_3 + CreatedJobs_3_4 + CreatedJobs_3_5 + CreatedJobs_3_2 = 1
inv : CreatedJobs_10_5 + AvailableJobId_10 + CreatedJobs_10_2 + CreatedJobs_10_1 + CreatedJobs_10_4 + CreatedJobs_10_3 = 1
Total of 57 invariants.
[2021-05-17 03:19:48] [INFO ] Computed 57 place invariants in 50 ms
[2021-05-17 03:19:48] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=2 took 334 ms
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :36082 after 59358
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :59358 after 83278
SDD proceeding with computation,2 properties remain. new max is 512
SDD size :83278 after 149396
[2021-05-17 03:19:52] [INFO ] Proved 336 variables to be positive in 4342 ms
[2021-05-17 03:19:52] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-01
[2021-05-17 03:19:52] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(SAT) depth K=0 took 129 ms
[2021-05-17 03:19:52] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-02
[2021-05-17 03:19:52] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(SAT) depth K=0 took 64 ms
Compilation finished in 7292 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/tmp/ltsmin13689000153090943140]
Link finished in 132 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, PolyORBNTPTS05J20ReachabilityCardinality01==true], workingDir=/tmp/ltsmin13689000153090943140]
[2021-05-17 03:19:55] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(UNSAT) depth K=3 took 6304 ms
[2021-05-17 03:19:55] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-01
[2021-05-17 03:19:55] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(SAT) depth K=1 took 2135 ms
[2021-05-17 03:19:55] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-02
[2021-05-17 03:19:55] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(SAT) depth K=1 took 256 ms
[2021-05-17 03:19:58] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=3 took 3159 ms
SDD proceeding with computation,2 properties remain. new max is 1024
SDD size :149396 after 1.71174e+06
[2021-05-17 03:22:30] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(UNSAT) depth K=4 took 151993 ms
[2021-05-17 03:22:50] [INFO ] Induction result is UNSAT, proved invariant PolyORBNT-PT-S05J20-ReachabilityCardinality-01
[2021-05-17 03:22:50] [INFO ] Induction result is UNSAT, successfully proved induction at step 2 for PolyORBNT-PT-S05J20-ReachabilityCardinality-01
FORMULA PolyORBNT-PT-S05J20-ReachabilityCardinality-01 TRUE TECHNIQUES SAT_SMT K_INDUCTION(2)
[2021-05-17 03:22:50] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-01(TRUE) depth K=2 took 174971 ms
SDD proceeding with computation,2 properties remain. new max is 2048
SDD size :1.71174e+06 after 5.1146e+06
SDD proceeding with computation,2 properties remain. new max is 4096
SDD size :5.1146e+06 after 5.11691e+06
[2021-05-17 03:25:21] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=4 took 171515 ms
[2021-05-17 03:31:32] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=5 took 370329 ms
[2021-05-17 03:34:51] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-02
[2021-05-17 03:34:51] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(SAT) depth K=2 took 720676 ms
SDD proceeding with computation,2 properties remain. new max is 8192
SDD size :5.11691e+06 after 1.91226e+07
[2021-05-17 03:35:33] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-02
[2021-05-17 03:35:33] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(SAT) depth K=3 took 42203 ms
pins2lts-mc-linux64, 0.000: Registering PINS so language module
pins2lts-mc-linux64( 7/ 8), 0.001: library has no initializer
pins2lts-mc-linux64( 7/ 8), 0.001: loading model GAL
pins2lts-mc-linux64( 7/ 8), 0.013: completed loading model GAL
pins2lts-mc-linux64( 3/ 8), 0.036: library has no initializer
pins2lts-mc-linux64( 3/ 8), 0.036: loading model GAL
pins2lts-mc-linux64( 3/ 8), 0.039: completed loading model GAL
pins2lts-mc-linux64( 0/ 8), 0.063: Loading model from ./gal.so
pins2lts-mc-linux64( 0/ 8), 0.063: library has no initializer
pins2lts-mc-linux64( 0/ 8), 0.063: loading model GAL
pins2lts-mc-linux64( 0/ 8), 0.066: completed loading model GAL
pins2lts-mc-linux64( 0/ 8), 0.066: Initializing POR dependencies: labels 454, guards 452
pins2lts-mc-linux64( 1/ 8), 0.089: library has no initializer
pins2lts-mc-linux64( 1/ 8), 0.089: loading model GAL
pins2lts-mc-linux64( 1/ 8), 0.093: completed loading model GAL
pins2lts-mc-linux64( 2/ 8), 0.116: library has no initializer
pins2lts-mc-linux64( 2/ 8), 0.116: loading model GAL
pins2lts-mc-linux64( 4/ 8), 0.143: library has no initializer
pins2lts-mc-linux64( 4/ 8), 0.143: loading model GAL
pins2lts-mc-linux64( 4/ 8), 0.147: completed loading model GAL
pins2lts-mc-linux64( 5/ 8), 0.170: library has no initializer
pins2lts-mc-linux64( 5/ 8), 0.170: loading model GAL
pins2lts-mc-linux64( 6/ 8), 0.197: library has no initializer
pins2lts-mc-linux64( 6/ 8), 0.197: loading model GAL
pins2lts-mc-linux64( 6/ 8), 0.279: completed loading model GAL
pins2lts-mc-linux64( 5/ 8), 0.602: completed loading model GAL
pins2lts-mc-linux64( 2/ 8), 0.655: completed loading model GAL
pins2lts-mc-linux64( 0/ 8), 2.411: Forcing use of the an ignoring proviso (closed-set)
pins2lts-mc-linux64( 6/ 8), 2.523: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 2/ 8), 2.524: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 7/ 8), 2.525: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 3/ 8), 2.525: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 5/ 8), 2.536: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 4/ 8), 2.537: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 1/ 8), 2.537: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 0/ 8), 2.538: "PolyORBNTPTS05J20ReachabilityCardinality01==true" is not a file, parsing as formula...
pins2lts-mc-linux64( 0/ 8), 2.538: There are 454 state labels and 1 edge labels
pins2lts-mc-linux64( 0/ 8), 2.538: State length is 336, there are 452 groups
pins2lts-mc-linux64( 0/ 8), 2.538: Running bfs using 8 cores
pins2lts-mc-linux64( 0/ 8), 2.538: Using a non-indexing tree table with 2^27 elements
pins2lts-mc-linux64( 0/ 8), 2.538: Successor permutation: none
pins2lts-mc-linux64( 0/ 8), 2.538: Visible groups: 288 / 452, labels: 1 / 454
pins2lts-mc-linux64( 0/ 8), 2.538: POR cycle proviso: closed-set
pins2lts-mc-linux64( 0/ 8), 2.538: Global bits: 0, count bits: 0, local bits: 0
pins2lts-mc-linux64( 2/ 8), 4.093: ~7 levels ~960 states ~2832 transitions
pins2lts-mc-linux64( 5/ 8), 4.316: ~3 levels ~1920 states ~10496 transitions
pins2lts-mc-linux64( 7/ 8), 4.580: ~7 levels ~3840 states ~36744 transitions
pins2lts-mc-linux64( 5/ 8), 4.895: ~4 levels ~7680 states ~26640 transitions
pins2lts-mc-linux64( 5/ 8), 5.123: ~5 levels ~15360 states ~41448 transitions
pins2lts-mc-linux64( 5/ 8), 5.459: ~7 levels ~30720 states ~58472 transitions
pins2lts-mc-linux64( 5/ 8), 7.865: ~11 levels ~61440 states ~148560 transitions
pins2lts-mc-linux64( 5/ 8), 12.797: ~13 levels ~122880 states ~306752 transitions
pins2lts-mc-linux64( 2/ 8), 17.015: ~14 levels ~245760 states ~526496 transitions
pins2lts-mc-linux64( 2/ 8), 34.081: ~18 levels ~491520 states ~1231440 transitions
pins2lts-mc-linux64( 5/ 8), 51.332: ~37 levels ~983040 states ~2433624 transitions
pins2lts-mc-linux64( 5/ 8), 76.968: ~44 levels ~1966080 states ~4237912 transitions
pins2lts-mc-linux64( 5/ 8), 149.046: ~73 levels ~3932160 states ~8907304 transitions
pins2lts-mc-linux64( 6/ 8), 312.693: ~21 levels ~7864320 states ~19031152 transitions
pins2lts-mc-linux64( 6/ 8), 573.693: ~37 levels ~15728640 states ~36429304 transitions
pins2lts-mc-linux64( 0/ 8), 1085.044: Error: tree leafs table full! Change -s/--ratio.
pins2lts-mc-linux64( 0/ 8), 1085.284:
pins2lts-mc-linux64( 0/ 8), 1085.284: mean standard work distribution: 58.3% (states) 3.9% (transitions)
pins2lts-mc-linux64( 0/ 8), 1085.284:
pins2lts-mc-linux64( 0/ 8), 1085.284: Explored 16875475 states 74674723 transitions, fanout: 4.425
pins2lts-mc-linux64( 0/ 8), 1085.284: Total exploration time 1082.690 sec (1082.510 sec minimum, 1082.560 sec on average)
pins2lts-mc-linux64( 0/ 8), 1085.284: States per second: 15587, Transitions per second: 68971
pins2lts-mc-linux64( 0/ 8), 1085.284: Ignoring proviso: 0
pins2lts-mc-linux64( 0/ 8), 1085.284:
pins2lts-mc-linux64( 0/ 8), 1085.284: Queue width: 8B, total height: 9737368, memory: 74.29MB
pins2lts-mc-linux64( 0/ 8), 1085.284: Tree memory: 455.8MB, 18.2 B/state, compr.: 1.4%
pins2lts-mc-linux64( 0/ 8), 1085.284: Tree fill ratio (roots/leafs): 19.0%/99.0%
pins2lts-mc-linux64( 0/ 8), 1085.284: Stored 454 string chucks using 0MB
pins2lts-mc-linux64( 0/ 8), 1085.284: Total memory used for chunk indexing: 0MB
pins2lts-mc-linux64( 0/ 8), 1085.284: Est. total memory use: 530.1MB (~1098.3MB paged-in)
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, PolyORBNTPTS05J20ReachabilityCardinality01==true], workingDir=/tmp/ltsmin13689000153090943140]
255
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202104292328/bin/pins2lts-mc-linux64, ./gal.so, --threads=8, -p, --pins-guards, --when, -i, PolyORBNTPTS05J20ReachabilityCardinality01==true], workingDir=/tmp/ltsmin13689000153090943140]
255
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:214)
at fr.lip6.move.gal.application.LTSminRunner.access$10(LTSminRunner.java:165)
at fr.lip6.move.gal.application.LTSminRunner$1.checkProperties(LTSminRunner.java:154)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:98)
at java.base/java.lang.Thread.run(Thread.java:834)
SDD proceeding with computation,2 properties remain. new max is 16384
SDD size :1.91226e+07 after 1.91324e+07
[2021-05-17 03:39:02] [INFO ] Induction result is SAT, non conclusive we might be starting from unreachable statesPolyORBNT-PT-S05J20-ReachabilityCardinality-02
[2021-05-17 03:39:02] [INFO ] KInduction solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(SAT) depth K=4 took 209349 ms
SDD proceeding with computation,2 properties remain. new max is 32768
SDD size :1.91324e+07 after 1.91711e+07
Detected timeout of ITS tools.
[2021-05-17 03:41:18] [INFO ] Applying decomposition
[2021-05-17 03:41:18] [INFO ] Flatten gal took : 18 ms
[2021-05-17 03:41:18] [INFO ] Decomposing Gal with order
[2021-05-17 03:41:18] [INFO ] Rewriting arrays to variables to allow decomposition.
[2021-05-17 03:41:19] [INFO ] Removed a total of 730 redundant transitions.
[2021-05-17 03:41:19] [INFO ] Flatten gal took : 86 ms
[2021-05-17 03:41:19] [INFO ] Fuse similar labels procedure discarded/fused a total of 42 labels/synchronizations in 5 ms.
[2021-05-17 03:41:19] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality7343250326168817836.gal : 4 ms
[2021-05-17 03:41:19] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality2074139869153726470.prop : 0 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality7343250326168817836.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality2074139869153726470.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality7343250326168817836.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality2074139869153726470.prop --nowitness --gen-order FOLLOW
Loading property file /tmp/ReachabilityCardinality2074139869153726470.prop.
SDD proceeding with computation,1 properties remain. new max is 4
SDD size :1 after 8
SDD proceeding with computation,1 properties remain. new max is 8
SDD size :8 after 32
SDD proceeding with computation,1 properties remain. new max is 16
SDD size :32 after 68
SDD proceeding with computation,1 properties remain. new max is 32
SDD size :68 after 84
SDD proceeding with computation,1 properties remain. new max is 64
SDD size :84 after 25250
SDD proceeding with computation,1 properties remain. new max is 128
SDD size :25250 after 40555
SDD proceeding with computation,1 properties remain. new max is 256
SDD size :40555 after 57625
SDD proceeding with computation,1 properties remain. new max is 512
SDD size :57625 after 77878
SDD proceeding with computation,1 properties remain. new max is 1024
SDD size :77878 after 1.54881e+06
SDD proceeding with computation,1 properties remain. new max is 2048
SDD size :1.54881e+06 after 5.115e+06
SDD proceeding with computation,1 properties remain. new max is 4096
SDD size :5.115e+06 after 5.11692e+06
[2021-05-17 03:43:51] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=6 took 739740 ms
SDD proceeding with computation,1 properties remain. new max is 8192
SDD size :5.11692e+06 after 6.66023e+06
SDD proceeding with computation,1 properties remain. new max is 16384
SDD size :6.66023e+06 after 1.91417e+07
SDD proceeding with computation,1 properties remain. new max is 32768
SDD size :1.91417e+07 after 1.91543e+07
SDD proceeding with computation,1 properties remain. new max is 65536
SDD size :1.91543e+07 after 2.56756e+07
[2021-05-17 03:56:30] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=7 took 758947 ms
SDD proceeding with computation,1 properties remain. new max is 131072
SDD size :2.56756e+07 after 4.21162e+07
Detected timeout of ITS tools.
[2021-05-17 04:02:51] [INFO ] Flatten gal took : 163 ms
[2021-05-17 04:02:51] [INFO ] Input system was already deterministic with 452 transitions.
[2021-05-17 04:02:51] [INFO ] Transformed 336 places.
[2021-05-17 04:02:51] [INFO ] Transformed 452 transitions.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit/bin//..//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
P-invariant computation with GreatSPN timed out. Skipping.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit/bin//..//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
[2021-05-17 04:03:22] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality13678993820252695256.gal : 2 ms
[2021-05-17 04:03:22] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality1580056763296064159.prop : 9 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202104292328/bin/its-reach-linux64, --gc-threshold, 2000000, --quiet, -i, /tmp/ReachabilityCardinality13678993820252695256.gal, -t, CGAL, -reachable-file, /tmp/ReachabilityCardinality1580056763296064159.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.202104292328/bin/its-reach-linux64 --gc-threshold 2000000 --quiet -i /tmp/ReachabilityCardinality13678993820252695256.gal -t CGAL -reachable-file /tmp/ReachabilityCardinality1580056763296064159.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 /tmp/ReachabilityCardinality1580056763296064159.prop.
SDD proceeding with computation,1 properties remain. new max is 4
SDD size :1 after 4
SDD proceeding with computation,1 properties remain. new max is 8
SDD size :4 after 128
SDD proceeding with computation,1 properties remain. new max is 16
SDD size :191 after 244
SDD proceeding with computation,1 properties remain. new max is 32
SDD size :244 after 250
SDD proceeding with computation,1 properties remain. new max is 64
SDD size :250 after 258
SDD proceeding with computation,1 properties remain. new max is 128
SDD size :258 after 268
SDD proceeding with computation,1 properties remain. new max is 256
SDD size :268 after 282
SDD proceeding with computation,1 properties remain. new max is 512
SDD size :282 after 341
SDD proceeding with computation,1 properties remain. new max is 1024
SDD size :341 after 2450
SDD proceeding with computation,1 properties remain. new max is 2048
SDD size :2450 after 3413
SDD proceeding with computation,1 properties remain. new max is 4096
SDD size :3413 after 4850
SDD proceeding with computation,1 properties remain. new max is 8192
SDD size :4850 after 10007
SDD proceeding with computation,1 properties remain. new max is 16384
SDD size :10007 after 173615
SDD proceeding with computation,1 properties remain. new max is 32768
SDD size :173615 after 265727
SDD proceeding with computation,1 properties remain. new max is 65536
SDD size :265727 after 473945
[2021-05-17 04:12:17] [INFO ] BMC solution for property PolyORBNT-PT-S05J20-ReachabilityCardinality-02(UNSAT) depth K=8 took 947034 ms

BK_TIME_CONFINEMENT_REACHED

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

+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ ReachabilityCardinality = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution ReachabilityCardinality -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
++ cut -d . -f 9
++ ls /home/mcc/BenchKit/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202104292328.jar
+ VERSION=0
+ echo 'Running Version 0'
+ /home/mcc/BenchKit/bin//..//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination ReachabilityCardinality -spotpath /home/mcc/BenchKit/bin//..//ltlfilt -z3path /home/mcc/BenchKit/bin//..//z3/bin/z3 -yices2path /home/mcc/BenchKit/bin//..//yices/bin/yices -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss128m -Xms40m -Xmx16000m

Sequence of Actions to be Executed by the VM

This is useful if one wants to reexecute the tool in the VM from the submitted image disk.

set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="PolyORBNT-PT-S05J20"
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"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itstools"
echo " Input is PolyORBNT-PT-S05J20, 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 r159-oct2-162089268400446"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/PolyORBNT-PT-S05J20.tgz
mv PolyORBNT-PT-S05J20 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 ;