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

About the Execution of ITS-Tools for FamilyReunion-COL-L00050M0005C002P002G001

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
16218.048 3600000.00 11865285.00 78625.60 TFFTT???TFF?TFTF 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.r165-tall-167838850200318.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 FamilyReunion-COL-L00050M0005C002P002G001, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r165-tall-167838850200318
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 568K
-rw-r--r-- 1 mcc users 7.2K Feb 26 12:11 CTLCardinality.txt
-rw-r--r-- 1 mcc users 77K Feb 26 12:11 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.9K Feb 26 12:04 CTLFireability.txt
-rw-r--r-- 1 mcc users 51K Feb 26 12:04 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:40 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 7.0K Jan 29 11:40 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.9K Feb 25 16:05 LTLCardinality.txt
-rw-r--r-- 1 mcc users 27K Feb 25 16:05 LTLCardinality.xml
-rw-r--r-- 1 mcc users 3.2K Feb 25 16:05 LTLFireability.txt
-rw-r--r-- 1 mcc users 20K Feb 25 16:05 LTLFireability.xml
-rw-r--r-- 1 mcc users 10K Feb 26 12:35 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 103K Feb 26 12:35 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 9.3K Feb 26 12:26 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 57K Feb 26 12:26 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.0K Feb 25 16:05 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.0K Feb 25 16:05 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 5 18:22 equiv_pt
-rw-r--r-- 1 mcc users 24 Mar 5 18:22 instance
-rw-r--r-- 1 mcc users 5 Mar 5 18:22 iscolored
-rw-r--r-- 1 mcc users 137K Mar 5 18:22 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 FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-00
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-01
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-02
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-03
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-04
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-05
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-06
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-07
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-08
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-09
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-10
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-11
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-12
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-13
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-14
FORMULA_NAME FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-15

=== Now, execution of the tool begins

