Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2022-input.r078-tall-165260110600649.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/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 FamilyReunion-COL-L00200M0020C010P010G005, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r078-tall-165260110600649
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 372K
-rw-r--r-- 1 mcc users 6.7K Apr 30 13:21 CTLCardinality.txt
-rw-r--r-- 1 mcc users 70K Apr 30 13:21 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.7K Apr 30 10:52 CTLFireability.txt
-rw-r--r-- 1 mcc users 48K Apr 30 10:52 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 10 09:33 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 7.0K May 10 09:33 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.8K May 9 07:48 LTLCardinality.txt
-rw-r--r-- 1 mcc users 24K May 9 07:48 LTLCardinality.xml
-rw-r--r-- 1 mcc users 3.1K May 9 07:48 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K May 9 07:48 LTLFireability.xml
-rw-r--r-- 1 mcc users 2.0K May 9 07:48 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.0K May 9 07:48 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 10 09:33 equiv_pt
-rw-r--r-- 1 mcc users 24 May 10 09:33 instance
-rw-r--r-- 1 mcc users 5 May 10 09:33 iscolored
-rw-r--r-- 1 mcc users 146K May 10 09:33 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-L00200M0020C010P010G005-CTLCardinality-00
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-01
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-02
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-03
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-04
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-05
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-06
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-07
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-08
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-09
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-10
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-11
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-12
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-13
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-14
FORMULA_NAME FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-15

=== Now, execution of the tool begins

BK_START 1652706153731

