Execution Chart

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

Trace from the execution

Formatting '/data/fko/mcc2022-input.r204-oct2-165281599500593.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2022-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is SharedMemory-COL-000500, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r204-oct2-165281599500593
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 252K
-rw-r--r-- 1 mcc users 6.0K Apr 30 10:06 CTLCardinality.txt
-rw-r--r-- 1 mcc users 55K Apr 30 10:06 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.9K Apr 30 10:06 CTLFireability.txt
-rw-r--r-- 1 mcc users 56K Apr 30 10:06 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 10 09:34 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K May 10 09:34 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.9K May 9 08:46 LTLCardinality.txt
-rw-r--r-- 1 mcc users 24K May 9 08:46 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.7K May 9 08:46 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K May 9 08:46 LTLFireability.xml
-rw-r--r-- 1 mcc users 1.8K May 9 08:46 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K May 9 08:46 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 10 09:34 equiv_pt
-rw-r--r-- 1 mcc users 7 May 10 09:34 instance
-rw-r--r-- 1 mcc users 5 May 10 09:34 iscolored
-rw-r--r-- 1 mcc users 33K May 10 09:34 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 SharedMemory-COL-000500-CTLCardinality-00
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-01
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-02
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-03
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-04
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-05
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-06
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-07
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-08
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-09
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-10
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-11
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-12
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-13
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-14
FORMULA_NAME SharedMemory-COL-000500-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1652979118176

