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

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 380K
-rw-r--r-- 1 mcc users 7.7K Apr 30 11:28 CTLCardinality.txt
-rw-r--r-- 1 mcc users 88K Apr 30 11:28 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.9K Apr 30 11:27 CTLFireability.txt
-rw-r--r-- 1 mcc users 30K Apr 30 11:27 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.4K May 9 08:00 LTLCardinality.txt
-rw-r--r-- 1 mcc users 23K 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 17K 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 175K 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 1652723936957

Running Version 202205111006
[2022-05-16 17:58:59] [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:58:59] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2022-05-16 17:59:00] [INFO ] Load time of PNML (sax parser for PT used): 278 ms
[2022-05-16 17:59:00] [INFO ] Transformed 624 places.
[2022-05-16 17:59:00] [INFO ] Transformed 828 transitions.
[2022-05-16 17:59:00] [INFO ] Found NUPN structural information;
[2022-05-16 17:59:00] [INFO ] Parsed PT model containing 624 places and 828 transitions in 533 ms.
Graph (trivial) has 749 edges and 624 vertex of which 87 / 624 are part of one of the 21 SCC in 11 ms
Free SCC test removed 66 places
Structural test allowed to assert that 266 places are NOT stable. Took 25 ms.
Ensure Unique test removed 75 transitions
Reduce redundant transitions removed 75 transitions.
Incomplete random walk after 10000 steps, including 91 resets, run finished after 1293 ms. (steps per millisecond=7 ) properties (out of 358) seen :47
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 8 ms. (steps per millisecond=12 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 100 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 5 ms. (steps per millisecond=20 ) properties (out of 311) seen :0
Running SMT prover for 311 properties.
[2022-05-16 17:59:01] [INFO ] Flow matrix only has 733 transitions (discarded 20 similar events)
// Phase 1: matrix 733 rows 558 cols
[2022-05-16 17:59:01] [INFO ] Computed 18 place invariants in 37 ms
[2022-05-16 17:59:07] [INFO ] After 5448ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:311
[2022-05-16 17:59:11] [INFO ] [Nat]Absence check using 10 positive place invariants in 43 ms returned sat
[2022-05-16 17:59:11] [INFO ] [Nat]Absence check using 10 positive and 8 generalized place invariants in 20 ms returned sat
[2022-05-16 17:59:24] [INFO ] After 9540ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :311
[2022-05-16 17:59:24] [INFO ] State equation strengthened by 1 read => feed constraints.
[2022-05-16 17:59:32] [INFO ] After 8129ms SMT Verify possible using 1 Read/Feed constraints in natural domain returned unsat :0 sat :311
[2022-05-16 17:59:32] [INFO ] After 8133ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :311
Attempting to minimize the solution found.
Minimization took 1 ms.
[2022-05-16 17:59:32] [INFO ] After 25018ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :311
Fused 311 Parikh solutions to 306 different solutions.
Parikh walk visited 20 properties in 4160 ms.
Support contains 291 out of 558 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 558/558 places, 753/753 transitions.
Drop transitions removed 21 transitions
Reduce isomorphic transitions removed 21 transitions.
Drop transitions removed 146 transitions
Trivial Post-agglo rules discarded 146 transitions
Performed 146 trivial Post agglomeration. Transition count delta: 146
Iterating post reduction 0 with 167 rules applied. Total rules applied 167 place count 558 transition count 586
Reduce places removed 146 places and 0 transitions.
Ensure Unique test removed 8 transitions
Reduce isomorphic transitions removed 8 transitions.
Drop transitions removed 9 transitions
Trivial Post-agglo rules discarded 9 transitions
Performed 9 trivial Post agglomeration. Transition count delta: 9
Iterating post reduction 1 with 163 rules applied. Total rules applied 330 place count 412 transition count 569
Reduce places removed 9 places and 0 transitions.
Iterating post reduction 2 with 9 rules applied. Total rules applied 339 place count 403 transition count 569
Performed 10 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 10 Pre rules applied. Total rules applied 339 place count 403 transition count 559
Deduced a syphon composed of 10 places in 2 ms
Reduce places removed 10 places and 0 transitions.
Iterating global reduction 3 with 20 rules applied. Total rules applied 359 place count 393 transition count 559
Discarding 6 places :
Symmetric choice reduction at 3 with 6 rule applications. Total rules 365 place count 387 transition count 547
Iterating global reduction 3 with 6 rules applied. Total rules applied 371 place count 387 transition count 547
Performed 18 Post agglomeration using F-continuation condition.Transition count delta: 18
Deduced a syphon composed of 18 places in 1 ms
Reduce places removed 18 places and 0 transitions.
Iterating global reduction 3 with 36 rules applied. Total rules applied 407 place count 369 transition count 529
Performed 8 Post agglomeration using F-continuation condition with reduction of 6 identical transitions.
Deduced a syphon composed of 8 places in 1 ms
Reduce places removed 8 places and 0 transitions.
Iterating global reduction 3 with 16 rules applied. Total rules applied 423 place count 361 transition count 566
Ensure Unique test removed 4 transitions
Reduce isomorphic transitions removed 4 transitions.
Iterating post reduction 3 with 4 rules applied. Total rules applied 427 place count 361 transition count 562
Drop transitions removed 19 transitions
Redundant transition composition rules discarded 19 transitions
Iterating global reduction 4 with 19 rules applied. Total rules applied 446 place count 361 transition count 543
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: -11
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 4 with 2 rules applied. Total rules applied 448 place count 360 transition count 554
Free-agglomeration rule applied 24 times.
Iterating global reduction 4 with 24 rules applied. Total rules applied 472 place count 360 transition count 530
Reduce places removed 24 places and 0 transitions.
Iterating post reduction 4 with 24 rules applied. Total rules applied 496 place count 336 transition count 530
Free-agglomeration rule (complex) applied 1 times.
Iterating global reduction 5 with 1 rules applied. Total rules applied 497 place count 336 transition count 533
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 5 with 1 rules applied. Total rules applied 498 place count 335 transition count 533
Partial Free-agglomeration rule applied 6 times.
Drop transitions removed 6 transitions
Iterating global reduction 6 with 6 rules applied. Total rules applied 504 place count 335 transition count 533
Partial Post-agglomeration rule applied 1 times.
Drop transitions removed 1 transitions
Iterating global reduction 6 with 1 rules applied. Total rules applied 505 place count 335 transition count 533
Applied a total of 505 rules in 193 ms. Remains 335 /558 variables (removed 223) and now considering 533/753 (removed 220) transitions.
Finished structural reductions, in 1 iterations. Remains : 335/558 places, 533/753 transitions.
Interrupted random walk after 504555 steps, including 62296 resets, run timeout after 30001 ms. (steps per millisecond=16 ) properties seen 151
Incomplete Best-First random walk after 10001 steps, including 140 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 151 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 144 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 138 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 147 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 150 resets, run finished after 68 ms. (steps per millisecond=147 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 139 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 138 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 68 ms. (steps per millisecond=147 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 145 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 149 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 65 ms. (steps per millisecond=153 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 142 resets, run finished after 73 ms. (steps per millisecond=136 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 149 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 145 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 147 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 142 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 146 resets, run finished after 67 ms. (steps per millisecond=149 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 143 resets, run finished after 66 ms. (steps per millisecond=151 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 148 resets, run finished after 66 ms. (steps per millisecond=151 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 66 ms. (steps per millisecond=151 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 147 resets, run finished after 66 ms. (steps per millisecond=151 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 151 resets, run finished after 65 ms. (steps per millisecond=153 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 147 resets, run finished after 87 ms. (steps per millisecond=114 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 151 resets, run finished after 96 ms. (steps per millisecond=104 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 147 resets, run finished after 64 ms. (steps per millisecond=156 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 155 resets, run finished after 62 ms. (steps per millisecond=161 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 151 resets, run finished after 64 ms. (steps per millisecond=156 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 137 resets, run finished after 66 ms. (steps per millisecond=151 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 141 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 152 resets, run finished after 67 ms. (steps per millisecond=149 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 149 resets, run finished after 67 ms. (steps per millisecond=149 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 143 resets, run finished after 68 ms. (steps per millisecond=147 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 134 resets, run finished after 68 ms. (steps per millisecond=147 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 142 resets, run finished after 66 ms. (steps per millisecond=151 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 146 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 144 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 143 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10000 steps, including 143 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 143 resets, run finished after 68 ms. (steps per millisecond=147 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 149 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 135 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 139 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 141 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 140) seen :0
Incomplete Best-First random walk after 10001 steps, including 143 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 140) seen :0
Running SMT prover for 140 properties.
// Phase 1: matrix 533 rows 335 cols
[2022-05-16 18:00:10] [INFO ] Computed 18 place invariants in 5 ms
[2022-05-16 18:00:11] [INFO ] After 1281ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:140
[2022-05-16 18:00:12] [INFO ] [Nat]Absence check using 10 positive place invariants in 24 ms returned sat
[2022-05-16 18:00:12] [INFO ] [Nat]Absence check using 10 positive and 8 generalized place invariants in 14 ms returned sat
[2022-05-16 18:00:17] [INFO ] After 3231ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :140
[2022-05-16 18:00:17] [INFO ] State equation strengthened by 2 read => feed constraints.
[2022-05-16 18:00:19] [INFO ] After 2689ms SMT Verify possible using 2 Read/Feed constraints in natural domain returned unsat :0 sat :140
[2022-05-16 18:00:20] [INFO ] Deduced a trap composed of 57 places in 161 ms of which 9 ms to minimize.
[2022-05-16 18:00:20] [INFO ] Deduced a trap composed of 56 places in 82 ms of which 1 ms to minimize.
[2022-05-16 18:00:20] [INFO ] Deduced a trap composed of 75 places in 147 ms of which 2 ms to minimize.
[2022-05-16 18:00:20] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 478 ms
[2022-05-16 18:00:20] [INFO ] Deduced a trap composed of 57 places in 159 ms of which 2 ms to minimize.
[2022-05-16 18:00:20] [INFO ] Deduced a trap composed of 77 places in 152 ms of which 1 ms to minimize.
[2022-05-16 18:00:21] [INFO ] Deduced a trap composed of 57 places in 90 ms of which 1 ms to minimize.
[2022-05-16 18:00:21] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 494 ms
[2022-05-16 18:00:21] [INFO ] Deduced a trap composed of 57 places in 75 ms of which 1 ms to minimize.
[2022-05-16 18:00:21] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 116 ms
[2022-05-16 18:00:21] [INFO ] Deduced a trap composed of 63 places in 138 ms of which 1 ms to minimize.
[2022-05-16 18:00:22] [INFO ] Deduced a trap composed of 78 places in 150 ms of which 1 ms to minimize.
[2022-05-16 18:00:22] [INFO ] Deduced a trap composed of 77 places in 136 ms of which 1 ms to minimize.
[2022-05-16 18:00:22] [INFO ] Deduced a trap composed of 58 places in 66 ms of which 1 ms to minimize.
[2022-05-16 18:00:22] [INFO ] Trap strengthening (SAT) tested/added 5/4 trap constraints in 621 ms
[2022-05-16 18:00:25] [INFO ] Deduced a trap composed of 73 places in 204 ms of which 2 ms to minimize.
[2022-05-16 18:00:25] [INFO ] Deduced a trap composed of 65 places in 119 ms of which 1 ms to minimize.
[2022-05-16 18:00:25] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 427 ms
[2022-05-16 18:00:26] [INFO ] Deduced a trap composed of 68 places in 136 ms of which 0 ms to minimize.
[2022-05-16 18:00:26] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 190 ms
[2022-05-16 18:00:27] [INFO ] After 10052ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :140
Attempting to minimize the solution found.
Minimization took 3085 ms.
[2022-05-16 18:00:30] [INFO ] After 18582ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :140
Fused 140 Parikh solutions to 131 different solutions.
Parikh walk visited 117 properties in 1880 ms.
Support contains 23 out of 335 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 335/335 places, 533/533 transitions.
Graph (complete) has 1019 edges and 335 vertex of which 326 are kept as prefixes of interest. Removing 9 places using SCC suffix rule.8 ms
Discarding 9 places :
Also discarding 0 output transitions
Drop transitions removed 136 transitions
Trivial Post-agglo rules discarded 136 transitions
Performed 136 trivial Post agglomeration. Transition count delta: 136
Iterating post reduction 0 with 136 rules applied. Total rules applied 137 place count 326 transition count 397
Reduce places removed 136 places and 0 transitions.
Ensure Unique test removed 16 transitions
Reduce isomorphic transitions removed 16 transitions.
Drop transitions removed 5 transitions
Trivial Post-agglo rules discarded 5 transitions
Performed 5 trivial Post agglomeration. Transition count delta: 5
Iterating post reduction 1 with 157 rules applied. Total rules applied 294 place count 190 transition count 376
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 2 with 5 rules applied. Total rules applied 299 place count 185 transition count 376
Performed 4 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 4 Pre rules applied. Total rules applied 299 place count 185 transition count 372
Deduced a syphon composed of 4 places in 1 ms
Reduce places removed 4 places and 0 transitions.
Iterating global reduction 3 with 8 rules applied. Total rules applied 307 place count 181 transition count 372
Discarding 66 places :
Symmetric choice reduction at 3 with 66 rule applications. Total rules 373 place count 115 transition count 230
Iterating global reduction 3 with 66 rules applied. Total rules applied 439 place count 115 transition count 230
Discarding 9 places :
Symmetric choice reduction at 3 with 9 rule applications. Total rules 448 place count 106 transition count 212
Iterating global reduction 3 with 9 rules applied. Total rules applied 457 place count 106 transition count 212
Ensure Unique test removed 8 transitions
Reduce isomorphic transitions removed 8 transitions.
Iterating post reduction 3 with 8 rules applied. Total rules applied 465 place count 106 transition count 204
Discarding 1 places :
Symmetric choice reduction at 4 with 1 rule applications. Total rules 466 place count 105 transition count 203
Iterating global reduction 4 with 1 rules applied. Total rules applied 467 place count 105 transition count 203
Discarding 1 places :
Symmetric choice reduction at 4 with 1 rule applications. Total rules 468 place count 104 transition count 201
Iterating global reduction 4 with 1 rules applied. Total rules applied 469 place count 104 transition count 201
Discarding 1 places :
Symmetric choice reduction at 4 with 1 rule applications. Total rules 470 place count 103 transition count 199
Iterating global reduction 4 with 1 rules applied. Total rules applied 471 place count 103 transition count 199
Discarding 1 places :
Symmetric choice reduction at 4 with 1 rule applications. Total rules 472 place count 102 transition count 197
Iterating global reduction 4 with 1 rules applied. Total rules applied 473 place count 102 transition count 197
Ensure Unique test removed 3 transitions
Reduce isomorphic transitions removed 3 transitions.
Iterating post reduction 4 with 3 rules applied. Total rules applied 476 place count 102 transition count 194
Performed 15 Post agglomeration using F-continuation condition.Transition count delta: 15
Deduced a syphon composed of 15 places in 0 ms
Reduce places removed 15 places and 0 transitions.
Iterating global reduction 5 with 30 rules applied. Total rules applied 506 place count 87 transition count 179
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 5 with 1 rules applied. Total rules applied 507 place count 87 transition count 178
Performed 8 Post agglomeration using F-continuation condition with reduction of 4 identical transitions.
Deduced a syphon composed of 8 places in 0 ms
Reduce places removed 8 places and 0 transitions.
Iterating global reduction 6 with 16 rules applied. Total rules applied 523 place count 79 transition count 222
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 6 with 1 rules applied. Total rules applied 524 place count 79 transition count 221
Discarding 1 places :
Symmetric choice reduction at 7 with 1 rule applications. Total rules 525 place count 78 transition count 218
Iterating global reduction 7 with 1 rules applied. Total rules applied 526 place count 78 transition count 218
Drop transitions removed 4 transitions
Redundant transition composition rules discarded 4 transitions
Iterating global reduction 7 with 4 rules applied. Total rules applied 530 place count 78 transition count 214
Free-agglomeration rule applied 1 times.
Iterating global reduction 7 with 1 rules applied. Total rules applied 531 place count 78 transition count 213
Reduce places removed 1 places and 0 transitions.
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 7 with 2 rules applied. Total rules applied 533 place count 77 transition count 212
Partial Post-agglomeration rule applied 2 times.
Drop transitions removed 2 transitions
Iterating global reduction 8 with 2 rules applied. Total rules applied 535 place count 77 transition count 212
Applied a total of 535 rules in 95 ms. Remains 77 /335 variables (removed 258) and now considering 212/533 (removed 321) transitions.
Finished structural reductions, in 1 iterations. Remains : 77/335 places, 212/533 transitions.
Interrupted random walk after 792295 steps, including 112933 resets, run timeout after 30001 ms. (steps per millisecond=26 ) properties seen 6
Incomplete Best-First random walk after 100001 steps, including 1416 resets, run finished after 470 ms. (steps per millisecond=212 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1447 resets, run finished after 474 ms. (steps per millisecond=210 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1413 resets, run finished after 508 ms. (steps per millisecond=196 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100000 steps, including 1432 resets, run finished after 444 ms. (steps per millisecond=225 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1445 resets, run finished after 472 ms. (steps per millisecond=211 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1422 resets, run finished after 469 ms. (steps per millisecond=213 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1438 resets, run finished after 435 ms. (steps per millisecond=229 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1429 resets, run finished after 418 ms. (steps per millisecond=239 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1447 resets, run finished after 397 ms. (steps per millisecond=251 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1456 resets, run finished after 387 ms. (steps per millisecond=258 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1446 resets, run finished after 422 ms. (steps per millisecond=236 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1454 resets, run finished after 421 ms. (steps per millisecond=237 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1447 resets, run finished after 409 ms. (steps per millisecond=244 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1412 resets, run finished after 415 ms. (steps per millisecond=240 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1426 resets, run finished after 403 ms. (steps per millisecond=248 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1436 resets, run finished after 440 ms. (steps per millisecond=227 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1430 resets, run finished after 420 ms. (steps per millisecond=238 ) properties (out of 17) seen :0
Running SMT prover for 17 properties.
[2022-05-16 18:01:09] [INFO ] Flow matrix only has 203 transitions (discarded 9 similar events)
// Phase 1: matrix 203 rows 77 cols
[2022-05-16 18:01:09] [INFO ] Computed 9 place invariants in 2 ms
[2022-05-16 18:01:09] [INFO ] After 78ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:17
[2022-05-16 18:01:09] [INFO ] [Nat]Absence check using 1 positive place invariants in 1 ms returned sat
[2022-05-16 18:01:09] [INFO ] [Nat]Absence check using 1 positive and 8 generalized place invariants in 3 ms returned sat
[2022-05-16 18:01:10] [INFO ] After 268ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :17
[2022-05-16 18:01:10] [INFO ] State equation strengthened by 28 read => feed constraints.
[2022-05-16 18:01:10] [INFO ] After 192ms SMT Verify possible using 28 Read/Feed constraints in natural domain returned unsat :0 sat :17
[2022-05-16 18:01:10] [INFO ] After 457ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :17
Attempting to minimize the solution found.
Minimization took 161 ms.
[2022-05-16 18:01:10] [INFO ] After 994ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :17
Fused 17 Parikh solutions to 9 different solutions.
Parikh walk visited 0 properties in 78 ms.
Support contains 17 out of 77 places. Attempting structural reductions.
Starting structural reductions in SAFETY mode, iteration 0 : 77/77 places, 212/212 transitions.
Drop transitions removed 5 transitions
Trivial Post-agglo rules discarded 5 transitions
Performed 5 trivial Post agglomeration. Transition count delta: 5
Iterating post reduction 0 with 5 rules applied. Total rules applied 5 place count 77 transition count 207
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 1 with 5 rules applied. Total rules applied 10 place count 72 transition count 207
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 2 with 4 rules applied. Total rules applied 14 place count 70 transition count 205
Ensure Unique test removed 3 transitions
Reduce isomorphic transitions removed 3 transitions.
Iterating post reduction 2 with 3 rules applied. Total rules applied 17 place count 70 transition count 202
Applied a total of 17 rules in 11 ms. Remains 70 /77 variables (removed 7) and now considering 202/212 (removed 10) transitions.
Finished structural reductions, in 1 iterations. Remains : 70/77 places, 202/212 transitions.
Interrupted random walk after 810224 steps, including 115592 resets, run timeout after 30001 ms. (steps per millisecond=27 ) properties seen 0
Incomplete Best-First random walk after 100001 steps, including 1432 resets, run finished after 413 ms. (steps per millisecond=242 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1442 resets, run finished after 525 ms. (steps per millisecond=190 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1433 resets, run finished after 386 ms. (steps per millisecond=259 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1427 resets, run finished after 356 ms. (steps per millisecond=280 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1432 resets, run finished after 366 ms. (steps per millisecond=273 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1447 resets, run finished after 378 ms. (steps per millisecond=264 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1436 resets, run finished after 408 ms. (steps per millisecond=245 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1452 resets, run finished after 430 ms. (steps per millisecond=232 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1438 resets, run finished after 495 ms. (steps per millisecond=202 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100000 steps, including 1450 resets, run finished after 363 ms. (steps per millisecond=275 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1451 resets, run finished after 389 ms. (steps per millisecond=257 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1428 resets, run finished after 364 ms. (steps per millisecond=274 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1444 resets, run finished after 339 ms. (steps per millisecond=294 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1405 resets, run finished after 347 ms. (steps per millisecond=288 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1432 resets, run finished after 601 ms. (steps per millisecond=166 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100000 steps, including 1443 resets, run finished after 433 ms. (steps per millisecond=230 ) properties (out of 17) seen :0
Incomplete Best-First random walk after 100001 steps, including 1424 resets, run finished after 482 ms. (steps per millisecond=207 ) properties (out of 17) seen :0
Finished probabilistic random walk after 41809 steps, run visited all 17 properties in 738 ms. (steps per millisecond=56 )
Probabilistic random walk after 41809 steps, saw 9992 distinct states, run finished after 738 ms. (steps per millisecond=56 ) properties seen :17
Able to resolve query StableMarking after proving 360 properties.
FORMULA StableMarking FALSE TECHNIQUES RANDOM_WALK PARIKH_WALK PROBABILISTIC_WALK MARKED_SUFFIX_TEST TRIVIAL_UNMARKED_SCC_TEST TOPOLOGICAL
Total runtime 169207 ms.

BK_STOP 1652724108749

--------------------
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
++ 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 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-17"
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-17, 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-165264480700128"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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