fond
Model Checking Contest 2023
13th edition, Paris, France, April 26, 2023 (at TOOLympics II)
Execution of r389-oct2-167903713200158
Last Updated
May 14, 2023

About the Execution of ITS-Tools for ShieldIIPs-PT-050B

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
16217.552 3600000.00 10276198.00 163820.60 TFTT?TFF?FTTTFFF normal

Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2023-input.r389-oct2-167903713200158.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.........................
=====================================================================
Generated by BenchKit 2-5348
Executing tool itstools
Input is ShieldIIPs-PT-050B, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r389-oct2-167903713200158
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 1.3M
-rw-r--r-- 1 mcc users 6.5K Feb 25 16:39 CTLCardinality.txt
-rw-r--r-- 1 mcc users 67K Feb 25 16:39 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.2K Feb 25 16:38 CTLFireability.txt
-rw-r--r-- 1 mcc users 59K Feb 25 16:38 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:41 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K Jan 29 11:41 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.7K Feb 25 16:55 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Feb 25 16:55 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Feb 25 16:55 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Feb 25 16:55 LTLFireability.xml
-rw-r--r-- 1 mcc users 11K Feb 25 16:39 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 115K Feb 25 16:39 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 11K Feb 25 16:39 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 93K Feb 25 16:39 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Feb 25 16:55 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Feb 25 16:55 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 equiv_col
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 846K Mar 5 18:23 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

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

=== Now, execution of the tool begins