Running Version 202205111006
[2022-05-19 16:51:59] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -spotpath, /home/mcc/BenchKit/bin//..//ltlfilt, -z3path, /home/mcc/BenchKit/bin//..//z3/bin/z3, -yices2path, /home/mcc/BenchKit/bin//..//yices/bin/yices, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2022-05-19 16:51:59] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-19 16:51:59] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
log4j:WARN No appenders could be found for logger (org.apache.axiom.locator.DefaultOMMetaFactoryLocator).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
[2022-05-19 16:51:59] [WARNING] Using fallBack plugin, rng conformance not checked
[2022-05-19 16:51:59] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 485 ms
[2022-05-19 16:51:59] [INFO ] Imported 6 HL places and 5 HL transitions for a total of 252001 PT places and 751000.0 transition bindings in 25 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 12 ms.
[2022-05-19 16:51:59] [INFO ] Built PT skeleton of HLPN with 6 places and 5 transitions 16 arcs in 5 ms.
[2022-05-19 16:51:59] [INFO ] Skeletonized 16 HLPN properties in 0 ms.
Initial state reduction rules removed 5 formulas.
FORMULA SharedMemory-COL-000500-CTLCardinality-00 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA SharedMemory-COL-000500-CTLCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA SharedMemory-COL-000500-CTLCardinality-09 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA SharedMemory-COL-000500-CTLCardinality-12 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA SharedMemory-COL-000500-CTLCardinality-13 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Computed a total of 0 stabilizing places and 0 stable transitions
Remains 11 properties that can be checked using skeleton over-approximation.
Computed a total of 0 stabilizing places and 0 stable transitions
Incomplete random walk after 10001 steps, including 2 resets, run finished after 301 ms. (steps per millisecond=33 ) properties (out of 47) seen :22
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 7 ms. (steps per millisecond=142 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 26 ms. (steps per millisecond=38 ) properties (out of 25) seen :1
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 25 ms. (steps per millisecond=40 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 13 ms. (steps per millisecond=77 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 22 ms. (steps per millisecond=45 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=250 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=250 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 24) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 24) seen :0
Running SMT prover for 24 properties.
// Phase 1: matrix 5 rows 6 cols
[2022-05-19 16:52:00] [INFO ] Computed 3 place invariants in 8 ms
[2022-05-19 16:52:00] [INFO ] After 115ms SMT Verify possible using all constraints in real domain returned unsat :2 sat :0 real:22
[2022-05-19 16:52:00] [INFO ] [Nat]Absence check using 3 positive place invariants in 1 ms returned sat
[2022-05-19 16:52:00] [INFO ] After 82ms SMT Verify possible using all constraints in natural domain returned unsat :24 sat :0
Fused 24 Parikh solutions to 0 different solutions.
Parikh walk visited 0 properties in 0 ms.
Successfully simplified 24 atomic propositions for a total of 11 simplifications.
FORMULA SharedMemory-COL-000500-CTLCardinality-10 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2022-05-19 16:52:00] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
[2022-05-19 16:52:00] [INFO ] Flatten gal took : 31 ms
FORMULA SharedMemory-COL-000500-CTLCardinality-05 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2022-05-19 16:52:00] [INFO ] Flatten gal took : 1 ms
Domain [P(500), P(500)] of place Ext_Mem_Acc breaks symmetries in sort P
[2022-05-19 16:52:03] [INFO ] Unfolded HLPN to a Petri net with 252001 places and 501000 transitions 2002000 arcs in 2444 ms.
[2022-05-19 16:52:03] [INFO ] Unfolded 9 HLPN properties in 70 ms.
Deduced a syphon composed of 500 places in 441 ms
Reduce places removed 500 places and 500 transitions.
Support contains 251501 out of 251501 places. Attempting structural reductions.
Starting structural reductions in LTL mode, iteration 0 : 251501/251501 places, 500500/500500 transitions.
Applied a total of 0 rules in 2224 ms. Remains 251501 /251501 variables (removed 0) and now considering 500500/500500 (removed 0) transitions.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 16:54:15] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 16:54:36] [INFO ] Implicit Places using invariants in 141320 ms returned []
Implicit Place search using SMT only with invariants took 141324 ms to find 0 implicit places.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 16:56:36] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 16:56:50] [INFO ] Dead Transitions using invariants and state equation in 134245 ms found 0 transitions.
Finished structural reductions, in 1 iterations. Remains : 251501/251501 places, 500500/500500 transitions.
Support contains 251501 out of 251501 places after structural reductions.
[2022-05-19 16:57:14] [INFO ] Flatten gal took : 17268 ms
[2022-05-19 16:57:52] [INFO ] Flatten gal took : 17756 ms
[2022-05-19 16:58:51] [INFO ] Input system was already deterministic with 500500 transitions.
FORMULA SharedMemory-COL-000500-CTLCardinality-08 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Interrupted random walk after 950 steps, including 0 resets, run timeout after 30003 ms. (steps per millisecond=0 ) properties seen 14
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3493 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3108 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 68 ms. (steps per millisecond=14 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 56 ms. (steps per millisecond=17 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 53 ms. (steps per millisecond=18 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 63 ms. (steps per millisecond=15 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 112 ms. (steps per millisecond=8 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3020 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 102 ms. (steps per millisecond=9 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3054 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 8006 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 80 ms. (steps per millisecond=12 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 110 ms. (steps per millisecond=9 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 2980 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3122 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 70 ms. (steps per millisecond=14 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 8931 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 55 ms. (steps per millisecond=18 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3955 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 79 ms. (steps per millisecond=12 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3463 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 62 ms. (steps per millisecond=16 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 78 ms. (steps per millisecond=12 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 3289 ms. (steps per millisecond=0 ) properties (out of 25) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 50 ms. (steps per millisecond=20 ) properties (out of 25) seen :0
Running SMT prover for 25 properties.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:02:17] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:02:43] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2022-05-19 17:02:43] [INFO ] After 25137ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0
Fused 25 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 0 ms.
Support contains 251501 out of 251501 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 251501/251501 places, 500500/500500 transitions.
Applied a total of 0 rules in 31294 ms. Remains 251501 /251501 variables (removed 0) and now considering 500500/500500 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 251501/251501 places, 500500/500500 transitions.
[2022-05-19 17:03:49] [INFO ] Flatten gal took : 25151 ms
[2022-05-19 17:04:34] [INFO ] Flatten gal took : 24091 ms
[2022-05-19 17:05:49] [INFO ] Input system was already deterministic with 500500 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Starting structural reductions in LTL mode, iteration 0 : 251501/251501 places, 500500/500500 transitions.
Applied a total of 0 rules in 8162 ms. Remains 251501 /251501 variables (removed 0) and now considering 500500/500500 (removed 0) transitions.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:08:23] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:08:46] [INFO ] Implicit Places using invariants in 144468 ms returned []
Implicit Place search using SMT only with invariants took 144471 ms to find 0 implicit places.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:10:47] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:11:09] [INFO ] Dead Transitions using invariants and state equation in 142893 ms found 0 transitions.
Finished structural reductions, in 1 iterations. Remains : 251501/251501 places, 500500/500500 transitions.
[2022-05-19 17:11:44] [INFO ] Flatten gal took : 29420 ms
[2022-05-19 17:12:14] [INFO ] Flatten gal took : 29264 ms
[2022-05-19 17:13:28] [INFO ] Input system was already deterministic with 500500 transitions.
[2022-05-19 17:14:12] [INFO ] Flatten gal took : 32317 ms
[2022-05-19 17:14:42] [INFO ] Flatten gal took : 29747 ms
[2022-05-19 17:14:46] [INFO ] Time to serialize gal into /tmp/CTLCardinality8913806184290104728.gal : 3922 ms
[2022-05-19 17:14:47] [INFO ] Time to serialize properties into /tmp/CTLCardinality17792418184755711363.ctl : 518 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLCardinality8913806184290104728.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality17792418184755711363.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/C...275
Detected timeout of ITS tools.
[2022-05-19 17:15:53] [INFO ] Flatten gal took : 32390 ms
[2022-05-19 17:15:53] [INFO ] Applying decomposition
[2022-05-19 17:16:29] [INFO ] Flatten gal took : 35863 ms
Louvain graph construction failed due to OOM.
[2022-05-19 17:22:33] [WARNING] Could not apply decomposition. Using flat GAL structure.
java.lang.NullPointerException
at fr.lip6.move.gal.application.mcc.MccTranslator.applyOrder(MccTranslator.java:230)
at fr.lip6.move.gal.application.mcc.MccTranslator.flattenSpec(MccTranslator.java:264)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.verifyWithSDD(GlobalPropertySolver.java:654)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:606)
at fr.lip6.move.gal.application.Application.start(Application.java:174)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:43)
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:401)
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:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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)
[2022-05-19 17:22:52] [INFO ] Flatten gal took : 18666 ms
[2022-05-19 17:22:54] [INFO ] Time to serialize gal into /tmp/CTLCardinality5959061773834288916.gal : 1493 ms
[2022-05-19 17:22:54] [INFO ] Time to serialize properties into /tmp/CTLCardinality402242840727753665.ctl : 189 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLCardinality5959061773834288916.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality402242840727753665.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/C...273
Detected timeout of ITS tools.
Starting structural reductions in SI_CTL mode, iteration 0 : 251501/251501 places, 500500/500500 transitions.
Applied a total of 0 rules in 38480 ms. Remains 251501 /251501 variables (removed 0) and now considering 500500/500500 (removed 0) transitions.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:26:04] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:26:23] [INFO ] Implicit Places using invariants in 139822 ms returned []
Implicit Place search using SMT only with invariants took 139824 ms to find 0 implicit places.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:28:24] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:28:47] [INFO ] Dead Transitions using invariants and state equation in 144236 ms found 0 transitions.
Finished structural reductions, in 1 iterations. Remains : 251501/251501 places, 500500/500500 transitions.
[2022-05-19 17:29:13] [INFO ] Flatten gal took : 22043 ms
[2022-05-19 17:29:38] [INFO ] Flatten gal took : 24603 ms
[2022-05-19 17:30:38] [INFO ] Input system was already deterministic with 500500 transitions.
[2022-05-19 17:31:11] [INFO ] Flatten gal took : 26961 ms
[2022-05-19 17:31:40] [INFO ] Flatten gal took : 28257 ms
[2022-05-19 17:31:41] [INFO ] Time to serialize gal into /tmp/CTLCardinality13887251883618726216.gal : 1692 ms
[2022-05-19 17:31:41] [INFO ] Time to serialize properties into /tmp/CTLCardinality3660329490204011691.ctl : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLCardinality13887251883618726216.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality3660329490204011691.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/C...275
Detected timeout of ITS tools.
[2022-05-19 17:32:48] [INFO ] Flatten gal took : 26237 ms
[2022-05-19 17:32:48] [INFO ] Applying decomposition
[2022-05-19 17:33:16] [INFO ] Flatten gal took : 28469 ms
Louvain graph construction failed due to OOM.
[2022-05-19 17:37:02] [WARNING] Could not apply decomposition. Using flat GAL structure.
java.lang.NullPointerException
at fr.lip6.move.gal.application.mcc.MccTranslator.applyOrder(MccTranslator.java:230)
at fr.lip6.move.gal.application.mcc.MccTranslator.flattenSpec(MccTranslator.java:264)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.verifyWithSDD(GlobalPropertySolver.java:654)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:606)
at fr.lip6.move.gal.application.Application.start(Application.java:174)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:43)
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:401)
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:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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)
[2022-05-19 17:37:22] [INFO ] Flatten gal took : 19531 ms
[2022-05-19 17:37:24] [INFO ] Time to serialize gal into /tmp/CTLCardinality9598790186494822937.gal : 1448 ms
[2022-05-19 17:37:24] [INFO ] Time to serialize properties into /tmp/CTLCardinality15160756602923572616.ctl : 3 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLCardinality9598790186494822937.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality15160756602923572616.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/C...275
Detected timeout of ITS tools.
Starting structural reductions in LTL mode, iteration 0 : 251501/251501 places, 500500/500500 transitions.
Applied a total of 0 rules in 20785 ms. Remains 251501 /251501 variables (removed 0) and now considering 500500/500500 (removed 0) transitions.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:40:19] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:40:35] [INFO ] Implicit Places using invariants in 138735 ms returned []
Implicit Place search using SMT only with invariants took 138770 ms to find 0 implicit places.
// Phase 1: matrix 500500 rows 251501 cols
[2022-05-19 17:42:36] [WARNING] Invariant computation timed out after 120 seconds.
[2022-05-19 17:42:56] [INFO ] Dead Transitions using invariants and state equation in 140976 ms found 0 transitions.
Finished structural reductions, in 1 iterations. Remains : 251501/251501 places, 500500/500500 transitions.
[2022-05-19 17:43:23] [INFO ] Flatten gal took : 23515 ms
[2022-05-19 17:43:45] [INFO ] Flatten gal took : 22018 ms
[2022-05-19 17:44:36] [INFO ] Input system was already deterministic with 500500 transitions.
[2022-05-19 17:45:07] [INFO ] Flatten gal took : 25884 ms
[2022-05-19 17:45:32] [INFO ] Flatten gal took : 25468 ms
[2022-05-19 17:45:35] [INFO ] Time to serialize gal into /tmp/CTLCardinality13384003204265850114.gal : 2107 ms
[2022-05-19 17:45:36] [INFO ] Time to serialize properties into /tmp/CTLCardinality7615796263974375657.ctl : 1191 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLCardinality13384003204265850114.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality7615796263974375657.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/C...275
Detected timeout of ITS tools.
[2022-05-19 17:46:38] [INFO ] Flatten gal took : 25802 ms
[2022-05-19 17:46:38] [INFO ] Applying decomposition
[2022-05-19 17:47:03] [INFO ] Flatten gal took : 25281 ms
Louvain graph construction failed due to OOM.
[2022-05-19 17:50:21] [WARNING] Could not apply decomposition. Using flat GAL structure.
java.lang.NullPointerException
at fr.lip6.move.gal.application.mcc.MccTranslator.applyOrder(MccTranslator.java:230)
at fr.lip6.move.gal.application.mcc.MccTranslator.flattenSpec(MccTranslator.java:264)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.verifyWithSDD(GlobalPropertySolver.java:654)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:606)
at fr.lip6.move.gal.application.Application.start(Application.java:174)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:43)
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:401)
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:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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)
[2022-05-19 17:50:44] [INFO ] Flatten gal took : 22527 ms
[2022-05-19 17:50:46] [INFO ] Time to serialize gal into /tmp/CTLCardinality1595691955703077983.gal : 1801 ms
[2022-05-19 17:50:46] [INFO ] Time to serialize properties into /tmp/CTLCardinality7139222793388386086.ctl : 194 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/CTLCardinality1595691955703077983.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality7139222793388386086.ctl' '--gen-order' 'FOLLOW'

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202205111006/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /tmp/C...274
Detected timeout of ITS tools.
Starting structural reductions in LTL mode, iteration 0 : 251501/251501 places, 500500/500500 transitions.
Applied a total of 0 rules in 2286 ms. Remains 251501 /251501 variables (removed 0) and now considering 500500/500500 (removed 0) transitions.
// Phase 1: matrix 500500 rows 251501 cols

BK_TIME_CONFINEMENT_REACHED

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

+ export LANG=C
+ LANG=C
+ export BINDIR=/home/mcc/BenchKit/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ CTLCardinality = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution CTLCardinality -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ export PYTHONPATH=/usr/lib/python3.9/site-packages/
+ PYTHONPATH=/usr/lib/python3.9/site-packages/
+ export LD_LIBRARY_PATH=/usr/local/lib:
+ LD_LIBRARY_PATH=/usr/local/lib:
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202205111006.jar
+ VERSION=202205111006
+ echo 'Running Version 202205111006'
+ /home/mcc/BenchKit/bin//..//itstools/its-tools -data @none -pnfolder /home/mcc/execution -examination CTLCardinality -spotpath /home/mcc/BenchKit/bin//..//ltlfilt -z3path /home/mcc/BenchKit/bin//..//z3/bin/z3 -yices2path /home/mcc/BenchKit/bin//..//yices/bin/yices -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600 -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=@none -Xss128m -Xms40m -Xmx8192m

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="SharedMemory-COL-000500"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itstools"
echo " Input is SharedMemory-COL-000500, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r204-oct2-165281599500593"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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