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.r485-tall-167912699700694.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 cluster_size=65536 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 TokenRing-PT-040, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r485-tall-167912699700694
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 442M
-rw-r--r-- 1 mcc users 1.2M Feb 25 21:42 CTLCardinality.txt
-rw-r--r-- 1 mcc users 5.3M Feb 25 21:42 CTLCardinality.xml
-rw-r--r-- 1 mcc users 31M Feb 25 19:50 CTLFireability.txt
-rw-r--r-- 1 mcc users 105M Feb 25 19:40 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:41 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.6K Jan 29 11:41 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 838K Feb 25 17:21 LTLCardinality.txt
-rw-r--r-- 1 mcc users 2.7M Feb 25 17:21 LTLCardinality.xml
-rw-r--r-- 1 mcc users 16M Feb 25 17:21 LTLFireability.txt
-rw-r--r-- 1 mcc users 41M Feb 25 17:21 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.4M Feb 26 16:32 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 16M Feb 26 16:32 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 43M Feb 26 15:04 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 147M Feb 26 14:48 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 180K Feb 25 17:21 UpperBounds.txt
-rw-r--r-- 1 mcc users 457K Feb 25 17:21 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 equiv_col
-rw-r--r-- 1 mcc users 4 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 32M 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 TokenRing-PT-040-ReachabilityCardinality-00
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-01
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-02
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-03
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-04
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-05
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-06
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-07
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-08
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-09
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-10
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-11
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-12
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-13
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-14
FORMULA_NAME TokenRing-PT-040-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1679275192076

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=TokenRing-PT-040
Not applying reductions.
Model is PT
ReachabilityCardinality PT
Running Version 202303021504
[2023-03-20 01:19:54] [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-20 01:19:54] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-20 01:19:55] [INFO ] Load time of PNML (sax parser for PT used): 1166 ms
[2023-03-20 01:19:55] [INFO ] Transformed 1681 places.
[2023-03-20 01:19:55] [INFO ] Transformed 65641 transitions.
[2023-03-20 01:19:56] [INFO ] Parsed PT model containing 1681 places and 65641 transitions and 262564 arcs in 1472 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 2197 ms.
Working with output stream class java.io.PrintStream
FORMULA TokenRing-PT-040-ReachabilityCardinality-00 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-02 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-03 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-04 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-05 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-06 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA TokenRing-PT-040-ReachabilityCardinality-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Incomplete random walk after 10000 steps, including 2 resets, run finished after 840 ms. (steps per millisecond=11 ) properties (out of 8) seen :4
FORMULA TokenRing-PT-040-ReachabilityCardinality-13 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-040-ReachabilityCardinality-12 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-040-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA TokenRing-PT-040-ReachabilityCardinality-09 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 234 ms. (steps per millisecond=42 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 263 ms. (steps per millisecond=38 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 376 ms. (steps per millisecond=26 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 260 ms. (steps per millisecond=38 ) properties (out of 4) seen :0
Running SMT prover for 4 properties.
// Phase 1: matrix 65641 rows 1681 cols
[2023-03-20 01:20:01] [INFO ] Computed 41 place invariants in 272 ms
[2023-03-20 01:20:01] [INFO ] Flatten gal took : 2140 ms
[2023-03-20 01:20:01] [INFO ] After 773ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:4
[2023-03-20 01:20:02] [INFO ] [Nat]Absence check using 41 positive place invariants in 19 ms returned sat
[2023-03-20 01:20:03] [INFO ] Flatten gal took : 1780 ms
[2023-03-20 01:20:06] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality7121339031284485111.gal : 2495 ms
[2023-03-20 01:20:06] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality2675542056323981047.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/ReachabilityCardinality7121339031284485111.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality2675542056323981047.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
Loading property file /tmp/ReachabilityCardinality2675542056323981047.prop.
[2023-03-20 01:20:26] [INFO ] After 24535ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :4
[2023-03-20 01:20:27] [INFO ] State equation strengthened by 64040 read => feed constraints.
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.verifyPossible(DeadlockTester.java:642)
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-20 01:20:27] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-20 01:20:27] [INFO ] After 25984ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :0 real:4
Fused 4 Parikh solutions to 2 different solutions.
Parikh walk visited 0 properties in 47 ms.
Support contains 151 out of 1681 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1681/1681 places, 65641/65641 transitions.
Applied a total of 0 rules in 7103 ms. Remains 1681 /1681 variables (removed 0) and now considering 65641/65641 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 7111 ms. Remains : 1681/1681 places, 65641/65641 transitions.
Incomplete random walk after 10000 steps, including 2 resets, run finished after 472 ms. (steps per millisecond=21 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 177 ms. (steps per millisecond=56 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 322 ms. (steps per millisecond=31 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 226 ms. (steps per millisecond=44 ) properties (out of 4) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 199 ms. (steps per millisecond=50 ) properties (out of 4) seen :0
Interrupted probabilistic random walk after 3681 steps, run timeout after 3003 ms. (steps per millisecond=1 ) properties seen :{}
Probabilistic random walk after 3681 steps, saw 2545 distinct states, run finished after 3006 ms. (steps per millisecond=1 ) properties seen :0
Running SMT prover for 4 properties.
[2023-03-20 01:20:39] [INFO ] Invariant cache hit.
[2023-03-20 01:20:39] [INFO ] After 330ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:4
[2023-03-20 01:20:40] [INFO ] [Nat]Absence check using 41 positive place invariants in 19 ms returned sat
[2023-03-20 01:21:05] [INFO ] After 24806ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :4
[2023-03-20 01:21:06] [INFO ] State equation strengthened by 64040 read => feed constraints.
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.verifyPossible(DeadlockTester.java:642)
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-20 01:21:06] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-20 01:21:06] [INFO ] After 26013ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :0 real:4
Fused 4 Parikh solutions to 2 different solutions.
Parikh walk visited 0 properties in 33 ms.
Support contains 151 out of 1681 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1681/1681 places, 65641/65641 transitions.
Applied a total of 0 rules in 6610 ms. Remains 1681 /1681 variables (removed 0) and now considering 65641/65641 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 6611 ms. Remains : 1681/1681 places, 65641/65641 transitions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1681/1681 places, 65641/65641 transitions.
Applied a total of 0 rules in 4182 ms. Remains 1681 /1681 variables (removed 0) and now considering 65641/65641 (removed 0) transitions.
[2023-03-20 01:21:16] [INFO ] Invariant cache hit.
[2023-03-20 01:21:20] [INFO ] Implicit Places using invariants in 3840 ms returned []
Implicit Place search using SMT only with invariants took 3842 ms to find 0 implicit places.
[2023-03-20 01:21:20] [INFO ] Invariant cache hit.
[2023-03-20 01:21:42] [INFO ] Dead Transitions using invariants and state equation in 22089 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 30126 ms. Remains : 1681/1681 places, 65641/65641 transitions.
Graph (trivial) has 54245 edges and 1681 vertex of which 1491 / 1681 are part of one of the 40 SCC in 44 ms
Free SCC test removed 1451 places
Drop transitions removed 54208 transitions
Ensure Unique test removed 10566 transitions
Reduce isomorphic transitions removed 64774 transitions.
Graph (complete) has 867 edges and 230 vertex of which 229 are kept as prefixes of interest. Removing 1 places using SCC suffix rule.4 ms
Discarding 1 places :
Also discarding 0 output transitions
Drop transitions removed 34 transitions
Trivial Post-agglo rules discarded 34 transitions
Performed 34 trivial Post agglomeration. Transition count delta: 34
Iterating post reduction 0 with 34 rules applied. Total rules applied 36 place count 229 transition count 833
Reduce places removed 34 places and 0 transitions.
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Iterating post reduction 1 with 36 rules applied. Total rules applied 72 place count 195 transition count 831
Reduce places removed 2 places and 0 transitions.
Iterating post reduction 2 with 2 rules applied. Total rules applied 74 place count 193 transition count 831
Performed 1 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 1 Pre rules applied. Total rules applied 74 place count 193 transition count 830
Deduced a syphon composed of 1 places in 1 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 3 with 2 rules applied. Total rules applied 76 place count 192 transition count 830
Drop transitions removed 574 transitions
Redundant transition composition rules discarded 574 transitions
Iterating global reduction 3 with 574 rules applied. Total rules applied 650 place count 192 transition count 256
Applied a total of 650 rules in 395 ms. Remains 192 /1681 variables (removed 1489) and now considering 256/65641 (removed 65385) transitions.
Running SMT prover for 4 properties.
// Phase 1: matrix 256 rows 192 cols
[2023-03-20 01:21:43] [INFO ] Computed 40 place invariants in 2 ms
[2023-03-20 01:21:43] [INFO ] After 63ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:4
[2023-03-20 01:21:43] [INFO ] [Nat]Absence check using 40 positive place invariants in 4 ms returned sat
[2023-03-20 01:21:43] [INFO ] After 132ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :4
[2023-03-20 01:21:43] [INFO ] After 242ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :4
Attempting to minimize the solution found.
Minimization took 113 ms.
[2023-03-20 01:21:43] [INFO ] After 418ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :4
[2023-03-20 01:21:43] [INFO ] Flatten gal took : 6 ms
[2023-03-20 01:21:43] [INFO ] Flatten gal took : 5 ms
[2023-03-20 01:21:43] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality10150075949370444552.gal : 2 ms
[2023-03-20 01:21:43] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality7445015945750527524.prop : 0 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/ReachabilityCardinality10150075949370444552.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality7445015945750527524.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/ReachabilityCardinality7445015945750527524.prop.
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 5
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :5 after 20
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :20 after 200
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :200 after 30000
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :30000 after 1.62e+08
Detected timeout of ITS tools.
[2023-03-20 01:21:58] [INFO ] Flatten gal took : 5 ms
[2023-03-20 01:21:58] [INFO ] Applying decomposition
[2023-03-20 01:21:58] [INFO ] Flatten gal took : 5 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/graph2099648543755961001.txt' '-o' '/tmp/graph2099648543755961001.bin' '-w' '/tmp/graph2099648543755961001.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph2099648543755961001.bin' '-l' '-1' '-v' '-w' '/tmp/graph2099648543755961001.weights' '-q' '0' '-e' '0.001'
[2023-03-20 01:21:59] [INFO ] Decomposing Gal with order
[2023-03-20 01:21:59] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-20 01:21:59] [INFO ] Removed a total of 53 redundant transitions.
[2023-03-20 01:21:59] [INFO ] Flatten gal took : 42 ms
[2023-03-20 01:21:59] [INFO ] Fuse similar labels procedure discarded/fused a total of 18 labels/synchronizations in 7 ms.
[2023-03-20 01:21:59] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality13840534871745407612.gal : 3 ms
[2023-03-20 01:21:59] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality2682950925761621439.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/ReachabilityCardinality13840534871745407612.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality2682950925761621439.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/ReachabilityCardinality2682950925761621439.prop.
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 5
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :5 after 60
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :60 after 600
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :600 after 37500
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :37500 after 1.2e+07
Detected timeout of ITS tools.
Built C files in :
/tmp/ltsmin5934929369522335319
[2023-03-20 01:22:14] [INFO ] Built C files in 19ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin5934929369522335319
Running compilation step : cd /tmp/ltsmin5934929369522335319;'/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 458 ms.
Running link step : cd /tmp/ltsmin5934929369522335319;'gcc' '-shared' '-o' 'gal.so' 'model.o'
Link finished in 44 ms.
Running LTSmin : cd /tmp/ltsmin5934929369522335319;'/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' 'TokenRingPT040ReachabilityCardinality08==true'
LTSmin run took 5957 ms.
Found Violation
Running LTSmin : cd /tmp/ltsmin5934929369522335319;'/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' 'TokenRingPT040ReachabilityCardinality11==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-20 01:22:31] [INFO ] Flatten gal took : 1633 ms
[2023-03-20 01:22:31] [INFO ] Applying decomposition
[2023-03-20 01:22:32] [INFO ] Flatten gal took : 1626 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/graph17471920434001529719.txt' '-o' '/tmp/graph17471920434001529719.bin' '-w' '/tmp/graph17471920434001529719.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph17471920434001529719.bin' '-l' '-1' '-v' '-w' '/tmp/graph17471920434001529719.weights' '-q' '0' '-e' '0.001'
[2023-03-20 01:22:36] [INFO ] Decomposing Gal with order
[2023-03-20 01:22:36] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-20 01:22:41] [INFO ] Removed a total of 156466 redundant transitions.
[2023-03-20 01:22:42] [INFO ] Flatten gal took : 2477 ms
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 2
[2023-03-20 01:22:49] [INFO ] Fuse similar labels procedure discarded/fused a total of 3923 labels/synchronizations in 3562 ms.
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :2 after 5
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :5 after 11
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :11 after 14
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :14 after 29
SDD proceeding with computation,4 properties remain. new max is 128
SDD size :29 after 33
SDD proceeding with computation,4 properties remain. new max is 256
SDD size :33 after 42
SDD proceeding with computation,4 properties remain. new max is 512
SDD size :42 after 132
SDD proceeding with computation,4 properties remain. new max is 1024
SDD size :132 after 1430
SDD proceeding with computation,4 properties remain. new max is 2048
SDD size :1430 after 34502
[2023-03-20 01:22:51] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality9010483904778860587.gal : 175 ms
[2023-03-20 01:22:51] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality1007648847171206945.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/ReachabilityCardinality9010483904778860587.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality1007648847171206945.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
Loading property file /tmp/ReachabilityCardinality1007648847171206945.prop.
Invariant property TokenRing-PT-040-ReachabilityCardinality-14 does not hold.
FORMULA TokenRing-PT-040-ReachabilityCardinality-14 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING
SDD proceeding with computation,3 properties remain. new max is 2048
SDD size :34502 after 5.34888e+06
SDD proceeding with computation,3 properties remain. new max is 4096
SDD size :5.34888e+06 after 7.09268e+07
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 2
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :2 after 5
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :5 after 9
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :9 after 19
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :19 after 23
SDD proceeding with computation,4 properties remain. new max is 128
SDD size :23 after 33
SDD proceeding with computation,4 properties remain. new max is 256
SDD size :33 after 72
SDD proceeding with computation,4 properties remain. new max is 512
SDD size :72 after 183
SDD proceeding with computation,4 properties remain. new max is 1024
SDD size :183 after 805
SDD proceeding with computation,4 properties remain. new max is 2048
SDD size :805 after 22382
SDD proceeding with computation,4 properties remain. new max is 4096
SDD size :22382 after 2.1548e+06
SDD proceeding with computation,4 properties remain. new max is 8192
SDD size :2.1548e+06 after 3.66848e+06
Invariant property TokenRing-PT-040-ReachabilityCardinality-14 does not hold.
SDD proceeding with computation,3 properties remain. new max is 8192
SDD size :3.66848e+06 after 1.35823e+08
Detected timeout of ITS tools.
Detected timeout of ITS tools.
[2023-03-20 01:52:53] [INFO ] Flatten gal took : 1462 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin5253394942157629975
[2023-03-20 01:52:53] [INFO ] Too many transitions (65641) to apply POR reductions. Disabling POR matrices.
[2023-03-20 01:52:54] [INFO ] Built C files in 651ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin5253394942157629975
Running compilation step : cd /tmp/ltsmin5253394942157629975;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '240' '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'
[2023-03-20 01:52:55] [INFO ] Applying decomposition
[2023-03-20 01:52:56] [INFO ] Flatten gal took : 1314 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/graph3615863657881354808.txt' '-o' '/tmp/graph3615863657881354808.bin' '-w' '/tmp/graph3615863657881354808.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph3615863657881354808.bin' '-l' '-1' '-v' '-w' '/tmp/graph3615863657881354808.weights' '-q' '0' '-e' '0.001'
[2023-03-20 01:53:00] [INFO ] Decomposing Gal with order
[2023-03-20 01:53:00] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-20 01:53:04] [INFO ] Removed a total of 156232 redundant transitions.
[2023-03-20 01:53:05] [INFO ] Flatten gal took : 2321 ms
[2023-03-20 01:53:12] [INFO ] Fuse similar labels procedure discarded/fused a total of 4113 labels/synchronizations in 3005 ms.
[2023-03-20 01:53:14] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality1962283078019760332.gal : 165 ms
[2023-03-20 01:53:14] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality14705156558230539218.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/ReachabilityCardinality1962283078019760332.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality14705156558230539218.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/ReachabilityCardinality14705156558230539218.prop.
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running cd /tmp/ltsmin5253394942157629975;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '240' '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' killed by timeout after 240 SECONDS
java.lang.RuntimeException: Compilation or link of executable timed out.java.util.concurrent.TimeoutException: Subprocess running cd /tmp/ltsmin5253394942157629975;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '240' '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' killed by timeout after 240 SECONDS
at fr.lip6.move.gal.application.runner.ltsmin.LTSminRunner$1.run(LTSminRunner.java:92)
at java.base/java.lang.Thread.run(Thread.java:833)
SDD proceeding with computation,3 properties remain. new max is 4
SDD size :1 after 2
SDD proceeding with computation,3 properties remain. new max is 8
SDD size :2 after 5
SDD proceeding with computation,3 properties remain. new max is 16
SDD size :5 after 11
SDD proceeding with computation,3 properties remain. new max is 32
SDD size :11 after 14
SDD proceeding with computation,3 properties remain. new max is 64
SDD size :14 after 29
SDD proceeding with computation,3 properties remain. new max is 128
SDD size :29 after 33
SDD proceeding with computation,3 properties remain. new max is 256
SDD size :33 after 62
SDD proceeding with computation,3 properties remain. new max is 512
SDD size :62 after 116
SDD proceeding with computation,3 properties remain. new max is 1024
SDD size :116 after 282
SDD proceeding with computation,3 properties remain. new max is 2048
SDD size :282 after 45267
SDD proceeding with computation,3 properties remain. new max is 4096
SDD size :45267 after 1.22713e+07
SDD proceeding with computation,3 properties remain. new max is 8192
SDD size :1.22713e+07 after 4.85591e+07
SDD proceeding with computation,3 properties remain. new max is 16384
SDD size :4.85591e+07 after 1.21512e+09
SDD proceeding with computation,3 properties remain. new max is 32768
SDD size :1.21512e+09 after 5.88863e+09
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393216 kB
MemFree: 6239024 kB
After kill :
MemTotal: 16393216 kB
MemFree: 15567440 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//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
+ 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="TokenRing-PT-040"
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 TokenRing-PT-040, 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 r485-tall-167912699700694"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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