Running Version 202205111006
[2022-05-16 13:02:34] [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-16 13:02:34] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-16 13:02:35] [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-16 13:02:35] [WARNING] Using fallBack plugin, rng conformance not checked
[2022-05-16 13:02:35] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 679 ms
[2022-05-16 13:02:35] [INFO ] Detected 5 constant HL places corresponding to 56 PT places.
[2022-05-16 13:02:35] [INFO ] Imported 104 HL places and 66 HL transitions for a total of 144109 PT places and 134480.0 transition bindings in 41 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 19 ms.
[2022-05-16 13:02:35] [INFO ] Built PT skeleton of HLPN with 104 places and 66 transitions 198 arcs in 8 ms.
[2022-05-16 13:02:35] [INFO ] Skeletonized 16 HLPN properties in 2 ms.
Computed a total of 104 stabilizing places and 66 stable transitions
Complete graph has no SCC; deadlocks are unavoidable. place count 104 transition count 66
Detected that all paths lead to deadlock. Applying this knowledge to assert that all AP eventually converge (and all enablings converge to false).
AF dead knowledge conclusive for 2 formulas.
FORMULA FamilyReunion-COL-L00200M0020C010P010G005-CTLCardinality-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Remains 15 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
Detected that all paths lead to deadlock. Applying this knowledge to assert that all AP eventually converge (and all enablings converge to false).
Incomplete random walk after 10102 steps, including 2 resets, run finished after 66 ms. (steps per millisecond=153 ) properties (out of 69) seen :20
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 32 ms. (steps per millisecond=31 ) properties (out of 49) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 24 ms. (steps per millisecond=41 ) properties (out of 49) 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 49) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 49) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 19 ms. (steps per millisecond=52 ) properties (out of 49) 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 49) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 49) 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 49) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 49) 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 49) seen :1
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 21 ms. (steps per millisecond=47 ) properties (out of 48) 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 48) 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 48) 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 48) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 48) 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 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 48) 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 48) 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 48) 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 48) 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 48) 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 48) 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 48) 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 48) 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 48) 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 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 48) 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 48) 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 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 19 ms. (steps per millisecond=52 ) properties (out of 48) 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 48) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 48) 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 48) 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 48) 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 48) 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 48) 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 48) 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 48) 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 48) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 48) seen :0
Incomplete Best-First random walk after 1000 steps, including 2 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 48) 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 48) 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 48) 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 48) 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 48) seen :0
Running SMT prover for 48 properties.
// Phase 1: matrix 66 rows 99 cols
[2022-05-16 13:02:36] [INFO ] Computed 33 place invariants in 14 ms
[2022-05-16 13:02:36] [INFO ] After 425ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:48
[2022-05-16 13:02:37] [INFO ] [Nat]Absence check using 4 positive place invariants in 3 ms returned sat
[2022-05-16 13:02:37] [INFO ] [Nat]Absence check using 4 positive and 29 generalized place invariants in 8 ms returned sat
[2022-05-16 13:02:37] [INFO ] After 253ms SMT Verify possible using state equation in natural domain returned unsat :6 sat :42
[2022-05-16 13:02:37] [INFO ] After 580ms SMT Verify possible using trap constraints in natural domain returned unsat :6 sat :42
Attempting to minimize the solution found.
Minimization took 204 ms.
[2022-05-16 13:02:38] [INFO ] After 1111ms SMT Verify possible using all constraints in natural domain returned unsat :6 sat :42
Fused 48 Parikh solutions to 41 different solutions.
Finished Parikh walk after 1537 steps, including 0 resets, run visited all 1 properties in 5 ms. (steps per millisecond=307 )
Parikh walk visited 42 properties in 2494 ms.
Successfully simplified 6 atomic propositions for a total of 15 simplifications.
[2022-05-16 13:02:40] [INFO ] Flatten gal took : 31 ms
[2022-05-16 13:02:40] [INFO ] Flatten gal took : 10 ms
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 11
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 :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 6
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
[2022-05-16 13:02:41] [INFO ] Unfolded HLPN to a Petri net with 128969 places and 110159 transitions 316597 arcs in 721 ms.
[2022-05-16 13:02:41] [INFO ] Unfolded 15 HLPN properties in 18 ms.
Deduced a syphon composed of 201 places in 414 ms
Reduce places removed 237 places and 0 transitions.
Support contains 108388 out of 128732 places. Attempting structural reductions.
Starting structural reductions in LTL mode, iteration 0 : 128732/128732 places, 110159/110159 transitions.
Reduce places removed 222 places and 0 transitions.
Discarding 8442 places :
Implicit places reduction removed 8442 places
Iterating post reduction 0 with 8664 rules applied. Total rules applied 8664 place count 120068 transition count 110159
Applied a total of 8664 rules in 7822 ms. Remains 120068 /128732 variables (removed 8664) and now considering 110159/110159 (removed 0) transitions.
// Phase 1: matrix 110159 rows 120068 cols
[2022-05-16 13:04:04] [INFO ] Computed 21929 place invariants in 73003 ms
[2022-05-16 13:04:14] [INFO ] Implicit Places using invariants in 82444 ms returned []
Implicit Place search using SMT only with invariants took 82451 ms to find 0 implicit places.
// Phase 1: matrix 110159 rows 120068 cols
[2022-05-16 13:05:23] [INFO ] Computed 21929 place invariants in 68674 ms
[2022-05-16 13:05:31] [INFO ] Dead Transitions using invariants and state equation in 77487 ms found 0 transitions.
Starting structural reductions in LTL mode, iteration 1 : 120068/128732 places, 110159/110159 transitions.
Finished structural reductions, in 1 iterations. Remains : 120068/128732 places, 110159/110159 transitions.
Support contains 108388 out of 120068 places after structural reductions.
[2022-05-16 13:05:36] [INFO ] Flatten gal took : 3645 ms
[2022-05-16 13:05:41] [INFO ] Flatten gal took : 3464 ms
[2022-05-16 13:05:51] [INFO ] Input system was already deterministic with 110159 transitions.
Incomplete random walk after 10000 steps, including 2 resets, run finished after 8622 ms. (steps per millisecond=1 ) properties (out of 70) seen :26
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 152 ms. (steps per millisecond=6 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 86 ms. (steps per millisecond=11 ) properties (out of 44) 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 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 270 ms. (steps per millisecond=3 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 98 ms. (steps per millisecond=10 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 161 ms. (steps per millisecond=6 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 20 ms. (steps per millisecond=50 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 85 ms. (steps per millisecond=11 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 30 ms. (steps per millisecond=33 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 43 ms. (steps per millisecond=23 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 89 ms. (steps per millisecond=11 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 311 ms. (steps per millisecond=3 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 27 ms. (steps per millisecond=37 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 115 ms. (steps per millisecond=8 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 30 ms. (steps per millisecond=33 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 23 ms. (steps per millisecond=43 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 174 ms. (steps per millisecond=5 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 32 ms. (steps per millisecond=31 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 142 ms. (steps per millisecond=7 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 32 ms. (steps per millisecond=31 ) properties (out of 44) 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 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 148 ms. (steps per millisecond=6 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 34 ms. (steps per millisecond=29 ) properties (out of 44) 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 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 125 ms. (steps per millisecond=8 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 24 ms. (steps per millisecond=41 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 27 ms. (steps per millisecond=37 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 19 ms. (steps per millisecond=52 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 29 ms. (steps per millisecond=34 ) properties (out of 44) 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 44) 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 44) 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 44) 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 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 85 ms. (steps per millisecond=11 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 27 ms. (steps per millisecond=37 ) properties (out of 44) 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 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 24 ms. (steps per millisecond=41 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 105 ms. (steps per millisecond=9 ) properties (out of 44) 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 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 44 ms. (steps per millisecond=22 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 24 ms. (steps per millisecond=41 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 78 ms. (steps per millisecond=12 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 104 ms. (steps per millisecond=9 ) properties (out of 44) seen :0
Incomplete Best-First random walk after 1001 steps, including 2 resets, run finished after 139 ms. (steps per millisecond=7 ) properties (out of 44) seen :0
Running SMT prover for 44 properties.
// Phase 1: matrix 110159 rows 120068 cols
[2022-05-16 13:07:09] [INFO ] Computed 21929 place invariants in 63778 ms
[2022-05-16 13:07:34] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2022-05-16 13:07:34] [INFO ] After 25066ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0
Fused 44 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 0 ms.
Support contains 64145 out of 120068 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 120068/120068 places, 110159/110159 transitions.
Graph (complete) has 176902 edges and 120068 vertex of which 119866 are kept as prefixes of interest. Removing 202 places using SCC suffix rule.183 ms
Discarding 202 places :
Also discarding 0 output transitions
Discarding 8442 places :
Implicit places reduction removed 8442 places
Performed 4221 Post agglomeration using F-continuation condition.Transition count delta: 4221
Iterating post reduction 0 with 12663 rules applied. Total rules applied 12664 place count 111424 transition count 105938
Reduce places removed 4221 places and 0 transitions.
Iterating post reduction 1 with 4221 rules applied. Total rules applied 16885 place count 107203 transition count 105938
Performed 804 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 804 Pre rules applied. Total rules applied 16885 place count 107203 transition count 105134
Deduced a syphon composed of 804 places in 159 ms
Reduce places removed 804 places and 0 transitions.
Iterating global reduction 2 with 1608 rules applied. Total rules applied 18493 place count 106399 transition count 105134
Applied a total of 18493 rules in 18809 ms. Remains 106399 /120068 variables (removed 13669) and now considering 105134/110159 (removed 5025) transitions.
Finished structural reductions, in 1 iterations. Remains : 106399/120068 places, 105134/110159 transitions.
[2022-05-16 13:07:57] [INFO ] Flatten gal took : 3351 ms
[2022-05-16 13:08:02] [INFO ] Flatten gal took : 3338 ms
[2022-05-16 13:08:11] [INFO ] Input system was already deterministic with 110159 transitions.
Computed a total of 120068 stabilizing places and 110159 stable transitions
Complete graph has no SCC; deadlocks are unavoidable. place count 120068 transition count 110159
Detected that all paths lead to deadlock. Applying this knowledge to assert that all AP eventually converge (and all enablings converge to false).
AF dead knowledge conclusive for 1 formulas.
Starting structural reductions in LTL mode, iteration 0 : 120068/120068 places, 110159/110159 transitions.
Reduce places removed 405 places and 0 transitions.
Discarding 9045 places :
Implicit places reduction removed 9045 places
Iterating post reduction 0 with 9450 rules applied. Total rules applied 9450 place count 110618 transition count 110159
Applied a total of 9450 rules in 3803 ms. Remains 110618 /120068 variables (removed 9450) and now considering 110159/110159 (removed 0) transitions.
// Phase 1: matrix 110159 rows 110618 cols
[2022-05-16 13:09:21] [INFO ] Computed 12680 place invariants in 65994 ms
[2022-05-16 13:09:29] [INFO ] SMT solver returned unknown. Retrying;
[2022-05-16 13:09:30] [INFO ] Implicit Places using invariants in 74165 ms returned []
Implicit Place search using SMT only with invariants took 74167 ms to find 0 implicit places.
// Phase 1: matrix 110159 rows 110618 cols
[2022-05-16 13:10:24] [INFO ] Computed 12680 place invariants in 54394 ms
[2022-05-16 13:10:32] [INFO ] SMT solver returned unknown. Retrying;
[2022-05-16 13:10:32] [INFO ] Dead Transitions using invariants and state equation in 62519 ms found 0 transitions.
Starting structural reductions in LTL mode, iteration 1 : 110618/120068 places, 110159/110159 transitions.
Finished structural reductions, in 1 iterations. Remains : 110618/120068 places, 110159/110159 transitions.
[2022-05-16 13:10:36] [INFO ] Flatten gal took : 2840 ms
[2022-05-16 13:10:39] [INFO ] Flatten gal took : 2998 ms
[2022-05-16 13:10:44] [INFO ] Input system was already deterministic with 110159 transitions.
[2022-05-16 13:10:48] [INFO ] Flatten gal took : 3492 ms
[2022-05-16 13:10:52] [INFO ] Flatten gal took : 3601 ms
[2022-05-16 13:10:53] [INFO ] Time to serialize gal into /tmp/CTLCardinality13604353490728631859.gal : 437 ms
[2022-05-16 13:10:53] [INFO ] Time to serialize properties into /tmp/CTLCardinality7781671411693010717.ctl : 55 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/CTLCardinality13604353490728631859.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality7781671411693010717.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-16 13:11:27] [INFO ] Flatten gal took : 2973 ms
[2022-05-16 13:11:27] [INFO ] Applying decomposition
[2022-05-16 13:11:30] [INFO ] Flatten gal took : 3037 ms
Louvain graph construction failed due to OOM.
[2022-05-16 13:12:16] [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-16 13:12:19] [INFO ] Flatten gal took : 2940 ms
[2022-05-16 13:12:20] [INFO ] Time to serialize gal into /tmp/CTLCardinality16126277207761124088.gal : 305 ms
[2022-05-16 13:12:20] [INFO ] Time to serialize properties into /tmp/CTLCardinality16248948285740037953.ctl : 24 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/CTLCardinality16126277207761124088.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality16248948285740037953.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...276
Detected timeout of ITS tools.
Starting structural reductions in LTL mode, iteration 0 : 120068/120068 places, 110159/110159 transitions.
Reduce places removed 427 places and 0 transitions.
Discarding 17085 places :
Implicit places reduction removed 17085 places
Iterating post reduction 0 with 17512 rules applied. Total rules applied 17512 place count 102556 transition count 110159
Applied a total of 17512 rules in 3677 ms. Remains 102556 /120068 variables (removed 17512) and now considering 110159/110159 (removed 0) transitions.
// Phase 1: matrix 110159 rows 102556 cols
[2022-05-16 13:13:16] [INFO ] Computed 4628 place invariants in 22193 ms
[2022-05-16 13:13:24] [INFO ] SMT solver returned unknown. Retrying;
[2022-05-16 13:13:24] [INFO ] Implicit Places using invariants in 30141 ms returned []
Implicit Place search using SMT only with invariants took 30143 ms to find 0 implicit places.
// Phase 1: matrix 110159 rows 102556 cols
[2022-05-16 13:13:47] [INFO ] Computed 4628 place invariants in 23446 ms
[2022-05-16 13:13:55] [INFO ] SMT solver returned unknown. Retrying;
[2022-05-16 13:13:55] [INFO ] Dead Transitions using invariants and state equation in 31186 ms found 0 transitions.
Starting structural reductions in LTL mode, iteration 1 : 102556/120068 places, 110159/110159 transitions.
Finished structural reductions, in 1 iterations. Remains : 102556/120068 places, 110159/110159 transitions.
[2022-05-16 13:13:58] [INFO ] Flatten gal took : 2765 ms
[2022-05-16 13:14:01] [INFO ] Flatten gal took : 2817 ms
[2022-05-16 13:14:07] [INFO ] Input system was already deterministic with 110159 transitions.
[2022-05-16 13:14:11] [INFO ] Flatten gal took : 3329 ms
[2022-05-16 13:14:14] [INFO ] Flatten gal took : 3170 ms
[2022-05-16 13:14:15] [INFO ] Time to serialize gal into /tmp/CTLCardinality8317704821110943951.gal : 484 ms
[2022-05-16 13:14:15] [INFO ] Time to serialize properties into /tmp/CTLCardinality18111674052905386000.ctl : 2 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/CTLCardinality8317704821110943951.gal' '-t' 'CGAL' '-ctl' '/tmp/CTLCardinality18111674052905386000.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-16 13:14:49] [INFO ] Flatten gal took : 3107 ms
[2022-05-16 13:14:49] [INFO ] Applying decomposition
[2022-05-16 13:14:52] [INFO ] Flatten gal took : 2985 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202205111006/bin/convert-linux64' '-i' '/tmp/graph17594768333385027449.txt' '-o' '/tmp/graph17594768333385027449.bin' '-w' '/tmp/graph17594768333385027449.weights'
Built communities with : '/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202205111006/bin/louvain-linux64' '/tmp/graph17594768333385027449.bin' '-l' '-1' '-v' '-w' '/tmp/graph17594768333385027449.weights' '-q' '0' '-e' '0.001'
[2022-05-16 13:15:09] [INFO ] Decomposing Gal with order
[2022-05-16 13:17:28] [INFO ] Rewriting arrays to variables to allow decomposition.

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="FamilyReunion-COL-L00200M0020C010P010G005"
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 FamilyReunion-COL-L00200M0020C010P010G005, 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 r078-tall-165260110600649"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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