BK_START 1679461361854

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=FamilyReunion-COL-L00050M0005C002P002G001
Not applying reductions.
Model is COL
ReachabilityCardinality COL
Running Version 202303021504
[2023-03-22 05:02:43] [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-22 05:02:43] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-22 05:02:43] [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.
[2023-03-22 05:02:43] [WARNING] Using fallBack plugin, rng conformance not checked
[2023-03-22 05:02:43] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 508 ms
[2023-03-22 05:02:43] [INFO ] Detected 5 constant HL places corresponding to 17 PT places.
[2023-03-22 05:02:43] [INFO ] Imported 104 HL places and 66 HL transitions for a total of 12245 PT places and 10611.0 transition bindings in 24 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 22 ms.
Working with output stream class java.io.PrintStream
[2023-03-22 05:02:43] [INFO ] Built PT skeleton of HLPN with 104 places and 66 transitions 198 arcs in 5 ms.
[2023-03-22 05:02:43] [INFO ] Skeletonized 16 HLPN properties in 1 ms.
Remains 16 properties that can be checked using skeleton over-approximation.
Reduce places removed 5 places and 0 transitions.
Computed a total of 99 stabilizing places and 66 stable transitions
Complete graph has no SCC; deadlocks are unavoidable. place count 99 transition count 66
[2023-03-22 05:02:44] [INFO ] Flatten gal took : 24 ms
[2023-03-22 05:02:44] [INFO ] Flatten gal took : 15 ms
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-03 TRUE TECHNIQUES CPN_APPROX
Transition Gate2ANDJoin forces synchronizations/join behavior on parameter l of sort LegalResident
Transition ReceiveLangChoice forces synchronizations/join behavior on parameter m of sort MICSystem
Symmetric sort wr.t. initial and guards and successors and join/free detected :CINFORMI
Symmetric sort wr.t. initial detected :CINFORMI
Symmetric sort wr.t. initial and guards detected :CINFORMI
Applying symmetric unfolding of full symmetric sort :CINFORMI domain size was 3
Transition Gate1ANDJoin forces synchronizations/join behavior on parameter p of sort PublicAdminOffice
Symmetric sort wr.t. initial and guards and successors and join/free detected :Response
Symmetric sort wr.t. initial detected :Response
Transition SendClearanceToRel : guard parameter $r(Response:2) in guard (EQ $r 0)introduces in Response(2) partition with 2 elements
Symmetric sort wr.t. initial and guards and successors and join/free detected :GovernmentCommission
Symmetric sort wr.t. initial detected :GovernmentCommission
Symmetric sort wr.t. initial and guards detected :GovernmentCommission
Applying symmetric unfolding of full symmetric sort :GovernmentCommission domain size was 2
[2023-03-22 05:02:44] [INFO ] Unfolded HLPN to a Petri net with 11467 places and 9336 transitions 26832 arcs in 96 ms.
[2023-03-22 05:02:44] [INFO ] Unfolded 16 HLPN properties in 2 ms.
Deduced a syphon composed of 51 places in 60 ms
Reduce places removed 64 places and 0 transitions.
[2023-03-22 05:02:45] [INFO ] Flatten gal took : 534 ms
[2023-03-22 05:02:45] [INFO ] Flatten gal took : 328 ms
Incomplete random walk after 10000 steps, including 3 resets, run finished after 1398 ms. (steps per millisecond=7 ) properties (out of 15) seen :3
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-15 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-13 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-00 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
[2023-03-22 05:02:45] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality13146544772947703686.gal : 124 ms
[2023-03-22 05:02:45] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality5710578122334225062.prop : 41 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/ReachabilityCardinality13146544772947703686.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality5710578122334225062.prop' '--nowitness' '--gen-order' 'FOLLOW'
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 77 ms. (steps per millisecond=129 ) properties (out of 12) seen :0

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
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 185 ms. (steps per millisecond=54 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 214 ms. (steps per millisecond=46 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 369 ms. (steps per millisecond=27 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 370 ms. (steps per millisecond=27 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 88 ms. (steps per millisecond=113 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 96 ms. (steps per millisecond=104 ) properties (out of 12) seen :0
Loading property file /tmp/ReachabilityCardinality5710578122334225062.prop.
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 614 ms. (steps per millisecond=16 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 244 ms. (steps per millisecond=40 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 626 ms. (steps per millisecond=15 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 33 ms. (steps per millisecond=303 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 263 ms. (steps per millisecond=38 ) properties (out of 12) seen :0
Running SMT prover for 12 properties.
// Phase 1: matrix 9336 rows 11403 cols
[2023-03-22 05:02:49] [INFO ] Computed 2767 place invariants in 618 ms
[2023-03-22 05:02:55] [INFO ] [Real]Absence check using 59 positive place invariants in 83 ms returned sat
[2023-03-22 05:02:57] [INFO ] [Real]Absence check using 59 positive and 2708 generalized place invariants in 1509 ms returned sat
[2023-03-22 05:02:57] [INFO ] After 4871ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:12
[2023-03-22 05:03:00] [INFO ] [Nat]Absence check using 59 positive place invariants in 82 ms returned sat
[2023-03-22 05:03:01] [INFO ] [Nat]Absence check using 59 positive and 2708 generalized place invariants in 1504 ms returned sat
[2023-03-22 05:03:22] [INFO ] After 14795ms SMT Verify possible using state equation in natural domain returned unsat :7 sat :4
[2023-03-22 05:03:22] [INFO ] After 14815ms SMT Verify possible using trap constraints in natural domain returned unsat :7 sat :4
Attempting to minimize the solution found.
Minimization took 4 ms.
[2023-03-22 05:03:22] [INFO ] After 25072ms SMT Verify possible using all constraints in natural domain returned unsat :7 sat :4
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-14 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-12 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-10 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-09 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-08 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-04 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-02 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Fused 12 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 0 ms.
Support contains 6693 out of 11403 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 11403/11403 places, 9336/9336 transitions.
Graph (complete) has 16989 edges and 11403 vertex of which 11290 are kept as prefixes of interest. Removing 113 places using SCC suffix rule.23 ms
Discarding 113 places :
Also discarding 0 output transitions
Discarding 306 places :
Implicit places reduction removed 306 places
Performed 357 Post agglomeration using F-continuation condition.Transition count delta: 357
Iterating post reduction 0 with 663 rules applied. Total rules applied 664 place count 10984 transition count 8979
Reduce places removed 357 places and 0 transitions.
Iterating post reduction 1 with 357 rules applied. Total rules applied 1021 place count 10627 transition count 8979
Performed 102 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 102 Pre rules applied. Total rules applied 1021 place count 10627 transition count 8877
Deduced a syphon composed of 102 places in 10 ms
Reduce places removed 102 places and 0 transitions.
Iterating global reduction 2 with 204 rules applied. Total rules applied 1225 place count 10525 transition count 8877
Discarding 255 places :
Symmetric choice reduction at 2 with 255 rule applications. Total rules 1480 place count 10270 transition count 8622
Iterating global reduction 2 with 255 rules applied. Total rules applied 1735 place count 10270 transition count 8622
Applied a total of 1735 rules in 1356 ms. Remains 10270 /11403 variables (removed 1133) and now considering 8622/9336 (removed 714) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 1360 ms. Remains : 10270/11403 places, 8622/9336 transitions.
Incomplete random walk after 10000 steps, including 3 resets, run finished after 643 ms. (steps per millisecond=15 ) properties (out of 5) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 99 ms. (steps per millisecond=101 ) properties (out of 5) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 360 ms. (steps per millisecond=27 ) properties (out of 5) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 388 ms. (steps per millisecond=25 ) properties (out of 5) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 103 ms. (steps per millisecond=97 ) properties (out of 5) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 787 ms. (steps per millisecond=12 ) properties (out of 5) seen :0
Interrupted probabilistic random walk after 99306 steps, run timeout after 6001 ms. (steps per millisecond=16 ) properties seen :{}
Probabilistic random walk after 99306 steps, saw 86057 distinct states, run finished after 6004 ms. (steps per millisecond=16 ) properties seen :0
Running SMT prover for 5 properties.
// Phase 1: matrix 8622 rows 10270 cols
[2023-03-22 05:03:32] [INFO ] Computed 2353 place invariants in 385 ms
[2023-03-22 05:03:36] [INFO ] [Real]Absence check using 0 positive and 2353 generalized place invariants in 1073 ms returned sat
[2023-03-22 05:03:36] [INFO ] After 2941ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:5
[2023-03-22 05:03:39] [INFO ] [Nat]Absence check using 0 positive and 2353 generalized place invariants in 1085 ms returned sat
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.checkResults(DeadlockTester.java:797)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:631)
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-22 05:04:01] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-22 05:04:01] [INFO ] After 25147ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :0 real:5
Fused 5 Parikh solutions to 2 different solutions.
FORMULA FamilyReunion-COL-L00050M0005C002P002G001-ReachabilityCardinality-01 FALSE TECHNIQUES TOPOLOGICAL PARIKH_WALK
Parikh walk visited 1 properties in 98 ms.
Support contains 6387 out of 10270 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 10270/10270 places, 8622/8622 transitions.
Applied a total of 0 rules in 568 ms. Remains 10270 /10270 variables (removed 0) and now considering 8622/8622 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 573 ms. Remains : 10270/10270 places, 8622/8622 transitions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 10270/10270 places, 8622/8622 transitions.
Applied a total of 0 rules in 396 ms. Remains 10270 /10270 variables (removed 0) and now considering 8622/8622 (removed 0) transitions.
[2023-03-22 05:04:02] [INFO ] Invariant cache hit.
[2023-03-22 05:04:03] [INFO ] SMT solver returned unknown. Retrying;
[2023-03-22 05:04:03] [INFO ] Implicit Places using invariants in 902 ms returned []
Implicit Place search using SMT only with invariants took 907 ms to find 0 implicit places.
[2023-03-22 05:04:04] [INFO ] Redundant transitions in 1093 ms returned []
[2023-03-22 05:04:04] [INFO ] Invariant cache hit.
[2023-03-22 05:04:05] [INFO ] SMT solver returned unknown. Retrying;
[2023-03-22 05:04:05] [INFO ] Dead Transitions using invariants and state equation in 1051 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 3462 ms. Remains : 10270/10270 places, 8622/8622 transitions.
Applied a total of 0 rules in 391 ms. Remains 10270 /10270 variables (removed 0) and now considering 8622/8622 (removed 0) transitions.
Running SMT prover for 4 properties.
[2023-03-22 05:04:06] [INFO ] Invariant cache hit.
[2023-03-22 05:04:08] [INFO ] After 1505ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:4
[2023-03-22 05:04:10] [INFO ] [Nat]Absence check using 0 positive and 2353 generalized place invariants in 1021 ms returned sat
SDD proceeding with computation,15 properties remain. new max is 4
SDD size :1 after 4
SDD proceeding with computation,15 properties remain. new max is 8
SDD size :4 after 7
SDD proceeding with computation,15 properties remain. new max is 16
SDD size :7 after 8
SDD proceeding with computation,15 properties remain. new max is 32
SDD size :8 after 40
SDD proceeding with computation,15 properties remain. new max is 64
SDD size :40 after 88
SDD proceeding with computation,15 properties remain. new max is 128
SDD size :88 after 1032
SDD proceeding with computation,15 properties remain. new max is 256
SDD size :1032 after 1468
SDD proceeding with computation,15 properties remain. new max is 512
SDD size :1468 after 9600
[2023-03-22 05:04:58] [INFO ] After 45862ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :1
[2023-03-22 05:05:07] [INFO ] After 54769ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :1
Attempting to minimize the solution found.
SDD proceeding with computation,15 properties remain. new max is 1024
SDD size :9600 after 8.25754e+06
Minimization took 6574 ms.
[2023-03-22 05:05:13] [INFO ] After 65210ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :1
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-22 05:05:14] [INFO ] Flatten gal took : 294 ms
[2023-03-22 05:05:14] [INFO ] Applying decomposition
[2023-03-22 05:05:14] [INFO ] Flatten gal took : 265 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/graph17446372988679306824.txt' '-o' '/tmp/graph17446372988679306824.bin' '-w' '/tmp/graph17446372988679306824.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph17446372988679306824.bin' '-l' '-1' '-v' '-w' '/tmp/graph17446372988679306824.weights' '-q' '0' '-e' '0.001'
[2023-03-22 05:05:17] [INFO ] Decomposing Gal with order
[2023-03-22 05:05:18] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-22 05:05:24] [INFO ] Removed a total of 1969 redundant transitions.
[2023-03-22 05:05:24] [INFO ] Flatten gal took : 4528 ms
[2023-03-22 05:05:26] [INFO ] Fuse similar labels procedure discarded/fused a total of 969 labels/synchronizations in 417 ms.
[2023-03-22 05:05:28] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality924329567609176412.gal : 112 ms
[2023-03-22 05:05:28] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality3655486729647695265.prop : 4 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/ReachabilityCardinality924329567609176412.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality3655486729647695265.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 ...327
Loading property file /tmp/ReachabilityCardinality3655486729647695265.prop.
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 3
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :3 after 5
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :5 after 8
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :8 after 72
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :72 after 96
SDD proceeding with computation,4 properties remain. new max is 128
SDD size :96 after 144
SDD proceeding with computation,4 properties remain. new max is 256
SDD size :144 after 2240
SDD proceeding with computation,4 properties remain. new max is 512
SDD size :2240 after 5600
SDD proceeding with computation,4 properties remain. new max is 1024
SDD size :5600 after 340992
SDD proceeding with computation,4 properties remain. new max is 2048
SDD size :340992 after 4.71315e+07
SDD proceeding with computation,4 properties remain. new max is 4096
SDD size :4.71315e+07 after 1.12781e+08
SDD proceeding with computation,4 properties remain. new max is 8192
SDD size :1.12781e+08 after 1.9995e+08
SDD proceeding with computation,4 properties remain. new max is 16384
SDD size :1.9995e+08 after 3.23703e+08
SDD proceeding with computation,4 properties remain. new max is 32768
SDD size :3.23703e+08 after 3.76443e+08
SDD proceeding with computation,4 properties remain. new max is 65536
SDD size :3.76443e+08 after 4.21188e+08
SDD proceeding with computation,15 properties remain. new max is 2048
SDD size :8.25754e+06 after 1.5259e+08
SDD proceeding with computation,4 properties remain. new max is 131072
SDD size :4.21188e+08 after 5.89518e+08
SDD proceeding with computation,15 properties remain. new max is 4096
SDD size :1.5259e+08 after 1.79301e+08
SDD proceeding with computation,4 properties remain. new max is 262144
SDD size :5.89518e+08 after 1.1202e+09
ITS-tools command line returned an error code 137
[2023-03-22 05:20:37] [INFO ] Flatten gal took : 456 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin10295496652836680875
[2023-03-22 05:20:45] [INFO ] Applying decomposition
[2023-03-22 05:20:45] [INFO ] Too many transitions (8622) to apply POR reductions. Disabling POR matrices.
[2023-03-22 05:20:45] [INFO ] Built C files in 381ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin10295496652836680875
[2023-03-22 05:20:45] [INFO ] Flatten gal took : 565 ms
Running compilation step : cd /tmp/ltsmin10295496652836680875;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '180' '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/graph12179835518930414065.txt' '-o' '/tmp/graph12179835518930414065.bin' '-w' '/tmp/graph12179835518930414065.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph12179835518930414065.bin' '-l' '-1' '-v' '-w' '/tmp/graph12179835518930414065.weights' '-q' '0' '-e' '0.001'
[2023-03-22 05:21:22] [INFO ] Decomposing Gal with order
[2023-03-22 05:21:23] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-22 05:21:31] [INFO ] Removed a total of 1918 redundant transitions.
[2023-03-22 05:21:31] [INFO ] Flatten gal took : 7133 ms
[2023-03-22 05:21:32] [INFO ] Fuse similar labels procedure discarded/fused a total of 857 labels/synchronizations in 260 ms.
[2023-03-22 05:21:33] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality11077871264917225010.gal : 104 ms
[2023-03-22 05:21:33] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality16570762620346710885.prop : 4 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/ReachabilityCardinality11077871264917225010.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality16570762620346710885.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 ...330
Loading property file /tmp/ReachabilityCardinality16570762620346710885.prop.
Compilation finished in 77945 ms.
Running link step : cd /tmp/ltsmin10295496652836680875;'gcc' '-shared' '-o' 'gal.so' 'model.o'
Link finished in 96 ms.
Running LTSmin : cd /tmp/ltsmin10295496652836680875;'/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' 'FamilyReunionCOLL00050M0005C002P002G001ReachabilityCardinality05==true'
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 4
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :4 after 6
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :6 after 8
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :8 after 56
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :56 after 64
SDD proceeding with computation,4 properties remain. new max is 128
SDD size :64 after 896
SDD proceeding with computation,4 properties remain. new max is 256
SDD size :896 after 1760
SDD proceeding with computation,4 properties remain. new max is 512
SDD size :1760 after 7200
SDD proceeding with computation,4 properties remain. new max is 1024
SDD size :7200 after 160000
SDD proceeding with computation,4 properties remain. new max is 2048
SDD size :160000 after 191600
SDD proceeding with computation,4 properties remain. new max is 4096
SDD size :191600 after 279200
SDD proceeding with computation,4 properties remain. new max is 8192
SDD size :279200 after 491520
ITS-tools command line returned an error code 137
WARNING : LTSmin timed out (>900 s) on command cd /tmp/ltsmin10295496652836680875;'/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' 'FamilyReunionCOLL00050M0005C002P002G001ReachabilityCardinality05==true'
Running LTSmin : cd /tmp/ltsmin10295496652836680875;'/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' 'FamilyReunionCOLL00050M0005C002P002G001ReachabilityCardinality06==true'
SDD proceeding with computation,4 properties remain. new max is 16384
SDD size :491520 after 2.11093e+10
Detected timeout of ITS tools.
[2023-03-22 05:47:34] [INFO ] Applying decomposition
[2023-03-22 05:47:35] [INFO ] Flatten gal took : 531 ms
[2023-03-22 05:47:35] [INFO ] Decomposing Gal with order
[2023-03-22 05:47:36] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-22 05:47:39] [INFO ] Removed a total of 3084 redundant transitions.
[2023-03-22 05:47:39] [INFO ] Flatten gal took : 809 ms
[2023-03-22 05:47:39] [INFO ] Fuse similar labels procedure discarded/fused a total of 0 labels/synchronizations in 45 ms.
[2023-03-22 05:47:42] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality10790155818520500589.gal : 90 ms
[2023-03-22 05:47:42] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality14065613692874871579.prop : 6 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/ReachabilityCardinality10790155818520500589.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality14065613692874871579.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 ...330
Loading property file /tmp/ReachabilityCardinality14065613692874871579.prop.
WARNING : LTSmin timed out (>900 s) on command cd /tmp/ltsmin10295496652836680875;'/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' 'FamilyReunionCOLL00050M0005C002P002G001ReachabilityCardinality06==true'
Running LTSmin : cd /tmp/ltsmin10295496652836680875;'/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' 'FamilyReunionCOLL00050M0005C002P002G001ReachabilityCardinality07==true'
SDD proceeding with computation,4 properties remain. new max is 4
SDD size :1 after 4
SDD proceeding with computation,4 properties remain. new max is 8
SDD size :4 after 8
SDD proceeding with computation,4 properties remain. new max is 16
SDD size :8 after 20
SDD proceeding with computation,4 properties remain. new max is 32
SDD size :20 after 64
SDD proceeding with computation,4 properties remain. new max is 64
SDD size :64 after 512
SDD proceeding with computation,4 properties remain. new max is 128
SDD size :512 after 6016
SDD proceeding with computation,4 properties remain. new max is 256
SDD size :6016 after 11008
SDD proceeding with computation,4 properties remain. new max is 512
SDD size :11008 after 12930
SDD proceeding with computation,4 properties remain. new max is 1024
SDD size :12930 after 14080
SDD proceeding with computation,4 properties remain. new max is 2048
SDD size :14080 after 17920
SDD proceeding with computation,4 properties remain. new max is 4096
SDD size :17920 after 279200
SDD proceeding with computation,4 properties remain. new max is 8192
SDD size :279200 after 380000
SDD proceeding with computation,4 properties remain. new max is 16384
SDD size :380000 after 464480
SDD proceeding with computation,4 properties remain. new max is 32768
SDD size :464480 after 652160
SDD proceeding with computation,4 properties remain. new max is 65536
SDD size :652160 after 948384
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393216 kB
MemFree: 10771728 kB
After kill :
MemTotal: 16393216 kB
MemFree: 16194508 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="FamilyReunion-COL-L00050M0005C002P002G001"
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 FamilyReunion-COL-L00050M0005C002P002G001, 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 r165-tall-167838850200318"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/FamilyReunion-COL-L00050M0005C002P002G001.tgz
mv FamilyReunion-COL-L00050M0005C002P002G001 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 ;