BK_START 1679179281354

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=ReachabilityCardinality
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=3600
BK_INPUT=ShieldIIPs-PT-050B
Not applying reductions.
Model is PT
ReachabilityCardinality PT
Running Version 202303021504
[2023-03-18 22:41:23] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityCardinality, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2023-03-18 22:41:23] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-18 22:41:23] [INFO ] Load time of PNML (sax parser for PT used): 158 ms
[2023-03-18 22:41:24] [INFO ] Transformed 3003 places.
[2023-03-18 22:41:24] [INFO ] Transformed 2953 transitions.
[2023-03-18 22:41:24] [INFO ] Found NUPN structural information;
[2023-03-18 22:41:24] [INFO ] Parsed PT model containing 3003 places and 2953 transitions and 8906 arcs in 374 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 17 ms.
Working with output stream class java.io.PrintStream
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-12 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-18 22:41:24] [INFO ] Flatten gal took : 282 ms
[2023-03-18 22:41:24] [INFO ] Flatten gal took : 185 ms
Incomplete random walk after 10000 steps, including 2 resets, run finished after 726 ms. (steps per millisecond=13 ) properties (out of 14) seen :10
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-14 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-11 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-10 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-09 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-05 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-03 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-00 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 41 ms. (steps per millisecond=243 ) properties (out of 4) seen :0
[2023-03-18 22:41:24] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality16361092400039849387.gal : 74 ms
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 40 ms. (steps per millisecond=250 ) properties (out of 4) seen :0
[2023-03-18 22:41:25] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality772446901170353568.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality16361092400039849387.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality772446901170353568.prop' '--nowitness' '--gen-order' 'FOLLOW'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...328
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 37 ms. (steps per millisecond=270 ) properties (out of 4) seen :0
Running SMT prover for 4 properties.
// Phase 1: matrix 2953 rows 3003 cols
[2023-03-18 22:41:25] [INFO ] Computed 451 place invariants in 34 ms
Loading property file /tmp/ReachabilityCardinality772446901170353568.prop.
[2023-03-18 22:41:26] [INFO ] After 819ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:4
[2023-03-18 22:41:26] [INFO ] [Nat]Absence check using 451 positive place invariants in 189 ms returned sat
SDD proceeding with computation,14 properties remain. new max is 4
SDD size :1 after 5
SDD proceeding with computation,14 properties remain. new max is 8
SDD size :5 after 10
SDD proceeding with computation,14 properties remain. new max is 16
SDD size :10 after 19
SDD proceeding with computation,14 properties remain. new max is 32
SDD size :19 after 36
Reachability property ShieldIIPs-PT-050B-ReachabilityCardinality-10 is true.
SDD proceeding with computation,13 properties remain. new max is 32
SDD size :36 after 73
SDD proceeding with computation,13 properties remain. new max is 64
SDD size :73 after 392
SDD proceeding with computation,13 properties remain. new max is 128
SDD size :392 after 552
SDD proceeding with computation,13 properties remain. new max is 256
SDD size :552 after 103243
SDD proceeding with computation,13 properties remain. new max is 512
SDD size :103243 after 1.57252e+08
Reachability property ShieldIIPs-PT-050B-ReachabilityCardinality-05 is true.
SDD proceeding with computation,12 properties remain. new max is 512
SDD size :1.57252e+08 after 9.31044e+14
SDD proceeding with computation,12 properties remain. new max is 1024
SDD size :9.31044e+14 after 9.95461e+21
[2023-03-18 22:41:33] [INFO ] After 6521ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :4
[2023-03-18 22:41:36] [INFO ] Deduced a trap composed of 19 places in 2133 ms of which 18 ms to minimize.
[2023-03-18 22:41:37] [INFO ] Deduced a trap composed of 18 places in 1154 ms of which 3 ms to minimize.
[2023-03-18 22:41:39] [INFO ] Deduced a trap composed of 21 places in 2104 ms of which 17 ms to minimize.
[2023-03-18 22:41:41] [INFO ] Deduced a trap composed of 17 places in 1225 ms of which 9 ms to minimize.
[2023-03-18 22:41:42] [INFO ] Deduced a trap composed of 18 places in 976 ms of which 16 ms to minimize.
[2023-03-18 22:41:44] [INFO ] Deduced a trap composed of 28 places in 1491 ms of which 5 ms to minimize.
[2023-03-18 22:41:45] [INFO ] Deduced a trap composed of 16 places in 1310 ms of which 5 ms to minimize.
[2023-03-18 22:41:46] [INFO ] Deduced a trap composed of 28 places in 977 ms of which 1 ms to minimize.
[2023-03-18 22:41:49] [INFO ] Deduced a trap composed of 14 places in 1242 ms of which 4 ms to minimize.
[2023-03-18 22:41:50] [INFO ] Deduced a trap composed of 24 places in 1083 ms of which 2 ms to minimize.
[2023-03-18 22:41:52] [INFO ] Deduced a trap composed of 18 places in 1265 ms of which 2 ms to minimize.
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream close...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.refineWithTraps(DeadlockTester.java:1255)
at fr.lip6.move.gal.structural.smt.DeadlockTester.refineResultsWithTraps(DeadlockTester.java:736)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:656)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMTIncremental(DeadlockTester.java:350)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMT(DeadlockTester.java:223)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.applyReductions(ReachabilitySolver.java:95)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:902)
at fr.lip6.move.gal.application.Application.start(Application.java:178)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:45)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:136)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:104)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:402)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:596)
at org.eclipse.equinox.launcher.Main.run(Main.java:1467)
at org.eclipse.equinox.launcher.Main.main(Main.java:1440)
[2023-03-18 22:41:52] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-18 22:41:52] [INFO ] After 26173ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :0 real:4
Parikh walk visited 0 properties in 565 ms.
Support contains 93 out of 3003 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 3003/3003 places, 2953/2953 transitions.
Drop transitions removed 234 transitions
Trivial Post-agglo rules discarded 234 transitions
Performed 234 trivial Post agglomeration. Transition count delta: 234
Iterating post reduction 0 with 234 rules applied. Total rules applied 234 place count 3003 transition count 2719
Reduce places removed 234 places and 0 transitions.
Performed 5 Post agglomeration using F-continuation condition.Transition count delta: 5
Iterating post reduction 1 with 239 rules applied. Total rules applied 473 place count 2769 transition count 2714
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 2 with 5 rules applied. Total rules applied 478 place count 2764 transition count 2714
Performed 245 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 245 Pre rules applied. Total rules applied 478 place count 2764 transition count 2469
Deduced a syphon composed of 245 places in 6 ms
Reduce places removed 245 places and 0 transitions.
Iterating global reduction 3 with 490 rules applied. Total rules applied 968 place count 2519 transition count 2469
Discarding 330 places :
Symmetric choice reduction at 3 with 330 rule applications. Total rules 1298 place count 2189 transition count 2139
Iterating global reduction 3 with 330 rules applied. Total rules applied 1628 place count 2189 transition count 2139
Performed 133 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 133 Pre rules applied. Total rules applied 1628 place count 2189 transition count 2006
Deduced a syphon composed of 133 places in 15 ms
Reduce places removed 133 places and 0 transitions.
Iterating global reduction 3 with 266 rules applied. Total rules applied 1894 place count 2056 transition count 2006
Performed 700 Post agglomeration using F-continuation condition.Transition count delta: 700
Deduced a syphon composed of 700 places in 4 ms
Reduce places removed 700 places and 0 transitions.
Iterating global reduction 3 with 1400 rules applied. Total rules applied 3294 place count 1356 transition count 1306
Renaming transitions due to excessive name length > 1024 char.
Partial Free-agglomeration rule applied 320 times.
Drop transitions removed 320 transitions
Iterating global reduction 3 with 320 rules applied. Total rules applied 3614 place count 1356 transition count 1306
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 3 with 1 rules applied. Total rules applied 3615 place count 1355 transition count 1305
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 3 with 1 rules applied. Total rules applied 3616 place count 1354 transition count 1305
Applied a total of 3616 rules in 896 ms. Remains 1354 /3003 variables (removed 1649) and now considering 1305/2953 (removed 1648) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 897 ms. Remains : 1354/3003 places, 1305/2953 transitions.
Incomplete random walk after 10000 steps, including 2 resets, run finished after 271 ms. (steps per millisecond=36 ) properties (out of 4) seen :2
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-06 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldIIPs-PT-050B-ReachabilityCardinality-02 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 80 ms. (steps per millisecond=125 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 2) seen :0
Running SMT prover for 2 properties.
// Phase 1: matrix 1305 rows 1354 cols
[2023-03-18 22:41:54] [INFO ] Computed 450 place invariants in 35 ms
[2023-03-18 22:41:54] [INFO ] After 178ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:2
[2023-03-18 22:41:54] [INFO ] [Nat]Absence check using 441 positive place invariants in 92 ms returned sat
[2023-03-18 22:41:54] [INFO ] [Nat]Absence check using 441 positive and 9 generalized place invariants in 2 ms returned sat
[2023-03-18 22:41:56] [INFO ] After 1205ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :2
[2023-03-18 22:41:56] [INFO ] Deduced a trap composed of 4 places in 265 ms of which 1 ms to minimize.
[2023-03-18 22:41:56] [INFO ] Deduced a trap composed of 4 places in 300 ms of which 0 ms to minimize.
[2023-03-18 22:41:57] [INFO ] Deduced a trap composed of 5 places in 299 ms of which 1 ms to minimize.
[2023-03-18 22:41:57] [INFO ] Deduced a trap composed of 5 places in 232 ms of which 1 ms to minimize.
[2023-03-18 22:41:58] [INFO ] Deduced a trap composed of 7 places in 661 ms of which 5 ms to minimize.
[2023-03-18 22:41:58] [INFO ] Deduced a trap composed of 4 places in 249 ms of which 1 ms to minimize.
[2023-03-18 22:41:58] [INFO ] Deduced a trap composed of 6 places in 384 ms of which 0 ms to minimize.
[2023-03-18 22:41:59] [INFO ] Deduced a trap composed of 8 places in 213 ms of which 0 ms to minimize.
[2023-03-18 22:41:59] [INFO ] Deduced a trap composed of 6 places in 235 ms of which 1 ms to minimize.
[2023-03-18 22:41:59] [INFO ] Deduced a trap composed of 7 places in 230 ms of which 1 ms to minimize.
[2023-03-18 22:42:00] [INFO ] Deduced a trap composed of 4 places in 349 ms of which 1 ms to minimize.
[2023-03-18 22:42:00] [INFO ] Deduced a trap composed of 10 places in 397 ms of which 1 ms to minimize.
[2023-03-18 22:42:01] [INFO ] Deduced a trap composed of 3 places in 303 ms of which 1 ms to minimize.
[2023-03-18 22:42:01] [INFO ] Deduced a trap composed of 4 places in 460 ms of which 0 ms to minimize.
[2023-03-18 22:42:01] [INFO ] Deduced a trap composed of 5 places in 243 ms of which 1 ms to minimize.
[2023-03-18 22:42:02] [INFO ] Deduced a trap composed of 4 places in 319 ms of which 1 ms to minimize.
[2023-03-18 22:42:02] [INFO ] Deduced a trap composed of 5 places in 262 ms of which 1 ms to minimize.
[2023-03-18 22:42:03] [INFO ] Deduced a trap composed of 5 places in 405 ms of which 0 ms to minimize.
[2023-03-18 22:42:03] [INFO ] Deduced a trap composed of 6 places in 267 ms of which 0 ms to minimize.
[2023-03-18 22:42:03] [INFO ] Deduced a trap composed of 10 places in 227 ms of which 1 ms to minimize.
[2023-03-18 22:42:03] [INFO ] Deduced a trap composed of 6 places in 209 ms of which 2 ms to minimize.
[2023-03-18 22:42:04] [INFO ] Deduced a trap composed of 9 places in 280 ms of which 0 ms to minimize.
[2023-03-18 22:42:04] [INFO ] Deduced a trap composed of 9 places in 193 ms of which 17 ms to minimize.
[2023-03-18 22:42:04] [INFO ] Deduced a trap composed of 11 places in 276 ms of which 0 ms to minimize.
[2023-03-18 22:42:05] [INFO ] Deduced a trap composed of 5 places in 242 ms of which 0 ms to minimize.
[2023-03-18 22:42:05] [INFO ] Deduced a trap composed of 9 places in 454 ms of which 1 ms to minimize.
[2023-03-18 22:42:06] [INFO ] Deduced a trap composed of 9 places in 269 ms of which 0 ms to minimize.
[2023-03-18 22:42:06] [INFO ] Deduced a trap composed of 17 places in 223 ms of which 1 ms to minimize.
[2023-03-18 22:42:06] [INFO ] Deduced a trap composed of 7 places in 229 ms of which 14 ms to minimize.
[2023-03-18 22:42:06] [INFO ] Deduced a trap composed of 9 places in 194 ms of which 1 ms to minimize.
[2023-03-18 22:42:07] [INFO ] Deduced a trap composed of 9 places in 198 ms of which 0 ms to minimize.
[2023-03-18 22:42:07] [INFO ] Trap strengthening (SAT) tested/added 32/31 trap constraints in 11006 ms
[2023-03-18 22:42:07] [INFO ] Deduced a trap composed of 6 places in 282 ms of which 0 ms to minimize.
[2023-03-18 22:42:08] [INFO ] Deduced a trap composed of 6 places in 229 ms of which 1 ms to minimize.
[2023-03-18 22:42:08] [INFO ] Deduced a trap composed of 5 places in 255 ms of which 0 ms to minimize.
[2023-03-18 22:42:08] [INFO ] Deduced a trap composed of 4 places in 248 ms of which 1 ms to minimize.
[2023-03-18 22:42:09] [INFO ] Deduced a trap composed of 5 places in 208 ms of which 0 ms to minimize.
[2023-03-18 22:42:09] [INFO ] Deduced a trap composed of 6 places in 227 ms of which 1 ms to minimize.
[2023-03-18 22:42:09] [INFO ] Deduced a trap composed of 10 places in 201 ms of which 1 ms to minimize.
[2023-03-18 22:42:09] [INFO ] Deduced a trap composed of 9 places in 282 ms of which 1 ms to minimize.
[2023-03-18 22:42:10] [INFO ] Deduced a trap composed of 18 places in 248 ms of which 1 ms to minimize.
[2023-03-18 22:42:10] [INFO ] Deduced a trap composed of 15 places in 176 ms of which 0 ms to minimize.
[2023-03-18 22:42:10] [INFO ] Deduced a trap composed of 22 places in 273 ms of which 1 ms to minimize.
[2023-03-18 22:42:11] [INFO ] Deduced a trap composed of 21 places in 220 ms of which 1 ms to minimize.
[2023-03-18 22:42:11] [INFO ] Deduced a trap composed of 11 places in 181 ms of which 0 ms to minimize.
[2023-03-18 22:42:11] [INFO ] Deduced a trap composed of 5 places in 157 ms of which 2 ms to minimize.
[2023-03-18 22:42:11] [INFO ] Deduced a trap composed of 11 places in 191 ms of which 1 ms to minimize.
[2023-03-18 22:42:12] [INFO ] Deduced a trap composed of 16 places in 157 ms of which 0 ms to minimize.
[2023-03-18 22:42:12] [INFO ] Deduced a trap composed of 11 places in 164 ms of which 1 ms to minimize.
[2023-03-18 22:42:12] [INFO ] Deduced a trap composed of 14 places in 183 ms of which 0 ms to minimize.
[2023-03-18 22:42:12] [INFO ] Deduced a trap composed of 5 places in 152 ms of which 0 ms to minimize.
[2023-03-18 22:42:13] [INFO ] Deduced a trap composed of 3 places in 165 ms of which 1 ms to minimize.
[2023-03-18 22:42:13] [INFO ] Deduced a trap composed of 16 places in 166 ms of which 1 ms to minimize.
[2023-03-18 22:42:13] [INFO ] Deduced a trap composed of 15 places in 190 ms of which 15 ms to minimize.
[2023-03-18 22:42:13] [INFO ] Deduced a trap composed of 12 places in 153 ms of which 0 ms to minimize.
[2023-03-18 22:42:14] [INFO ] Deduced a trap composed of 19 places in 215 ms of which 0 ms to minimize.
[2023-03-18 22:42:14] [INFO ] Deduced a trap composed of 9 places in 136 ms of which 2 ms to minimize.
[2023-03-18 22:42:14] [INFO ] Deduced a trap composed of 7 places in 147 ms of which 25 ms to minimize.
[2023-03-18 22:42:14] [INFO ] Trap strengthening (SAT) tested/added 27/26 trap constraints in 7337 ms
[2023-03-18 22:42:14] [INFO ] After 19958ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :2
Attempting to minimize the solution found.
Minimization took 379 ms.
[2023-03-18 22:42:15] [INFO ] After 20839ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :2
Parikh walk visited 0 properties in 87 ms.
Support contains 43 out of 1354 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1354/1354 places, 1305/1305 transitions.
Drop transitions removed 4 transitions
Trivial Post-agglo rules discarded 4 transitions
Performed 4 trivial Post agglomeration. Transition count delta: 4
Iterating post reduction 0 with 4 rules applied. Total rules applied 4 place count 1354 transition count 1301
Reduce places removed 4 places and 0 transitions.
Iterating post reduction 1 with 4 rules applied. Total rules applied 8 place count 1350 transition count 1301
Performed 12 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 12 Pre rules applied. Total rules applied 8 place count 1350 transition count 1289
Deduced a syphon composed of 12 places in 4 ms
Reduce places removed 12 places and 0 transitions.
Iterating global reduction 2 with 24 rules applied. Total rules applied 32 place count 1338 transition count 1289
Performed 31 Post agglomeration using F-continuation condition.Transition count delta: 31
Deduced a syphon composed of 31 places in 28 ms
Reduce places removed 31 places and 0 transitions.
Iterating global reduction 2 with 62 rules applied. Total rules applied 94 place count 1307 transition count 1258
Partial Free-agglomeration rule applied 14 times.
Drop transitions removed 14 transitions
Iterating global reduction 2 with 14 rules applied. Total rules applied 108 place count 1307 transition count 1258
Reduce places removed 6 places and 6 transitions.
Iterating global reduction 2 with 6 rules applied. Total rules applied 114 place count 1301 transition count 1252
Applied a total of 114 rules in 302 ms. Remains 1301 /1354 variables (removed 53) and now considering 1252/1305 (removed 53) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 303 ms. Remains : 1301/1354 places, 1252/1305 transitions.
Incomplete random walk after 10000 steps, including 2 resets, run finished after 426 ms. (steps per millisecond=23 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 74 ms. (steps per millisecond=135 ) properties (out of 2) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 62 ms. (steps per millisecond=161 ) properties (out of 2) seen :0
Interrupted probabilistic random walk after 118101 steps, run timeout after 3001 ms. (steps per millisecond=39 ) properties seen :{}
Probabilistic random walk after 118101 steps, saw 67321 distinct states, run finished after 3002 ms. (steps per millisecond=39 ) properties seen :0
Running SMT prover for 2 properties.
// Phase 1: matrix 1252 rows 1301 cols
[2023-03-18 22:42:19] [INFO ] Computed 450 place invariants in 42 ms
[2023-03-18 22:42:19] [INFO ] After 170ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:2
[2023-03-18 22:42:19] [INFO ] [Nat]Absence check using 446 positive place invariants in 126 ms returned sat
[2023-03-18 22:42:19] [INFO ] [Nat]Absence check using 446 positive and 4 generalized place invariants in 1 ms returned sat
[2023-03-18 22:42:22] [INFO ] After 3124ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :2
[2023-03-18 22:42:23] [INFO ] Deduced a trap composed of 4 places in 269 ms of which 1 ms to minimize.
[2023-03-18 22:42:23] [INFO ] Deduced a trap composed of 6 places in 258 ms of which 0 ms to minimize.
[2023-03-18 22:42:23] [INFO ] Deduced a trap composed of 4 places in 237 ms of which 0 ms to minimize.
[2023-03-18 22:42:24] [INFO ] Deduced a trap composed of 8 places in 278 ms of which 0 ms to minimize.
[2023-03-18 22:42:24] [INFO ] Deduced a trap composed of 4 places in 331 ms of which 0 ms to minimize.
[2023-03-18 22:42:25] [INFO ] Deduced a trap composed of 4 places in 323 ms of which 1 ms to minimize.
[2023-03-18 22:42:25] [INFO ] Deduced a trap composed of 4 places in 274 ms of which 0 ms to minimize.
[2023-03-18 22:42:25] [INFO ] Deduced a trap composed of 4 places in 407 ms of which 1 ms to minimize.
[2023-03-18 22:42:27] [INFO ] Deduced a trap composed of 8 places in 1089 ms of which 1 ms to minimize.
[2023-03-18 22:42:27] [INFO ] Deduced a trap composed of 5 places in 278 ms of which 1 ms to minimize.
[2023-03-18 22:42:27] [INFO ] Deduced a trap composed of 3 places in 282 ms of which 1 ms to minimize.
[2023-03-18 22:42:28] [INFO ] Deduced a trap composed of 5 places in 249 ms of which 1 ms to minimize.
[2023-03-18 22:42:28] [INFO ] Deduced a trap composed of 4 places in 265 ms of which 0 ms to minimize.
[2023-03-18 22:42:28] [INFO ] Deduced a trap composed of 7 places in 250 ms of which 1 ms to minimize.
[2023-03-18 22:42:28] [INFO ] Deduced a trap composed of 5 places in 275 ms of which 0 ms to minimize.
[2023-03-18 22:42:29] [INFO ] Deduced a trap composed of 10 places in 163 ms of which 0 ms to minimize.
[2023-03-18 22:42:29] [INFO ] Deduced a trap composed of 7 places in 243 ms of which 0 ms to minimize.
[2023-03-18 22:42:29] [INFO ] Deduced a trap composed of 10 places in 223 ms of which 0 ms to minimize.
[2023-03-18 22:42:30] [INFO ] Deduced a trap composed of 8 places in 265 ms of which 1 ms to minimize.
[2023-03-18 22:42:30] [INFO ] Deduced a trap composed of 8 places in 224 ms of which 0 ms to minimize.
[2023-03-18 22:42:30] [INFO ] Deduced a trap composed of 4 places in 225 ms of which 1 ms to minimize.
[2023-03-18 22:42:30] [INFO ] Deduced a trap composed of 17 places in 199 ms of which 0 ms to minimize.
[2023-03-18 22:42:31] [INFO ] Deduced a trap composed of 12 places in 185 ms of which 0 ms to minimize.
[2023-03-18 22:42:31] [INFO ] Deduced a trap composed of 4 places in 218 ms of which 1 ms to minimize.
[2023-03-18 22:42:31] [INFO ] Deduced a trap composed of 6 places in 288 ms of which 1 ms to minimize.
[2023-03-18 22:42:32] [INFO ] Deduced a trap composed of 5 places in 189 ms of which 1 ms to minimize.
[2023-03-18 22:42:32] [INFO ] Deduced a trap composed of 7 places in 201 ms of which 0 ms to minimize.
[2023-03-18 22:42:32] [INFO ] Deduced a trap composed of 15 places in 213 ms of which 0 ms to minimize.
[2023-03-18 22:42:32] [INFO ] Deduced a trap composed of 9 places in 191 ms of which 1 ms to minimize.
[2023-03-18 22:42:32] [INFO ] Trap strengthening (SAT) tested/added 30/29 trap constraints in 10010 ms
[2023-03-18 22:42:33] [INFO ] Deduced a trap composed of 7 places in 439 ms of which 0 ms to minimize.
[2023-03-18 22:42:33] [INFO ] Deduced a trap composed of 5 places in 224 ms of which 1 ms to minimize.
[2023-03-18 22:42:34] [INFO ] Deduced a trap composed of 8 places in 236 ms of which 1 ms to minimize.
[2023-03-18 22:42:34] [INFO ] Deduced a trap composed of 9 places in 339 ms of which 1 ms to minimize.
[2023-03-18 22:42:34] [INFO ] Deduced a trap composed of 4 places in 225 ms of which 0 ms to minimize.
[2023-03-18 22:42:35] [INFO ] Deduced a trap composed of 4 places in 233 ms of which 1 ms to minimize.
[2023-03-18 22:42:35] [INFO ] Deduced a trap composed of 4 places in 207 ms of which 0 ms to minimize.
[2023-03-18 22:42:35] [INFO ] Deduced a trap composed of 4 places in 191 ms of which 0 ms to minimize.
[2023-03-18 22:42:35] [INFO ] Deduced a trap composed of 14 places in 250 ms of which 0 ms to minimize.
[2023-03-18 22:42:36] [INFO ] Deduced a trap composed of 6 places in 239 ms of which 1 ms to minimize.
[2023-03-18 22:42:36] [INFO ] Deduced a trap composed of 6 places in 184 ms of which 1 ms to minimize.
[2023-03-18 22:42:36] [INFO ] Deduced a trap composed of 3 places in 175 ms of which 0 ms to minimize.
[2023-03-18 22:42:36] [INFO ] Deduced a trap composed of 19 places in 185 ms of which 0 ms to minimize.
[2023-03-18 22:42:37] [INFO ] Deduced a trap composed of 8 places in 172 ms of which 1 ms to minimize.
[2023-03-18 22:42:37] [INFO ] Deduced a trap composed of 22 places in 221 ms of which 1 ms to minimize.
[2023-03-18 22:42:37] [INFO ] Deduced a trap composed of 15 places in 157 ms of which 1 ms to minimize.
[2023-03-18 22:42:37] [INFO ] Deduced a trap composed of 5 places in 203 ms of which 0 ms to minimize.
[2023-03-18 22:42:38] [INFO ] Deduced a trap composed of 11 places in 199 ms of which 0 ms to minimize.
[2023-03-18 22:42:38] [INFO ] Deduced a trap composed of 7 places in 157 ms of which 0 ms to minimize.
[2023-03-18 22:42:38] [INFO ] Deduced a trap composed of 5 places in 214 ms of which 1 ms to minimize.
[2023-03-18 22:42:38] [INFO ] Deduced a trap composed of 9 places in 183 ms of which 1 ms to minimize.
[2023-03-18 22:42:39] [INFO ] Deduced a trap composed of 11 places in 165 ms of which 0 ms to minimize.
[2023-03-18 22:42:39] [INFO ] Deduced a trap composed of 7 places in 135 ms of which 0 ms to minimize.
[2023-03-18 22:42:39] [INFO ] Deduced a trap composed of 8 places in 237 ms of which 0 ms to minimize.
[2023-03-18 22:42:39] [INFO ] Deduced a trap composed of 6 places in 223 ms of which 14 ms to minimize.
[2023-03-18 22:42:40] [INFO ] Deduced a trap composed of 5 places in 157 ms of which 0 ms to minimize.
[2023-03-18 22:42:40] [INFO ] Deduced a trap composed of 14 places in 235 ms of which 2 ms to minimize.
[2023-03-18 22:42:40] [INFO ] Deduced a trap composed of 4 places in 186 ms of which 0 ms to minimize.
[2023-03-18 22:42:41] [INFO ] Deduced a trap composed of 6 places in 228 ms of which 0 ms to minimize.
[2023-03-18 22:42:41] [INFO ] Deduced a trap composed of 5 places in 119 ms of which 0 ms to minimize.
[2023-03-18 22:42:41] [INFO ] Deduced a trap composed of 6 places in 152 ms of which 0 ms to minimize.
[2023-03-18 22:42:41] [INFO ] Deduced a trap composed of 9 places in 200 ms of which 1 ms to minimize.
[2023-03-18 22:42:41] [INFO ] Trap strengthening (SAT) tested/added 33/32 trap constraints in 8819 ms
[2023-03-18 22:42:42] [INFO ] After 22313ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :2
Attempting to minimize the solution found.
Minimization took 376 ms.
[2023-03-18 22:42:42] [INFO ] After 23080ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :2
Parikh walk visited 0 properties in 97 ms.
Support contains 43 out of 1301 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1301/1301 places, 1252/1252 transitions.
Applied a total of 0 rules in 37 ms. Remains 1301 /1301 variables (removed 0) and now considering 1252/1252 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 37 ms. Remains : 1301/1301 places, 1252/1252 transitions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1301/1301 places, 1252/1252 transitions.
Applied a total of 0 rules in 36 ms. Remains 1301 /1301 variables (removed 0) and now considering 1252/1252 (removed 0) transitions.
[2023-03-18 22:42:42] [INFO ] Invariant cache hit.
[2023-03-18 22:42:43] [INFO ] Implicit Places using invariants in 849 ms returned []
[2023-03-18 22:42:43] [INFO ] Invariant cache hit.
[2023-03-18 22:42:45] [INFO ] Implicit Places using invariants and state equation in 2171 ms returned []
Implicit Place search using SMT with State Equation took 3025 ms to find 0 implicit places.
[2023-03-18 22:42:45] [INFO ] Redundant transitions in 80 ms returned []
[2023-03-18 22:42:45] [INFO ] Invariant cache hit.
[2023-03-18 22:42:46] [INFO ] Dead Transitions using invariants and state equation in 679 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 3831 ms. Remains : 1301/1301 places, 1252/1252 transitions.
Applied a total of 0 rules in 33 ms. Remains 1301 /1301 variables (removed 0) and now considering 1252/1252 (removed 0) transitions.
Running SMT prover for 2 properties.
[2023-03-18 22:42:46] [INFO ] Invariant cache hit.
[2023-03-18 22:42:46] [INFO ] After 132ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:2
[2023-03-18 22:42:46] [INFO ] [Nat]Absence check using 446 positive place invariants in 69 ms returned sat
[2023-03-18 22:42:46] [INFO ] [Nat]Absence check using 446 positive and 4 generalized place invariants in 2 ms returned sat
[2023-03-18 22:42:47] [INFO ] After 780ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :2
[2023-03-18 22:42:47] [INFO ] Deduced a trap composed of 6 places in 240 ms of which 1 ms to minimize.
[2023-03-18 22:42:48] [INFO ] Deduced a trap composed of 17 places in 253 ms of which 0 ms to minimize.
[2023-03-18 22:42:48] [INFO ] Deduced a trap composed of 5 places in 218 ms of which 1 ms to minimize.
[2023-03-18 22:42:48] [INFO ] Deduced a trap composed of 4 places in 295 ms of which 1 ms to minimize.
[2023-03-18 22:42:49] [INFO ] Deduced a trap composed of 4 places in 238 ms of which 1 ms to minimize.
[2023-03-18 22:42:49] [INFO ] Deduced a trap composed of 4 places in 198 ms of which 0 ms to minimize.
[2023-03-18 22:42:49] [INFO ] Deduced a trap composed of 5 places in 170 ms of which 1 ms to minimize.
[2023-03-18 22:42:50] [INFO ] Deduced a trap composed of 5 places in 349 ms of which 0 ms to minimize.
[2023-03-18 22:42:50] [INFO ] Deduced a trap composed of 6 places in 166 ms of which 1 ms to minimize.
[2023-03-18 22:42:50] [INFO ] Deduced a trap composed of 4 places in 362 ms of which 0 ms to minimize.
[2023-03-18 22:42:50] [INFO ] Deduced a trap composed of 9 places in 188 ms of which 1 ms to minimize.
[2023-03-18 22:42:51] [INFO ] Deduced a trap composed of 13 places in 174 ms of which 1 ms to minimize.
[2023-03-18 22:42:51] [INFO ] Deduced a trap composed of 14 places in 216 ms of which 0 ms to minimize.
[2023-03-18 22:42:51] [INFO ] Deduced a trap composed of 17 places in 144 ms of which 0 ms to minimize.
[2023-03-18 22:42:51] [INFO ] Deduced a trap composed of 11 places in 121 ms of which 1 ms to minimize.
[2023-03-18 22:42:52] [INFO ] Deduced a trap composed of 5 places in 166 ms of which 0 ms to minimize.
[2023-03-18 22:42:52] [INFO ] Deduced a trap composed of 16 places in 144 ms of which 1 ms to minimize.
[2023-03-18 22:42:52] [INFO ] Deduced a trap composed of 16 places in 176 ms of which 1 ms to minimize.
[2023-03-18 22:42:52] [INFO ] Deduced a trap composed of 7 places in 157 ms of which 1 ms to minimize.
[2023-03-18 22:42:52] [INFO ] Deduced a trap composed of 6 places in 110 ms of which 0 ms to minimize.
[2023-03-18 22:42:53] [INFO ] Deduced a trap composed of 6 places in 196 ms of which 0 ms to minimize.
[2023-03-18 22:42:53] [INFO ] Deduced a trap composed of 7 places in 153 ms of which 0 ms to minimize.
[2023-03-18 22:42:53] [INFO ] Deduced a trap composed of 4 places in 132 ms of which 1 ms to minimize.
[2023-03-18 22:42:53] [INFO ] Deduced a trap composed of 4 places in 131 ms of which 0 ms to minimize.
[2023-03-18 22:42:53] [INFO ] Deduced a trap composed of 7 places in 173 ms of which 0 ms to minimize.
[2023-03-18 22:42:54] [INFO ] Deduced a trap composed of 9 places in 127 ms of which 0 ms to minimize.
[2023-03-18 22:42:54] [INFO ] Deduced a trap composed of 18 places in 161 ms of which 0 ms to minimize.
[2023-03-18 22:42:54] [INFO ] Deduced a trap composed of 19 places in 134 ms of which 0 ms to minimize.
[2023-03-18 22:42:54] [INFO ] Deduced a trap composed of 5 places in 150 ms of which 0 ms to minimize.
[2023-03-18 22:42:54] [INFO ] Deduced a trap composed of 12 places in 194 ms of which 0 ms to minimize.
[2023-03-18 22:42:54] [INFO ] Trap strengthening (SAT) tested/added 31/30 trap constraints in 7203 ms
[2023-03-18 22:42:55] [INFO ] Deduced a trap composed of 4 places in 289 ms of which 0 ms to minimize.
[2023-03-18 22:42:55] [INFO ] Deduced a trap composed of 3 places in 204 ms of which 1 ms to minimize.
[2023-03-18 22:42:56] [INFO ] Deduced a trap composed of 3 places in 215 ms of which 1 ms to minimize.
[2023-03-18 22:42:56] [INFO ] Deduced a trap composed of 5 places in 236 ms of which 1 ms to minimize.
[2023-03-18 22:42:56] [INFO ] Deduced a trap composed of 5 places in 230 ms of which 1 ms to minimize.
[2023-03-18 22:42:56] [INFO ] Deduced a trap composed of 5 places in 199 ms of which 0 ms to minimize.
[2023-03-18 22:42:57] [INFO ] Deduced a trap composed of 6 places in 204 ms of which 1 ms to minimize.
[2023-03-18 22:42:57] [INFO ] Deduced a trap composed of 5 places in 206 ms of which 1 ms to minimize.
[2023-03-18 22:42:57] [INFO ] Deduced a trap composed of 7 places in 233 ms of which 0 ms to minimize.
[2023-03-18 22:42:58] [INFO ] Deduced a trap composed of 5 places in 233 ms of which 1 ms to minimize.
[2023-03-18 22:42:58] [INFO ] Deduced a trap composed of 4 places in 200 ms of which 0 ms to minimize.
[2023-03-18 22:42:58] [INFO ] Deduced a trap composed of 14 places in 195 ms of which 0 ms to minimize.
[2023-03-18 22:42:58] [INFO ] Deduced a trap composed of 4 places in 234 ms of which 1 ms to minimize.
[2023-03-18 22:42:59] [INFO ] Deduced a trap composed of 19 places in 195 ms of which 1 ms to minimize.
[2023-03-18 22:42:59] [INFO ] Deduced a trap composed of 17 places in 198 ms of which 1 ms to minimize.
[2023-03-18 22:42:59] [INFO ] Deduced a trap composed of 6 places in 201 ms of which 0 ms to minimize.
[2023-03-18 22:43:00] [INFO ] Deduced a trap composed of 16 places in 221 ms of which 1 ms to minimize.
[2023-03-18 22:43:00] [INFO ] Deduced a trap composed of 6 places in 227 ms of which 1 ms to minimize.
[2023-03-18 22:43:00] [INFO ] Deduced a trap composed of 16 places in 204 ms of which 1 ms to minimize.
[2023-03-18 22:43:00] [INFO ] Deduced a trap composed of 4 places in 203 ms of which 1 ms to minimize.
[2023-03-18 22:43:01] [INFO ] Deduced a trap composed of 5 places in 197 ms of which 0 ms to minimize.
[2023-03-18 22:43:01] [INFO ] Deduced a trap composed of 6 places in 194 ms of which 1 ms to minimize.
[2023-03-18 22:43:01] [INFO ] Deduced a trap composed of 5 places in 188 ms of which 0 ms to minimize.
[2023-03-18 22:43:02] [INFO ] Deduced a trap composed of 5 places in 191 ms of which 0 ms to minimize.
[2023-03-18 22:43:02] [INFO ] Deduced a trap composed of 15 places in 196 ms of which 1 ms to minimize.
[2023-03-18 22:43:02] [INFO ] Deduced a trap composed of 13 places in 172 ms of which 0 ms to minimize.
[2023-03-18 22:43:02] [INFO ] Deduced a trap composed of 15 places in 187 ms of which 1 ms to minimize.
[2023-03-18 22:43:03] [INFO ] Deduced a trap composed of 13 places in 183 ms of which 0 ms to minimize.
[2023-03-18 22:43:03] [INFO ] Trap strengthening (SAT) tested/added 29/28 trap constraints in 7988 ms
[2023-03-18 22:43:03] [INFO ] After 16299ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :2
Attempting to minimize the solution found.
Minimization took 375 ms.
[2023-03-18 22:43:03] [INFO ] After 16916ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :2
[2023-03-18 22:43:03] [INFO ] Flatten gal took : 91 ms
[2023-03-18 22:43:03] [INFO ] Flatten gal took : 77 ms
[2023-03-18 22:43:03] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality4955295036306188036.gal : 11 ms
[2023-03-18 22:43:03] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality10540258536967296224.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality4955295036306188036.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality10540258536967296224.prop' '--nowitness' '--gen-order' 'FOLLOW'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...329
Loading property file /tmp/ReachabilityCardinality10540258536967296224.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 3
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :3 after 5
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :5 after 9
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :9 after 25
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :25 after 49
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :49 after 588
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :588 after 10584
SDD proceeding with computation,2 properties remain. new max is 512
SDD size :5.71536e+06 after 2.57191e+07
SDD proceeding with computation,2 properties remain. new max is 1024
SDD size :2.57191e+07 after 3.34673e+07
Detected timeout of ITS tools.
[2023-03-18 22:43:18] [INFO ] Flatten gal took : 60 ms
[2023-03-18 22:43:18] [INFO ] Applying decomposition
[2023-03-18 22:43:18] [INFO ] Flatten gal took : 61 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph10024811394279928462.txt' '-o' '/tmp/graph10024811394279928462.bin' '-w' '/tmp/graph10024811394279928462.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph10024811394279928462.bin' '-l' '-1' '-v' '-w' '/tmp/graph10024811394279928462.weights' '-q' '0' '-e' '0.001'
[2023-03-18 22:43:19] [INFO ] Decomposing Gal with order
[2023-03-18 22:43:19] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-18 22:43:19] [INFO ] Removed a total of 978 redundant transitions.
[2023-03-18 22:43:19] [INFO ] Flatten gal took : 162 ms
[2023-03-18 22:43:19] [INFO ] Fuse similar labels procedure discarded/fused a total of 1122 labels/synchronizations in 76 ms.
[2023-03-18 22:43:19] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality2530748077611010465.gal : 19 ms
[2023-03-18 22:43:19] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality11608478570049028716.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality2530748077611010465.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality11608478570049028716.prop' '--nowitness'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...308
Loading property file /tmp/ReachabilityCardinality11608478570049028716.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 3
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :3 after 4
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :4 after 4
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :4 after 4
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :4 after 4
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :4 after 4
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin16171566563099988181
[2023-03-18 22:43:34] [INFO ] Built C files in 56ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin16171566563099988181
Running compilation step : cd /tmp/ltsmin16171566563099988181;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '3' 'gcc' '-c' '-I/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/include/' '-I.' '-std=c99' '-fPIC' '-O0' 'model.c'
Compilation finished in 2652 ms.
Running link step : cd /tmp/ltsmin16171566563099988181;'gcc' '-shared' '-o' 'gal.so' 'model.o'
Link finished in 47 ms.
Running LTSmin : cd /tmp/ltsmin16171566563099988181;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/pins2lts-mc-linux64' './gal.so' '--threads=8' '--when' '-i' 'ShieldIIPsPT050BReachabilityCardinality04==true'
WARNING : LTS min runner thread was asked to interrupt. Dying gracefully.
ITS runner failed with exception null
java.lang.InterruptedException
at java.base/java.lang.Object.wait(Native Method)
at java.base/java.lang.Thread.join(Thread.java:1304)
at java.base/java.lang.Thread.join(Thread.java:1372)
at fr.lip6.move.gal.application.runner.AbstractRunner.join(AbstractRunner.java:27)
at fr.lip6.move.gal.application.runner.its.ITSRunner.join(ITSRunner.java:177)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.verifyWithSDD(GlobalPropertySolver.java:675)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.lambda$2(ReachabilitySolver.java:63)
at java.base/java.lang.Thread.run(Thread.java:833)
[2023-03-18 22:43:50] [INFO ] Flatten gal took : 124 ms
[2023-03-18 22:43:50] [INFO ] Applying decomposition
[2023-03-18 22:43:50] [INFO ] Flatten gal took : 89 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph16850223699663064029.txt' '-o' '/tmp/graph16850223699663064029.bin' '-w' '/tmp/graph16850223699663064029.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph16850223699663064029.bin' '-l' '-1' '-v' '-w' '/tmp/graph16850223699663064029.weights' '-q' '0' '-e' '0.001'
[2023-03-18 22:43:50] [INFO ] Decomposing Gal with order
[2023-03-18 22:43:50] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-18 22:43:50] [INFO ] Removed a total of 1150 redundant transitions.
[2023-03-18 22:43:50] [INFO ] Flatten gal took : 218 ms
[2023-03-18 22:43:50] [INFO ] Fuse similar labels procedure discarded/fused a total of 0 labels/synchronizations in 7 ms.
[2023-03-18 22:43:51] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality8013308206572721060.gal : 32 ms
[2023-03-18 22:43:51] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality4360594064003510801.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality8013308206572721060.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality4360594064003510801.prop' '--nowitness'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...307
Loading property file /tmp/ReachabilityCardinality4360594064003510801.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 1
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :1 after 1
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :1 after 1
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :1 after 1227
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :1227 after 2.31208e+50
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :2.31208e+50 after 1.5919e+113
SDD proceeding with computation,2 properties remain. new max is 256
SDD size :1.17916e+139 after 4.33761e+139
Detected timeout of ITS tools.
Detected timeout of ITS tools.
[2023-03-18 23:13:55] [INFO ] Flatten gal took : 1038 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin417632618564296278
[2023-03-18 23:13:55] [INFO ] Computing symmetric may disable matrix : 1252 transitions.
[2023-03-18 23:13:55] [INFO ] Computation of Complete disable matrix. took 21 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2023-03-18 23:13:55] [INFO ] Computing symmetric may enable matrix : 1252 transitions.
[2023-03-18 23:13:55] [INFO ] Computation of Complete enable matrix. took 20 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2023-03-18 23:13:56] [INFO ] Applying decomposition
[2023-03-18 23:13:56] [INFO ] Flatten gal took : 661 ms
[2023-03-18 23:14:01] [INFO ] Computing Do-Not-Accords matrix : 1252 transitions.
[2023-03-18 23:14:01] [INFO ] Computation of Completed DNA matrix. took 77 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2023-03-18 23:14:02] [INFO ] Built C files in 6673ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin417632618564296278
Running compilation step : cd /tmp/ltsmin417632618564296278;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '360' 'gcc' '-c' '-I/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/include/' '-I.' '-std=c99' '-fPIC' '-O0' 'model.c'
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph920921605373372217.txt' '-o' '/tmp/graph920921605373372217.bin' '-w' '/tmp/graph920921605373372217.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph920921605373372217.bin' '-l' '-1' '-v' '-w' '/tmp/graph920921605373372217.weights' '-q' '0' '-e' '0.001'
[2023-03-18 23:14:02] [INFO ] Decomposing Gal with order
[2023-03-18 23:14:02] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-18 23:14:02] [INFO ] Removed a total of 984 redundant transitions.
[2023-03-18 23:14:02] [INFO ] Flatten gal took : 268 ms
[2023-03-18 23:14:02] [INFO ] Fuse similar labels procedure discarded/fused a total of 1027 labels/synchronizations in 31 ms.
[2023-03-18 23:14:03] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality10350425334883891124.gal : 16 ms
[2023-03-18 23:14:03] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality12211443405808912289.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality10350425334883891124.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality12211443405808912289.prop' '--nowitness'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...309
Loading property file /tmp/ReachabilityCardinality12211443405808912289.prop.
SDD proceeding with computation,2 properties remain. new max is 4
SDD size :1 after 3
SDD proceeding with computation,2 properties remain. new max is 8
SDD size :3 after 5
SDD proceeding with computation,2 properties remain. new max is 16
SDD size :5 after 5
SDD proceeding with computation,2 properties remain. new max is 32
SDD size :5 after 5
SDD proceeding with computation,2 properties remain. new max is 64
SDD size :5 after 5
Compilation finished in 4818 ms.
Running link step : cd /tmp/ltsmin417632618564296278;'gcc' '-shared' '-o' 'gal.so' 'model.o'
Link finished in 156 ms.
Running LTSmin : cd /tmp/ltsmin417632618564296278;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/pins2lts-mc-linux64' './gal.so' '--threads=8' '-p' '--pins-guards' '--when' '-i' 'ShieldIIPsPT050BReachabilityCardinality04==true'
SDD proceeding with computation,2 properties remain. new max is 128
SDD size :5 after 29
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393220 kB
MemFree: 6453012 kB
After kill :
MemTotal: 16393220 kB
MemFree: 16102184 kB

BK_TIME_CONFINEMENT_REACHED

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

+ export BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ ReachabilityCardinality = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution ReachabilityCardinality -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
++ perl -pe 's/.*\.//g'
+ VERSION=202303021504
+ echo 'Running Version 202303021504'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination ReachabilityCardinality -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600

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="ShieldIIPs-PT-050B"
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-5348"
echo " Executing tool itstools"
echo " Input is ShieldIIPs-PT-050B, 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 r389-oct2-167903713200158"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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