About the Execution of Marcie+red for HealthRecord-PT-17
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
364.691 | 146355.00 | 243443.00 | 627.00 | F | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fkordon/mcc2023-input.r216-smll-167840358400228.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2023-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
......................................................................................................
=====================================================================
Generated by BenchKit 2-5348
Executing tool marciexred
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 r216-smll-167840358400228
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 604K
-rw-r--r-- 1 mcc users 6.1K Feb 26 17:53 CTLCardinality.txt
-rw-r--r-- 1 mcc users 65K Feb 26 17:53 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.5K Feb 26 17:52 CTLFireability.txt
-rw-r--r-- 1 mcc users 51K Feb 26 17:52 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.5K Feb 25 16:14 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Feb 25 16:14 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Feb 25 16:14 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Feb 25 16:14 LTLFireability.xml
-rw-r--r-- 1 mcc users 11K Feb 26 17:54 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 114K Feb 26 17:54 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 8.9K Feb 26 17:53 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 78K Feb 26 17:53 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 25 16:14 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Feb 25 16:14 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 equiv_col
-rw-r--r-- 1 mcc users 3 Mar 5 18:22 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:22 iscolored
-rw-r--r-- 1 mcc users 175K Mar 5 18:22 model.pnml
--------------------
content from stdout:
=== Data for post analysis generated by BenchKit (invocation template)
The expected result is a vector of booleans
BOOL_VECTOR
FORMULA_NAME StableMarking
=== Now, execution of the tool begins
BK_START 1678626621524
bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=marciexred
BK_EXAMINATION=StableMarking
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=HealthRecord-PT-17
Applying reductions before tool marcie
Invoking reducer
Running Version 202303021504
[2023-03-12 13:10:24] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, StableMarking, -timeout, 180, -rebuildPNML]
[2023-03-12 13:10:25] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-12 13:10:25] [INFO ] Load time of PNML (sax parser for PT used): 197 ms
[2023-03-12 13:10:25] [INFO ] Transformed 624 places.
[2023-03-12 13:10:25] [INFO ] Transformed 828 transitions.
[2023-03-12 13:10:25] [INFO ] Found NUPN structural information;
[2023-03-12 13:10:25] [INFO ] Parsed PT model containing 624 places and 828 transitions and 1879 arcs in 379 ms.
Graph (trivial) has 749 edges and 624 vertex of which 87 / 624 are part of one of the 21 SCC in 13 ms
Free SCC test removed 66 places
Structural test allowed to assert that 266 places are NOT stable. Took 34 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 1152 ms. (steps per millisecond=8 ) 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 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 9 ms. (steps per millisecond=11 ) 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 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 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 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 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 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 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 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 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 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 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 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 3 ms. (steps per millisecond=33 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 3 ms. (steps per millisecond=33 ) properties (out of 311) seen :0
Incomplete Best-First random walk after 101 steps, including 2 resets, run finished after 3 ms. (steps per millisecond=33 ) 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 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 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 101 steps, including 2 resets, run finished after 4 ms. (steps per millisecond=25 ) properties (out of 311) seen :0
Running SMT prover for 311 properties.
[2023-03-12 13:10:26] [INFO ] Flow matrix only has 733 transitions (discarded 20 similar events)
// Phase 1: matrix 733 rows 558 cols
[2023-03-12 13:10:27] [INFO ] Computed 18 place invariants in 30 ms
[2023-03-12 13:10:34] [INFO ] After 7236ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:311
[2023-03-12 13:10:38] [INFO ] [Nat]Absence check using 10 positive place invariants in 24 ms returned sat
[2023-03-12 13:10:38] [INFO ] [Nat]Absence check using 10 positive and 8 generalized place invariants in 15 ms returned sat
[2023-03-12 13:10:51] [INFO ] After 9702ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :311
[2023-03-12 13:10:51] [INFO ] State equation strengthened by 1 read => feed constraints.
[2023-03-12 13:10:59] [INFO ] After 8273ms SMT Verify possible using 1 Read/Feed constraints in natural domain returned unsat :0 sat :311
[2023-03-12 13:10:59] [INFO ] After 8274ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :311
Attempting to minimize the solution found.
Minimization took 1 ms.
[2023-03-12 13:10:59] [INFO ] After 25012ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :311
Fused 311 Parikh solutions to 298 different solutions.
Parikh walk visited 18 properties in 3275 ms.
Support contains 293 out of 558 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 558/558 places, 753/753 transitions.
Drop transitions removed 21 transitions
Reduce isomorphic transitions removed 21 transitions.
Drop transitions removed 145 transitions
Trivial Post-agglo rules discarded 145 transitions
Performed 145 trivial Post agglomeration. Transition count delta: 145
Iterating post reduction 0 with 166 rules applied. Total rules applied 166 place count 558 transition count 587
Reduce places removed 145 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 162 rules applied. Total rules applied 328 place count 413 transition count 570
Reduce places removed 9 places and 0 transitions.
Iterating post reduction 2 with 9 rules applied. Total rules applied 337 place count 404 transition count 570
Performed 10 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 10 Pre rules applied. Total rules applied 337 place count 404 transition count 560
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 357 place count 394 transition count 560
Discarding 4 places :
Symmetric choice reduction at 3 with 4 rule applications. Total rules 361 place count 390 transition count 552
Iterating global reduction 3 with 4 rules applied. Total rules applied 365 place count 390 transition count 552
Performed 18 Post agglomeration using F-continuation condition.Transition count delta: 18
Deduced a syphon composed of 18 places in 0 ms
Reduce places removed 18 places and 0 transitions.
Iterating global reduction 3 with 36 rules applied. Total rules applied 401 place count 372 transition count 534
Performed 7 Post agglomeration using F-continuation condition with reduction of 6 identical transitions.
Deduced a syphon composed of 7 places in 0 ms
Reduce places removed 7 places and 0 transitions.
Iterating global reduction 3 with 14 rules applied. Total rules applied 415 place count 365 transition count 574
Ensure Unique test removed 6 transitions
Reduce isomorphic transitions removed 6 transitions.
Iterating post reduction 3 with 6 rules applied. Total rules applied 421 place count 365 transition count 568
Drop transitions removed 19 transitions
Redundant transition composition rules discarded 19 transitions
Iterating global reduction 4 with 19 rules applied. Total rules applied 440 place count 365 transition count 549
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 442 place count 364 transition count 560
Free-agglomeration rule applied 24 times.
Iterating global reduction 4 with 24 rules applied. Total rules applied 466 place count 364 transition count 536
Reduce places removed 24 places and 0 transitions.
Iterating post reduction 4 with 24 rules applied. Total rules applied 490 place count 340 transition count 536
Free-agglomeration rule (complex) applied 1 times.
Iterating global reduction 5 with 1 rules applied. Total rules applied 491 place count 340 transition count 539
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 5 with 1 rules applied. Total rules applied 492 place count 339 transition count 539
Partial Free-agglomeration rule applied 9 times.
Drop transitions removed 9 transitions
Iterating global reduction 6 with 9 rules applied. Total rules applied 501 place count 339 transition count 539
Applied a total of 501 rules in 190 ms. Remains 339 /558 variables (removed 219) and now considering 539/753 (removed 214) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 191 ms. Remains : 339/558 places, 539/753 transitions.
Interrupted random walk after 812705 steps, including 98528 resets, run timeout after 30001 ms. (steps per millisecond=27 ) properties seen 155
Incomplete Best-First random walk after 10001 steps, including 165 resets, run finished after 50 ms. (steps per millisecond=200 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 165 resets, run finished after 53 ms. (steps per millisecond=188 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 168 resets, run finished after 52 ms. (steps per millisecond=192 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10000 steps, including 163 resets, run finished after 50 ms. (steps per millisecond=200 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 160 resets, run finished after 49 ms. (steps per millisecond=204 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 159 resets, run finished after 55 ms. (steps per millisecond=181 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 162 resets, run finished after 55 ms. (steps per millisecond=181 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 160 resets, run finished after 68 ms. (steps per millisecond=147 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10000 steps, including 156 resets, run finished after 73 ms. (steps per millisecond=136 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 165 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 169 resets, run finished after 71 ms. (steps per millisecond=140 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 155 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 166 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 165 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 163 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 155 resets, run finished after 76 ms. (steps per millisecond=131 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 75 ms. (steps per millisecond=133 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 169 resets, run finished after 78 ms. (steps per millisecond=128 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10000 steps, including 174 resets, run finished after 75 ms. (steps per millisecond=133 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 79 ms. (steps per millisecond=126 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 162 resets, run finished after 74 ms. (steps per millisecond=135 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 167 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 165 resets, run finished after 75 ms. (steps per millisecond=133 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 160 resets, run finished after 75 ms. (steps per millisecond=133 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 163 resets, run finished after 77 ms. (steps per millisecond=129 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 162 resets, run finished after 89 ms. (steps per millisecond=112 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 172 resets, run finished after 83 ms. (steps per millisecond=120 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 165 resets, run finished after 60 ms. (steps per millisecond=166 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 159 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 168 resets, run finished after 49 ms. (steps per millisecond=204 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 168 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 150 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 164 resets, run finished after 49 ms. (steps per millisecond=204 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 163 resets, run finished after 46 ms. (steps per millisecond=217 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 157 resets, run finished after 46 ms. (steps per millisecond=217 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 159 resets, run finished after 48 ms. (steps per millisecond=208 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 171 resets, run finished after 46 ms. (steps per millisecond=217 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10000 steps, including 164 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 161 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 169 resets, run finished after 49 ms. (steps per millisecond=204 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 163 resets, run finished after 50 ms. (steps per millisecond=200 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 171 resets, run finished after 50 ms. (steps per millisecond=200 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10000 steps, including 170 resets, run finished after 48 ms. (steps per millisecond=208 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 169 resets, run finished after 50 ms. (steps per millisecond=200 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 170 resets, run finished after 45 ms. (steps per millisecond=222 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10001 steps, including 163 resets, run finished after 47 ms. (steps per millisecond=212 ) properties (out of 138) seen :0
Incomplete Best-First random walk after 10000 steps, including 159 resets, run finished after 48 ms. (steps per millisecond=208 ) properties (out of 138) seen :0
Running SMT prover for 138 properties.
// Phase 1: matrix 539 rows 339 cols
[2023-03-12 13:11:36] [INFO ] Computed 18 place invariants in 10 ms
[2023-03-12 13:11:37] [INFO ] After 1261ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:138
[2023-03-12 13:11:38] [INFO ] [Nat]Absence check using 10 positive place invariants in 14 ms returned sat
[2023-03-12 13:11:38] [INFO ] [Nat]Absence check using 10 positive and 8 generalized place invariants in 9 ms returned sat
[2023-03-12 13:11:42] [INFO ] After 2763ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :138
[2023-03-12 13:11:42] [INFO ] State equation strengthened by 3 read => feed constraints.
[2023-03-12 13:11:44] [INFO ] After 2581ms SMT Verify possible using 3 Read/Feed constraints in natural domain returned unsat :0 sat :138
[2023-03-12 13:11:44] [INFO ] Deduced a trap composed of 78 places in 203 ms of which 11 ms to minimize.
[2023-03-12 13:11:45] [INFO ] Deduced a trap composed of 59 places in 171 ms of which 1 ms to minimize.
[2023-03-12 13:11:45] [INFO ] Deduced a trap composed of 70 places in 129 ms of which 1 ms to minimize.
[2023-03-12 13:11:45] [INFO ] Deduced a trap composed of 69 places in 166 ms of which 2 ms to minimize.
[2023-03-12 13:11:45] [INFO ] Trap strengthening (SAT) tested/added 5/4 trap constraints in 779 ms
[2023-03-12 13:11:45] [INFO ] Deduced a trap composed of 57 places in 200 ms of which 1 ms to minimize.
[2023-03-12 13:11:46] [INFO ] Deduced a trap composed of 58 places in 179 ms of which 1 ms to minimize.
[2023-03-12 13:11:46] [INFO ] Deduced a trap composed of 79 places in 143 ms of which 1 ms to minimize.
[2023-03-12 13:11:46] [INFO ] Deduced a trap composed of 68 places in 130 ms of which 2 ms to minimize.
[2023-03-12 13:11:46] [INFO ] Trap strengthening (SAT) tested/added 5/4 trap constraints in 774 ms
[2023-03-12 13:11:46] [INFO ] Deduced a trap composed of 58 places in 83 ms of which 2 ms to minimize.
[2023-03-12 13:11:46] [INFO ] Deduced a trap composed of 57 places in 60 ms of which 1 ms to minimize.
[2023-03-12 13:11:47] [INFO ] Deduced a trap composed of 56 places in 62 ms of which 0 ms to minimize.
[2023-03-12 13:11:47] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 313 ms
[2023-03-12 13:11:47] [INFO ] Deduced a trap composed of 71 places in 116 ms of which 1 ms to minimize.
[2023-03-12 13:11:47] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 156 ms
[2023-03-12 13:11:48] [INFO ] Deduced a trap composed of 58 places in 149 ms of which 1 ms to minimize.
[2023-03-12 13:11:48] [INFO ] Deduced a trap composed of 58 places in 118 ms of which 0 ms to minimize.
[2023-03-12 13:11:48] [INFO ] Deduced a trap composed of 82 places in 101 ms of which 0 ms to minimize.
[2023-03-12 13:11:48] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 455 ms
[2023-03-12 13:11:49] [INFO ] Deduced a trap composed of 57 places in 119 ms of which 1 ms to minimize.
[2023-03-12 13:11:49] [INFO ] Deduced a trap composed of 79 places in 116 ms of which 1 ms to minimize.
[2023-03-12 13:11:49] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 295 ms
[2023-03-12 13:11:49] [INFO ] Deduced a trap composed of 56 places in 130 ms of which 1 ms to minimize.
[2023-03-12 13:11:50] [INFO ] Deduced a trap composed of 74 places in 126 ms of which 1 ms to minimize.
[2023-03-12 13:11:50] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 319 ms
[2023-03-12 13:11:52] [INFO ] After 10137ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :138
Attempting to minimize the solution found.
Minimization took 3746 ms.
[2023-03-12 13:11:56] [INFO ] After 18686ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :138
Fused 138 Parikh solutions to 131 different solutions.
Parikh walk visited 100 properties in 1853 ms.
Support contains 38 out of 339 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 339/339 places, 539/539 transitions.
Graph (complete) has 1026 edges and 339 vertex of which 330 are kept as prefixes of interest. Removing 9 places using SCC suffix rule.3 ms
Discarding 9 places :
Also discarding 0 output transitions
Drop transitions removed 122 transitions
Trivial Post-agglo rules discarded 122 transitions
Performed 122 trivial Post agglomeration. Transition count delta: 122
Iterating post reduction 0 with 122 rules applied. Total rules applied 123 place count 330 transition count 417
Reduce places removed 122 places and 0 transitions.
Ensure Unique test removed 11 transitions
Reduce isomorphic transitions removed 11 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 138 rules applied. Total rules applied 261 place count 208 transition count 401
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 2 with 5 rules applied. Total rules applied 266 place count 203 transition count 401
Performed 3 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 3 Pre rules applied. Total rules applied 266 place count 203 transition count 398
Deduced a syphon composed of 3 places in 1 ms
Reduce places removed 3 places and 0 transitions.
Iterating global reduction 3 with 6 rules applied. Total rules applied 272 place count 200 transition count 398
Discarding 64 places :
Symmetric choice reduction at 3 with 64 rule applications. Total rules 336 place count 136 transition count 257
Iterating global reduction 3 with 64 rules applied. Total rules applied 400 place count 136 transition count 257
Ensure Unique test removed 2 transitions
Reduce isomorphic transitions removed 2 transitions.
Iterating post reduction 3 with 2 rules applied. Total rules applied 402 place count 136 transition count 255
Discarding 9 places :
Symmetric choice reduction at 4 with 9 rule applications. Total rules 411 place count 127 transition count 237
Iterating global reduction 4 with 9 rules applied. Total rules applied 420 place count 127 transition count 237
Ensure Unique test removed 8 transitions
Reduce isomorphic transitions removed 8 transitions.
Iterating post reduction 4 with 8 rules applied. Total rules applied 428 place count 127 transition count 229
Performed 16 Post agglomeration using F-continuation condition.Transition count delta: 16
Deduced a syphon composed of 16 places in 0 ms
Reduce places removed 16 places and 0 transitions.
Iterating global reduction 5 with 32 rules applied. Total rules applied 460 place count 111 transition count 213
Performed 9 Post agglomeration using F-continuation condition with reduction of 6 identical transitions.
Deduced a syphon composed of 9 places in 0 ms
Reduce places removed 9 places and 0 transitions.
Iterating global reduction 5 with 18 rules applied. Total rules applied 478 place count 102 transition count 265
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 5 with 1 rules applied. Total rules applied 479 place count 102 transition count 264
Discarding 1 places :
Symmetric choice reduction at 6 with 1 rule applications. Total rules 480 place count 101 transition count 262
Iterating global reduction 6 with 1 rules applied. Total rules applied 481 place count 101 transition count 262
Free-agglomeration rule applied 1 times.
Iterating global reduction 6 with 1 rules applied. Total rules applied 482 place count 101 transition count 261
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 6 with 1 rules applied. Total rules applied 483 place count 100 transition count 261
Applied a total of 483 rules in 75 ms. Remains 100 /339 variables (removed 239) and now considering 261/539 (removed 278) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 75 ms. Remains : 100/339 places, 261/539 transitions.
Interrupted random walk after 801692 steps, including 113263 resets, run timeout after 30001 ms. (steps per millisecond=26 ) properties seen 0
Incomplete Best-First random walk after 100001 steps, including 1576 resets, run finished after 465 ms. (steps per millisecond=215 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1563 resets, run finished after 470 ms. (steps per millisecond=212 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1553 resets, run finished after 460 ms. (steps per millisecond=217 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1601 resets, run finished after 481 ms. (steps per millisecond=207 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1573 resets, run finished after 463 ms. (steps per millisecond=215 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1591 resets, run finished after 406 ms. (steps per millisecond=246 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1587 resets, run finished after 436 ms. (steps per millisecond=229 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1585 resets, run finished after 461 ms. (steps per millisecond=216 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1584 resets, run finished after 479 ms. (steps per millisecond=208 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1571 resets, run finished after 455 ms. (steps per millisecond=219 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1552 resets, run finished after 371 ms. (steps per millisecond=269 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1593 resets, run finished after 448 ms. (steps per millisecond=223 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1576 resets, run finished after 446 ms. (steps per millisecond=224 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1564 resets, run finished after 474 ms. (steps per millisecond=210 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 1583 resets, run finished after 464 ms. (steps per millisecond=215 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1580 resets, run finished after 479 ms. (steps per millisecond=208 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1589 resets, run finished after 469 ms. (steps per millisecond=213 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1595 resets, run finished after 472 ms. (steps per millisecond=211 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 1581 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 1574 resets, run finished after 445 ms. (steps per millisecond=224 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1579 resets, run finished after 463 ms. (steps per millisecond=215 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1578 resets, run finished after 405 ms. (steps per millisecond=246 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1557 resets, run finished after 459 ms. (steps per millisecond=217 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1595 resets, run finished after 406 ms. (steps per millisecond=246 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1585 resets, run finished after 463 ms. (steps per millisecond=215 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1549 resets, run finished after 417 ms. (steps per millisecond=239 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1575 resets, run finished after 442 ms. (steps per millisecond=226 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1587 resets, run finished after 458 ms. (steps per millisecond=218 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1571 resets, run finished after 442 ms. (steps per millisecond=226 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1550 resets, run finished after 458 ms. (steps per millisecond=218 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1556 resets, run finished after 456 ms. (steps per millisecond=219 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1567 resets, run finished after 430 ms. (steps per millisecond=232 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1574 resets, run finished after 454 ms. (steps per millisecond=220 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1591 resets, run finished after 460 ms. (steps per millisecond=217 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1560 resets, run finished after 413 ms. (steps per millisecond=242 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1570 resets, run finished after 412 ms. (steps per millisecond=242 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100001 steps, including 1579 resets, run finished after 451 ms. (steps per millisecond=221 ) properties (out of 38) seen :0
Incomplete Best-First random walk after 100000 steps, including 1572 resets, run finished after 385 ms. (steps per millisecond=259 ) properties (out of 38) seen :0
Finished probabilistic random walk after 386682 steps, run visited all 38 properties in 1998 ms. (steps per millisecond=193 )
Probabilistic random walk after 386682 steps, saw 69637 distinct states, run finished after 1999 ms. (steps per millisecond=193 ) properties seen :38
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 141916 ms.
ITS solved all properties within timeout
BK_STOP 1678626767879
--------------------
content from stderr:
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
+ VERSION=202303021504
+ echo 'Running Version 202303021504'
+ /home/mcc/BenchKit/bin//../reducer/bin//../../itstools//itstools/its-tools -pnfolder /home/mcc/execution -examination StableMarking -timeout 180 -rebuildPNML
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="marciexred"
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-5348"
echo " Executing tool marciexred"
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 r216-smll-167840358400228"
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 '
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 ;