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.r121-smll-165264480700118.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 HealthRecord-PT-15, examination is StableMarking
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r121-smll-165264480700118
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 288K
-rw-r--r-- 1 mcc users 6.1K Apr 30 11:06 CTLCardinality.txt
-rw-r--r-- 1 mcc users 64K Apr 30 11:06 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.0K Apr 30 11:04 CTLFireability.txt
-rw-r--r-- 1 mcc users 55K Apr 30 11:04 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.9K May 9 08:00 LTLCardinality.txt
-rw-r--r-- 1 mcc users 30K May 9 08:00 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K May 9 08:00 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K May 9 08:00 LTLFireability.xml
-rw-r--r-- 1 mcc users 1.6K May 9 08:00 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K May 9 08:00 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 10 09:34 equiv_col
-rw-r--r-- 1 mcc users 3 May 10 09:34 instance
-rw-r--r-- 1 mcc users 6 May 10 09:34 iscolored
-rw-r--r-- 1 mcc users 73K May 10 09:34 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

FORMULA_NAME StableMarking

=== Now, execution of the tool begins

BK_START 1652723672684

Running Version 202205111006
[2022-05-16 17:54:34] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, StableMarking, -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, 1800]
[2022-05-16 17:54:34] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-16 17:54:35] [INFO ] Load time of PNML (sax parser for PT used): 184 ms
[2022-05-16 17:54:35] [INFO ] Transformed 163 places.
[2022-05-16 17:54:35] [INFO ] Transformed 348 transitions.
[2022-05-16 17:54:35] [INFO ] Found NUPN structural information;
[2022-05-16 17:54:35] [INFO ] Parsed PT model containing 163 places and 348 transitions in 401 ms.
Graph (trivial) has 278 edges and 163 vertex of which 6 / 163 are part of one of the 3 SCC in 8 ms
Free SCC test removed 3 places
Structural test allowed to assert that 28 places are NOT stable. Took 24 ms.
Ensure Unique test removed 32 transitions
Reduce redundant transitions removed 32 transitions.
Incomplete random walk after 10000 steps, including 915 resets, run finished after 892 ms. (steps per millisecond=11 ) properties (out of 135) seen :38
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 97) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 97) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 97) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 97) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 97) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 4 ms. (steps per millisecond=250 ) properties (out of 97) seen :2
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 95) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 4 ms. (steps per millisecond=250 ) properties (out of 95) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 95) seen :2
Incomplete Best-First random walk after 1001 steps, including 9 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 93) seen :1
Incomplete Best-First random walk after 1000 steps, including 11 resets, run finished after 13 ms. (steps per millisecond=76 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 11 ms. (steps per millisecond=91 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 92) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 92) seen :2
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 14 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 3 ms. (steps per millisecond=333 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1000 steps, including 13 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1000 steps, including 10 resets, run finished after 7 ms. (steps per millisecond=142 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 16 ms. (steps per millisecond=62 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 14 ms. (steps per millisecond=71 ) properties (out of 90) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 90) seen :2
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 12 ms. (steps per millisecond=83 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1000 steps, including 14 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 5 ms. (steps per millisecond=200 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1000 steps, including 12 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1000 steps, including 13 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1000 steps, including 12 resets, run finished after 4 ms. (steps per millisecond=250 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 4 ms. (steps per millisecond=250 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 15 ms. (steps per millisecond=66 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1000 steps, including 10 resets, run finished after 7 ms. (steps per millisecond=142 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1000 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=142 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 6 ms. (steps per millisecond=166 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 8 ms. (steps per millisecond=125 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 21 ms. (steps per millisecond=47 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 10 ms. (steps per millisecond=100 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 9 ms. (steps per millisecond=111 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 13 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 11 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :0
Incomplete Best-First random walk after 1001 steps, including 10 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 88) seen :2
Incomplete Best-First random walk after 1001 steps, including 12 resets, run finished after 7 ms. (steps per millisecond=143 ) properties (out of 86) seen :0
Running SMT prover for 86 properties.
[2022-05-16 17:54:37] [INFO ] Flow matrix only has 301 transitions (discarded 15 similar events)
// Phase 1: matrix 301 rows 160 cols
[2022-05-16 17:54:37] [INFO ] Computed 18 place invariants in 39 ms
[2022-05-16 17:54:38] [INFO ] After 1108ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:86
[2022-05-16 17:54:38] [INFO ] [Nat]Absence check using 10 positive place invariants in 33 ms returned sat
[2022-05-16 17:54:38] [INFO ] [Nat]Absence check using 10 positive and 8 generalized place invariants in 14 ms returned sat
[2022-05-16 17:54:40] [INFO ] After 1267ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :86
[2022-05-16 17:54:40] [INFO ] State equation strengthened by 1 read => feed constraints.
[2022-05-16 17:54:41] [INFO ] After 1011ms SMT Verify possible using 1 Read/Feed constraints in natural domain returned unsat :0 sat :86
[2022-05-16 17:54:41] [INFO ] Deduced a trap composed of 38 places in 80 ms of which 7 ms to minimize.
[2022-05-16 17:54:41] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 131 ms
[2022-05-16 17:54:43] [INFO ] Deduced a trap composed of 38 places in 87 ms of which 2 ms to minimize.
[2022-05-16 17:54:43] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 111 ms
[2022-05-16 17:54:43] [INFO ] After 2931ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :86
Attempting to minimize the solution found.
Minimization took 1100 ms.
[2022-05-16 17:54:44] [INFO ] After 6399ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :86
Fused 86 Parikh solutions to 69 different solutions.
Parikh walk visited 1 properties in 1401 ms.
Support contains 85 out of 160 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 160/160 places, 316/316 transitions.
Drop transitions removed 16 transitions
Reduce isomorphic transitions removed 16 transitions.
Iterating post reduction 0 with 16 rules applied. Total rules applied 16 place count 160 transition count 300
Discarding 29 places :
Symmetric choice reduction at 1 with 29 rule applications. Total rules 45 place count 131 transition count 242
Iterating global reduction 1 with 29 rules applied. Total rules applied 74 place count 131 transition count 242
Discarding 1 places :
Symmetric choice reduction at 1 with 1 rule applications. Total rules 75 place count 130 transition count 240
Iterating global reduction 1 with 1 rules applied. Total rules applied 76 place count 130 transition count 240
Performed 7 Post agglomeration using F-continuation condition.Transition count delta: -24
Deduced a syphon composed of 7 places in 0 ms
Reduce places removed 7 places and 0 transitions.
Iterating global reduction 1 with 14 rules applied. Total rules applied 90 place count 123 transition count 264
Drop transitions removed 3 transitions
Redundant transition composition rules discarded 3 transitions
Iterating global reduction 1 with 3 rules applied. Total rules applied 93 place count 123 transition count 261
Free-agglomeration rule applied 2 times.
Iterating global reduction 1 with 2 rules applied. Total rules applied 95 place count 123 transition count 259
Reduce places removed 2 places and 0 transitions.
Iterating post reduction 1 with 2 rules applied. Total rules applied 97 place count 121 transition count 259
Partial Free-agglomeration rule applied 1 times.
Drop transitions removed 1 transitions
Iterating global reduction 2 with 1 rules applied. Total rules applied 98 place count 121 transition count 259
Applied a total of 98 rules in 95 ms. Remains 121 /160 variables (removed 39) and now considering 259/316 (removed 57) transitions.
Finished structural reductions, in 1 iterations. Remains : 121/160 places, 259/316 transitions.
Interrupted random walk after 699861 steps, including 126883 resets, run timeout after 30001 ms. (steps per millisecond=23 ) properties seen 47
Incomplete Best-First random walk after 100001 steps, including 2771 resets, run finished after 658 ms. (steps per millisecond=151 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2733 resets, run finished after 608 ms. (steps per millisecond=164 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2770 resets, run finished after 597 ms. (steps per millisecond=167 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2743 resets, run finished after 607 ms. (steps per millisecond=164 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2748 resets, run finished after 618 ms. (steps per millisecond=161 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2718 resets, run finished after 616 ms. (steps per millisecond=162 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2757 resets, run finished after 610 ms. (steps per millisecond=163 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 2709 resets, run finished after 724 ms. (steps per millisecond=138 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2740 resets, run finished after 687 ms. (steps per millisecond=145 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2752 resets, run finished after 591 ms. (steps per millisecond=169 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2765 resets, run finished after 717 ms. (steps per millisecond=139 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2767 resets, run finished after 581 ms. (steps per millisecond=172 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2741 resets, run finished after 630 ms. (steps per millisecond=158 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2747 resets, run finished after 835 ms. (steps per millisecond=119 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2763 resets, run finished after 590 ms. (steps per millisecond=169 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2695 resets, run finished after 570 ms. (steps per millisecond=175 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2746 resets, run finished after 438 ms. (steps per millisecond=228 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2735 resets, run finished after 595 ms. (steps per millisecond=168 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2741 resets, run finished after 636 ms. (steps per millisecond=157 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2765 resets, run finished after 547 ms. (steps per millisecond=182 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2738 resets, run finished after 615 ms. (steps per millisecond=162 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 2721 resets, run finished after 526 ms. (steps per millisecond=190 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2713 resets, run finished after 531 ms. (steps per millisecond=188 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2735 resets, run finished after 549 ms. (steps per millisecond=182 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2747 resets, run finished after 609 ms. (steps per millisecond=164 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2739 resets, run finished after 612 ms. (steps per millisecond=163 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2787 resets, run finished after 597 ms. (steps per millisecond=167 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2736 resets, run finished after 644 ms. (steps per millisecond=155 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 2771 resets, run finished after 640 ms. (steps per millisecond=156 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2740 resets, run finished after 639 ms. (steps per millisecond=156 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 2775 resets, run finished after 628 ms. (steps per millisecond=159 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 2786 resets, run finished after 649 ms. (steps per millisecond=154 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2773 resets, run finished after 649 ms. (steps per millisecond=154 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2734 resets, run finished after 634 ms. (steps per millisecond=157 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2746 resets, run finished after 668 ms. (steps per millisecond=149 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2751 resets, run finished after 623 ms. (steps per millisecond=160 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 2770 resets, run finished after 623 ms. (steps per millisecond=160 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 2762 resets, run finished after 587 ms. (steps per millisecond=170 ) properties (out of 38) seen :0
Running SMT prover for 38 properties.
[2022-05-16 17:55:39] [INFO ] Flow matrix only has 245 transitions (discarded 14 similar events)
// Phase 1: matrix 245 rows 121 cols
[2022-05-16 17:55:39] [INFO ] Computed 18 place invariants in 5 ms
[2022-05-16 17:55:39] [INFO ] After 220ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:38
[2022-05-16 17:55:40] [INFO ] [Nat]Absence check using 10 positive place invariants in 10 ms returned sat
[2022-05-16 17:55:40] [INFO ] [Nat]Absence check using 10 positive and 8 generalized place invariants in 11 ms returned sat
[2022-05-16 17:55:40] [INFO ] After 620ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :38
[2022-05-16 17:55:40] [INFO ] State equation strengthened by 9 read => feed constraints.
[2022-05-16 17:55:41] [INFO ] After 384ms SMT Verify possible using 9 Read/Feed constraints in natural domain returned unsat :0 sat :38
[2022-05-16 17:55:41] [INFO ] Deduced a trap composed of 34 places in 74 ms of which 3 ms to minimize.
[2022-05-16 17:55:41] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 94 ms
[2022-05-16 17:55:42] [INFO ] After 1078ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :38
Attempting to minimize the solution found.
Minimization took 395 ms.
[2022-05-16 17:55:42] [INFO ] After 2444ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :38
Fused 38 Parikh solutions to 21 different solutions.
Parikh walk visited 0 properties in 8 ms.
Support contains 38 out of 121 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 121/121 places, 259/259 transitions.
Graph (complete) has 594 edges and 121 vertex of which 112 are kept as prefixes of interest. Removing 9 places using SCC suffix rule.7 ms
Discarding 9 places :
Also discarding 0 output transitions
Drop transitions removed 4 transitions
Trivial Post-agglo rules discarded 4 transitions
Performed 4 trivial Post agglomeration. Transition count delta: 4
Iterating post reduction 0 with 4 rules applied. Total rules applied 5 place count 112 transition count 255
Reduce places removed 4 places and 0 transitions.
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 1 with 5 rules applied. Total rules applied 10 place count 108 transition count 254
Discarding 24 places :
Symmetric choice reduction at 2 with 24 rule applications. Total rules 34 place count 84 transition count 206
Iterating global reduction 2 with 24 rules applied. Total rules applied 58 place count 84 transition count 206
Discarding 3 places :
Symmetric choice reduction at 2 with 3 rule applications. Total rules 61 place count 81 transition count 200
Iterating global reduction 2 with 3 rules applied. Total rules applied 64 place count 81 transition count 200
Ensure Unique test removed 9 transitions
Reduce isomorphic transitions removed 9 transitions.
Iterating post reduction 2 with 9 rules applied. Total rules applied 73 place count 81 transition count 191
Performed 4 Post agglomeration using F-continuation condition.Transition count delta: -8
Deduced a syphon composed of 4 places in 0 ms
Reduce places removed 4 places and 0 transitions.
Iterating global reduction 3 with 8 rules applied. Total rules applied 81 place count 77 transition count 199
Ensure Unique test removed 4 transitions
Reduce isomorphic transitions removed 4 transitions.
Iterating post reduction 3 with 4 rules applied. Total rules applied 85 place count 77 transition count 195
Partial Free-agglomeration rule applied 16 times.
Drop transitions removed 16 transitions
Iterating global reduction 4 with 16 rules applied. Total rules applied 101 place count 77 transition count 195
Partial Free-agglomeration rule applied 15 times.
Drop transitions removed 15 transitions
Iterating global reduction 4 with 15 rules applied. Total rules applied 116 place count 77 transition count 195
Applied a total of 116 rules in 51 ms. Remains 77 /121 variables (removed 44) and now considering 195/259 (removed 64) transitions.
Finished structural reductions, in 1 iterations. Remains : 77/121 places, 195/259 transitions.
Interrupted random walk after 692021 steps, including 55485 resets, run timeout after 30001 ms. (steps per millisecond=23 ) properties seen 23
Incomplete Best-First random walk after 100001 steps, including 1340 resets, run finished after 768 ms. (steps per millisecond=130 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1396 resets, run finished after 706 ms. (steps per millisecond=141 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1362 resets, run finished after 700 ms. (steps per millisecond=142 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1338 resets, run finished after 842 ms. (steps per millisecond=118 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1302 resets, run finished after 680 ms. (steps per millisecond=147 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1366 resets, run finished after 759 ms. (steps per millisecond=131 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1328 resets, run finished after 580 ms. (steps per millisecond=172 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100001 steps, including 1345 resets, run finished after 575 ms. (steps per millisecond=173 ) properties (out of 15) seen :0
Incomplete Best-First random walk after 100000 steps, including 1341 resets, run finished after 522 ms. (steps per millisecond=191 ) properties (out of 15) seen :2
Incomplete Best-First random walk after 100000 steps, including 1382 resets, run finished after 524 ms. (steps per millisecond=190 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 100001 steps, including 1313 resets, run finished after 588 ms. (steps per millisecond=170 ) properties (out of 13) seen :4
Incomplete Best-First random walk after 100000 steps, including 1339 resets, run finished after 497 ms. (steps per millisecond=201 ) properties (out of 9) seen :0
Incomplete Best-First random walk after 100001 steps, including 1374 resets, run finished after 522 ms. (steps per millisecond=191 ) properties (out of 9) seen :0
Running SMT prover for 9 properties.
[2022-05-16 17:56:20] [INFO ] Flow matrix only has 173 transitions (discarded 22 similar events)
// Phase 1: matrix 173 rows 77 cols
[2022-05-16 17:56:20] [INFO ] Computed 9 place invariants in 4 ms
[2022-05-16 17:56:20] [INFO ] After 61ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:9
[2022-05-16 17:56:20] [INFO ] [Nat]Absence check using 1 positive place invariants in 1 ms returned sat
[2022-05-16 17:56:20] [INFO ] [Nat]Absence check using 1 positive and 8 generalized place invariants in 6 ms returned sat
[2022-05-16 17:56:21] [INFO ] After 219ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :9
[2022-05-16 17:56:21] [INFO ] State equation strengthened by 13 read => feed constraints.
[2022-05-16 17:56:21] [INFO ] After 117ms SMT Verify possible using 13 Read/Feed constraints in natural domain returned unsat :0 sat :9
[2022-05-16 17:56:21] [INFO ] After 291ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :9
Attempting to minimize the solution found.
Minimization took 111 ms.
[2022-05-16 17:56:21] [INFO ] After 715ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :9
Fused 9 Parikh solutions to 6 different solutions.
Parikh walk visited 0 properties in 1077 ms.
Support contains 9 out of 77 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 77/77 places, 195/195 transitions.
Discarding 18 places :
Symmetric choice reduction at 0 with 18 rule applications. Total rules 18 place count 59 transition count 159
Iterating global reduction 0 with 18 rules applied. Total rules applied 36 place count 59 transition count 159
Discarding 1 places :
Symmetric choice reduction at 0 with 1 rule applications. Total rules 37 place count 58 transition count 157
Iterating global reduction 0 with 1 rules applied. Total rules applied 38 place count 58 transition count 157
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 1 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 0 with 2 rules applied. Total rules applied 40 place count 57 transition count 156
Performed 3 Post agglomeration using F-continuation condition.Transition count delta: -21
Deduced a syphon composed of 3 places in 1 ms
Reduce places removed 3 places and 0 transitions.
Iterating global reduction 0 with 6 rules applied. Total rules applied 46 place count 54 transition count 177
Drop transitions removed 1 transitions
Redundant transition composition rules discarded 1 transitions
Iterating global reduction 0 with 1 rules applied. Total rules applied 47 place count 54 transition count 176
Partial Free-agglomeration rule applied 5 times.
Drop transitions removed 5 transitions
Iterating global reduction 0 with 5 rules applied. Total rules applied 52 place count 54 transition count 176
Applied a total of 52 rules in 40 ms. Remains 54 /77 variables (removed 23) and now considering 176/195 (removed 19) transitions.
Finished structural reductions, in 1 iterations. Remains : 54/77 places, 176/195 transitions.
Incomplete random walk after 1000000 steps, including 80265 resets, run finished after 18357 ms. (steps per millisecond=54 ) properties (out of 9) seen :6
Incomplete Best-First random walk after 1000001 steps, including 13448 resets, run finished after 2886 ms. (steps per millisecond=346 ) properties (out of 3) seen :0
Incomplete Best-First random walk after 1000001 steps, including 13547 resets, run finished after 2905 ms. (steps per millisecond=344 ) properties (out of 3) seen :0
Incomplete Best-First random walk after 1000001 steps, including 13514 resets, run finished after 2988 ms. (steps per millisecond=334 ) properties (out of 3) seen :0
Running SMT prover for 3 properties.
[2022-05-16 17:56:49] [INFO ] Flow matrix only has 154 transitions (discarded 22 similar events)
// Phase 1: matrix 154 rows 54 cols
[2022-05-16 17:56:49] [INFO ] Computed 9 place invariants in 3 ms
[2022-05-16 17:56:49] [INFO ] After 35ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:3
[2022-05-16 17:56:49] [INFO ] [Nat]Absence check using 1 positive place invariants in 1 ms returned sat
[2022-05-16 17:56:49] [INFO ] [Nat]Absence check using 1 positive and 8 generalized place invariants in 6 ms returned sat
[2022-05-16 17:56:49] [INFO ] After 71ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :3
[2022-05-16 17:56:49] [INFO ] State equation strengthened by 38 read => feed constraints.
[2022-05-16 17:56:50] [INFO ] After 31ms SMT Verify possible using 38 Read/Feed constraints in natural domain returned unsat :0 sat :3
[2022-05-16 17:56:50] [INFO ] After 62ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :3
Attempting to minimize the solution found.
Minimization took 22 ms.
[2022-05-16 17:56:50] [INFO ] After 213ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :3
Parikh walk visited 0 properties in 100 ms.
Support contains 3 out of 54 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 54/54 places, 176/176 transitions.
Discarding 4 places :
Symmetric choice reduction at 0 with 4 rule applications. Total rules 4 place count 50 transition count 168
Iterating global reduction 0 with 4 rules applied. Total rules applied 8 place count 50 transition count 168
Discarding 2 places :
Symmetric choice reduction at 0 with 2 rule applications. Total rules 10 place count 48 transition count 164
Iterating global reduction 0 with 2 rules applied. Total rules applied 12 place count 48 transition count 164
Discarding 2 places :
Symmetric choice reduction at 0 with 2 rule applications. Total rules 14 place count 46 transition count 152
Iterating global reduction 0 with 2 rules applied. Total rules applied 16 place count 46 transition count 152
Discarding 2 places :
Symmetric choice reduction at 0 with 2 rule applications. Total rules 18 place count 44 transition count 146
Iterating global reduction 0 with 2 rules applied. Total rules applied 20 place count 44 transition count 146
Ensure Unique test removed 12 transitions
Reduce isomorphic transitions removed 12 transitions.
Iterating post reduction 0 with 12 rules applied. Total rules applied 32 place count 44 transition count 134
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 1 with 2 rules applied. Total rules applied 34 place count 43 transition count 133
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 0
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 1 with 2 rules applied. Total rules applied 36 place count 42 transition count 133
Applied a total of 36 rules in 19 ms. Remains 42 /54 variables (removed 12) and now considering 133/176 (removed 43) transitions.
Finished structural reductions, in 1 iterations. Remains : 42/54 places, 133/176 transitions.
Incomplete random walk after 1000000 steps, including 80256 resets, run finished after 14232 ms. (steps per millisecond=70 ) properties (out of 3) seen :0
Incomplete Best-First random walk after 1000000 steps, including 14112 resets, run finished after 2897 ms. (steps per millisecond=345 ) properties (out of 3) seen :0
Incomplete Best-First random walk after 1000001 steps, including 14151 resets, run finished after 2951 ms. (steps per millisecond=338 ) properties (out of 3) seen :0
Incomplete Best-First random walk after 1000001 steps, including 14141 resets, run finished after 2916 ms. (steps per millisecond=342 ) properties (out of 3) seen :0
Finished probabilistic random walk after 11446 steps, run visited all 3 properties in 97 ms. (steps per millisecond=118 )
Probabilistic random walk after 11446 steps, saw 3796 distinct states, run finished after 97 ms. (steps per millisecond=118 ) properties seen :3
Able to resolve query StableMarking after proving 137 properties.
FORMULA StableMarking FALSE TECHNIQUES RANDOM_WALK PARIKH_WALK PROBABILISTIC_WALK MARKED_SUFFIX_TEST TRIVIAL_UNMARKED_SCC_TEST BESTFIRST_WALK TOPOLOGICAL
Total runtime 158405 ms.

BK_STOP 1652723833357

--------------------
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
+ [[ StableMarking = StateSpace ]]
+ /home/mcc/BenchKit/bin//..//runeclipse.sh /home/mcc/execution StableMarking -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ 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
++ perl -pe 's/.*\.//g'
++ sed s/.jar//
++ 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 StableMarking -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 1800 -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="HealthRecord-PT-15"
export BK_EXAMINATION="StableMarking"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
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 HealthRecord-PT-15, examination is StableMarking"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r121-smll-165264480700118"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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