About the Execution of ITS-Tools for ShieldRVt-PT-100B
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
16217.632 | 1994599.00 | 3908967.00 | 90287.00 | TFFTTTFTFTTFFTTT | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/mnt/tpsp/fkordon/mcc2023-input.r421-tajo-167905975100351.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/fkordon/mcc2023-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
........................
=====================================================================
Generated by BenchKit 2-5348
Executing tool itstools
Input is ShieldRVt-PT-100B, examination is ReachabilityFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r421-tajo-167905975100351
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 1.7M
-rw-r--r-- 1 mcc users 7.2K Feb 25 23:00 CTLCardinality.txt
-rw-r--r-- 1 mcc users 78K Feb 25 23:00 CTLCardinality.xml
-rw-r--r-- 1 mcc users 6.4K Feb 25 23:00 CTLFireability.txt
-rw-r--r-- 1 mcc users 61K Feb 25 23:00 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Jan 29 11:41 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.6K Jan 29 11:41 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.4K Feb 25 17:05 LTLCardinality.txt
-rw-r--r-- 1 mcc users 23K Feb 25 17:05 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Feb 25 17:05 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K Feb 25 17:05 LTLFireability.xml
-rw-r--r-- 1 mcc users 9.5K Feb 25 23:01 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 96K Feb 25 23:01 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 9.5K Feb 25 23:00 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 83K Feb 25 23:00 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 25 17:05 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Feb 25 17:05 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 equiv_col
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 6 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 1.3M Mar 5 18:23 model.pnml
--------------------
content from stdout:
=== Data for post analysis generated by BenchKit (invocation template)
The expected result is a vector of booleans
BOOL_VECTOR
here is the order used to build the result vector(from text file)
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-00
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-01
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-02
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-03
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-04
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-05
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-06
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-07
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-08
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-09
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-10
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-11
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-12
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-13
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-14
FORMULA_NAME ShieldRVt-PT-100B-ReachabilityFireability-15
=== Now, execution of the tool begins
BK_START 1679176472591
bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=ReachabilityFireability
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=3600
BK_INPUT=ShieldRVt-PT-100B
Not applying reductions.
Model is PT
ReachabilityFireability PT
Running Version 202303021504
[2023-03-18 21:54:35] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityFireability, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2023-03-18 21:54:35] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-18 21:54:35] [INFO ] Load time of PNML (sax parser for PT used): 282 ms
[2023-03-18 21:54:35] [INFO ] Transformed 5003 places.
[2023-03-18 21:54:35] [INFO ] Transformed 5003 transitions.
[2023-03-18 21:54:35] [INFO ] Found NUPN structural information;
[2023-03-18 21:54:35] [INFO ] Parsed PT model containing 5003 places and 5003 transitions and 11806 arcs in 588 ms.
Parsed 16 properties from file /home/mcc/execution/ReachabilityFireability.xml in 40 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 2 resets, run finished after 493 ms. (steps per millisecond=20 ) properties (out of 16) seen :3
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-11 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-03 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-00 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 62 ms. (steps per millisecond=161 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 78 ms. (steps per millisecond=128 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 100 ms. (steps per millisecond=100 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 52 ms. (steps per millisecond=192 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 48 ms. (steps per millisecond=208 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 44 ms. (steps per millisecond=227 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 48 ms. (steps per millisecond=208 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 38 ms. (steps per millisecond=263 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 42 ms. (steps per millisecond=238 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 31 ms. (steps per millisecond=322 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 34 ms. (steps per millisecond=294 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 24 ms. (steps per millisecond=416 ) properties (out of 13) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 24 ms. (steps per millisecond=416 ) properties (out of 13) seen :0
[2023-03-18 21:54:37] [INFO ] Flatten gal took : 565 ms
[2023-03-18 21:54:37] [INFO ] Flatten gal took : 325 ms
Running SMT prover for 13 properties.
// Phase 1: matrix 5003 rows 5003 cols
[2023-03-18 21:54:37] [INFO ] Computed 401 place invariants in 96 ms
[2023-03-18 21:54:37] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality7516486855701366127.gal : 151 ms
[2023-03-18 21:54:37] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality9606166632258164220.prop : 13 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality7516486855701366127.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality9606166632258164220.prop' '--nowitness' '--gen-order' 'FOLLOW'
its-reach command run as :
/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...328
Loading property file /tmp/ReachabilityCardinality9606166632258164220.prop.
[2023-03-18 21:54:41] [INFO ] After 3868ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:13
[2023-03-18 21:54:44] [INFO ] [Nat]Absence check using 401 positive place invariants in 457 ms returned sat
SDD proceeding with computation,13 properties remain. new max is 4
SDD size :1 after 5
SDD proceeding with computation,13 properties remain. new max is 8
SDD size :5 after 10
SDD proceeding with computation,13 properties remain. new max is 16
SDD size :10 after 19
SDD proceeding with computation,13 properties remain. new max is 32
SDD size :19 after 36
SDD proceeding with computation,13 properties remain. new max is 64
SDD size :36 after 69
SDD proceeding with computation,13 properties remain. new max is 128
SDD size :69 after 309
SDD proceeding with computation,13 properties remain. new max is 256
SDD size :309 after 1.9172e+09
SDD proceeding with computation,13 properties remain. new max is 512
SDD size :1.9172e+09 after 3.19577e+23
SDD proceeding with computation,13 properties remain. new max is 1024
SDD size :3.19577e+23 after 9.9895e+51
SDD proceeding with computation,13 properties remain. new max is 2048
SDD size :9.9895e+51 after 2.3394e+111
[2023-03-18 21:55:06] [INFO ] After 20710ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :11
[2023-03-18 21:55:06] [INFO ] After 20717ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :11
Attempting to minimize the solution found.
Minimization took 2 ms.
[2023-03-18 21:55:06] [INFO ] After 25041ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :11
Fused 13 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 1 ms.
Support contains 261 out of 5003 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 5003/5003 places, 5003/5003 transitions.
Drop transitions removed 1347 transitions
Trivial Post-agglo rules discarded 1347 transitions
Performed 1347 trivial Post agglomeration. Transition count delta: 1347
Iterating post reduction 0 with 1347 rules applied. Total rules applied 1347 place count 5003 transition count 3656
Reduce places removed 1347 places and 0 transitions.
Ensure Unique test removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Drop transitions removed 1 transitions
Trivial Post-agglo rules discarded 1 transitions
Performed 1 trivial Post agglomeration. Transition count delta: 1
Iterating post reduction 1 with 1349 rules applied. Total rules applied 2696 place count 3656 transition count 3654
Reduce places removed 1 places and 0 transitions.
Performed 93 Post agglomeration using F-continuation condition.Transition count delta: 93
Iterating post reduction 2 with 94 rules applied. Total rules applied 2790 place count 3655 transition count 3561
Reduce places removed 93 places and 0 transitions.
Iterating post reduction 3 with 93 rules applied. Total rules applied 2883 place count 3562 transition count 3561
Performed 413 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 413 Pre rules applied. Total rules applied 2883 place count 3562 transition count 3148
Deduced a syphon composed of 413 places in 29 ms
Reduce places removed 413 places and 0 transitions.
Iterating global reduction 4 with 826 rules applied. Total rules applied 3709 place count 3149 transition count 3148
Discarding 638 places :
Symmetric choice reduction at 4 with 638 rule applications. Total rules 4347 place count 2511 transition count 2510
Iterating global reduction 4 with 638 rules applied. Total rules applied 4985 place count 2511 transition count 2510
Performed 241 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 4 with 241 Pre rules applied. Total rules applied 4985 place count 2511 transition count 2269
Deduced a syphon composed of 241 places in 8 ms
Reduce places removed 241 places and 0 transitions.
Iterating global reduction 4 with 482 rules applied. Total rules applied 5467 place count 2270 transition count 2269
Performed 823 Post agglomeration using F-continuation condition.Transition count delta: 823
Deduced a syphon composed of 823 places in 4 ms
Reduce places removed 823 places and 0 transitions.
Iterating global reduction 4 with 1646 rules applied. Total rules applied 7113 place count 1447 transition count 1446
Renaming transitions due to excessive name length > 1024 char.
Performed 101 Post agglomeration using F-continuation condition.Transition count delta: -73
Deduced a syphon composed of 101 places in 4 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 4 with 202 rules applied. Total rules applied 7315 place count 1346 transition count 1519
Performed 101 Post agglomeration using F-continuation condition.Transition count delta: -65
Deduced a syphon composed of 101 places in 3 ms
Reduce places removed 101 places and 0 transitions.
Iterating global reduction 4 with 202 rules applied. Total rules applied 7517 place count 1245 transition count 1584
Performed 32 Post agglomeration using F-continuation condition.Transition count delta: -27
Deduced a syphon composed of 32 places in 4 ms
Reduce places removed 32 places and 0 transitions.
Iterating global reduction 4 with 64 rules applied. Total rules applied 7581 place count 1213 transition count 1611
Drop transitions removed 1 transitions
Reduce isomorphic transitions removed 1 transitions.
Iterating post reduction 4 with 1 rules applied. Total rules applied 7582 place count 1213 transition count 1610
Free-agglomeration rule applied 11 times.
Iterating global reduction 5 with 11 rules applied. Total rules applied 7593 place count 1213 transition count 1599
Reduce places removed 11 places and 0 transitions.
Iterating post reduction 5 with 11 rules applied. Total rules applied 7604 place count 1202 transition count 1599
Drop transitions removed 5 transitions
Redundant transition composition rules discarded 5 transitions
Iterating global reduction 6 with 5 rules applied. Total rules applied 7609 place count 1202 transition count 1594
Partial Free-agglomeration rule applied 4 times.
Drop transitions removed 4 transitions
Iterating global reduction 6 with 4 rules applied. Total rules applied 7613 place count 1202 transition count 1594
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 6 with 1 rules applied. Total rules applied 7614 place count 1201 transition count 1593
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 6 with 1 rules applied. Total rules applied 7615 place count 1200 transition count 1593
Applied a total of 7615 rules in 2906 ms. Remains 1200 /5003 variables (removed 3803) and now considering 1593/5003 (removed 3410) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 2907 ms. Remains : 1200/5003 places, 1593/5003 transitions.
Incomplete random walk after 10000 steps, including 3 resets, run finished after 577 ms. (steps per millisecond=17 ) properties (out of 13) seen :1
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-13 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 12) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 126 ms. (steps per millisecond=79 ) properties (out of 12) seen :1
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-02 FALSE TECHNIQUES TOPOLOGICAL BESTFIRST_WALK
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 115 ms. (steps per millisecond=86 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 46 ms. (steps per millisecond=217 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 43 ms. (steps per millisecond=232 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 73 ms. (steps per millisecond=137 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 69 ms. (steps per millisecond=144 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 81 ms. (steps per millisecond=123 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 72 ms. (steps per millisecond=138 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 102 ms. (steps per millisecond=98 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 45 ms. (steps per millisecond=222 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 70 ms. (steps per millisecond=142 ) properties (out of 11) seen :0
Running SMT prover for 11 properties.
// Phase 1: matrix 1593 rows 1200 cols
[2023-03-18 21:55:11] [INFO ] Computed 400 place invariants in 16 ms
[2023-03-18 21:55:12] [INFO ] After 713ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:11
[2023-03-18 21:55:12] [INFO ] [Nat]Absence check using 400 positive place invariants in 129 ms returned sat
[2023-03-18 21:55:14] [INFO ] After 2148ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :11
[2023-03-18 21:55:14] [INFO ] State equation strengthened by 597 read => feed constraints.
[2023-03-18 21:55:20] [INFO ] After 5217ms SMT Verify possible using 597 Read/Feed constraints in natural domain returned unsat :0 sat :11
[2023-03-18 21:55:20] [INFO ] Deduced a trap composed of 12 places in 300 ms of which 6 ms to minimize.
[2023-03-18 21:55:21] [INFO ] Deduced a trap composed of 12 places in 253 ms of which 1 ms to minimize.
[2023-03-18 21:55:30] [INFO ] Deduced a trap composed of 17 places in 9284 ms of which 27 ms to minimize.
[2023-03-18 21:55:38] [INFO ] Deduced a trap composed of 14 places in 8428 ms of which 2 ms to minimize.
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream close...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.refineWithTraps(DeadlockTester.java:1255)
at fr.lip6.move.gal.structural.smt.DeadlockTester.refineResultsWithTraps(DeadlockTester.java:736)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:656)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMTIncremental(DeadlockTester.java:350)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMT(DeadlockTester.java:223)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.applyReductions(ReachabilitySolver.java:95)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:902)
at fr.lip6.move.gal.application.Application.start(Application.java:178)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:45)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:136)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:104)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:402)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:596)
at org.eclipse.equinox.launcher.Main.run(Main.java:1467)
at org.eclipse.equinox.launcher.Main.main(Main.java:1440)
[2023-03-18 21:55:38] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-18 21:55:38] [INFO ] After 26751ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :0 real:11
Parikh walk visited 0 properties in 260 ms.
Support contains 216 out of 1200 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1200/1200 places, 1593/1593 transitions.
Drop transitions removed 14 transitions
Trivial Post-agglo rules discarded 14 transitions
Performed 14 trivial Post agglomeration. Transition count delta: 14
Iterating post reduction 0 with 14 rules applied. Total rules applied 14 place count 1200 transition count 1579
Reduce places removed 14 places and 0 transitions.
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Iterating post reduction 1 with 15 rules applied. Total rules applied 29 place count 1186 transition count 1578
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 2 with 1 rules applied. Total rules applied 30 place count 1185 transition count 1578
Performed 16 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 3 with 16 Pre rules applied. Total rules applied 30 place count 1185 transition count 1562
Deduced a syphon composed of 16 places in 40 ms
Reduce places removed 16 places and 0 transitions.
Iterating global reduction 3 with 32 rules applied. Total rules applied 62 place count 1169 transition count 1562
Performed 27 Post agglomeration using F-continuation condition.Transition count delta: 27
Deduced a syphon composed of 27 places in 1 ms
Reduce places removed 27 places and 0 transitions.
Iterating global reduction 3 with 54 rules applied. Total rules applied 116 place count 1142 transition count 1535
Performed 11 Post agglomeration using F-continuation condition.Transition count delta: -12
Deduced a syphon composed of 11 places in 20 ms
Reduce places removed 11 places and 0 transitions.
Iterating global reduction 3 with 22 rules applied. Total rules applied 138 place count 1131 transition count 1547
Partial Free-agglomeration rule applied 1 times.
Drop transitions removed 1 transitions
Iterating global reduction 3 with 1 rules applied. Total rules applied 139 place count 1131 transition count 1547
Applied a total of 139 rules in 441 ms. Remains 1131 /1200 variables (removed 69) and now considering 1547/1593 (removed 46) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 456 ms. Remains : 1131/1200 places, 1547/1593 transitions.
Incomplete random walk after 10000 steps, including 3 resets, run finished after 234 ms. (steps per millisecond=42 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 82 ms. (steps per millisecond=121 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 144 ms. (steps per millisecond=69 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 100 ms. (steps per millisecond=100 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 97 ms. (steps per millisecond=103 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 136 ms. (steps per millisecond=73 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 100 ms. (steps per millisecond=100 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10000 steps, including 2 resets, run finished after 114 ms. (steps per millisecond=87 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 89 ms. (steps per millisecond=112 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 91 ms. (steps per millisecond=109 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 92 ms. (steps per millisecond=108 ) properties (out of 11) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 94 ms. (steps per millisecond=106 ) properties (out of 11) seen :0
Interrupted probabilistic random walk after 77020 steps, run timeout after 3001 ms. (steps per millisecond=25 ) properties seen :{}
Probabilistic random walk after 77020 steps, saw 48704 distinct states, run finished after 3014 ms. (steps per millisecond=25 ) properties seen :0
Running SMT prover for 11 properties.
// Phase 1: matrix 1547 rows 1131 cols
[2023-03-18 21:55:44] [INFO ] Computed 400 place invariants in 16 ms
[2023-03-18 21:55:45] [INFO ] After 1033ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:11
[2023-03-18 21:55:45] [INFO ] [Nat]Absence check using 400 positive place invariants in 125 ms returned sat
[2023-03-18 21:55:47] [INFO ] After 1905ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :11
[2023-03-18 21:55:47] [INFO ] State equation strengthened by 643 read => feed constraints.
[2023-03-18 21:55:51] [INFO ] After 4361ms SMT Verify possible using 643 Read/Feed constraints in natural domain returned unsat :0 sat :11
[2023-03-18 21:55:53] [INFO ] Deduced a trap composed of 24 places in 166 ms of which 1 ms to minimize.
[2023-03-18 21:55:53] [INFO ] Deduced a trap composed of 24 places in 191 ms of which 1 ms to minimize.
[2023-03-18 21:55:59] [INFO ] Deduced a trap composed of 12 places in 5085 ms of which 26 ms to minimize.
[2023-03-18 21:56:05] [INFO ] Deduced a trap composed of 14 places in 6627 ms of which 27 ms to minimize.
[2023-03-18 21:56:05] [INFO ] Trap strengthening (SAT) tested/added 5/4 trap constraints in 12459 ms
[2023-03-18 21:56:23] [INFO ] Deduced a trap composed of 22 places in 17081 ms of which 8 ms to minimize.
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream close...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.refineWithTraps(DeadlockTester.java:1255)
at fr.lip6.move.gal.structural.smt.DeadlockTester.refineResultsWithTraps(DeadlockTester.java:736)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:656)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMTIncremental(DeadlockTester.java:350)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMT(DeadlockTester.java:223)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.applyReductions(ReachabilitySolver.java:95)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:902)
at fr.lip6.move.gal.application.Application.start(Application.java:178)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:45)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:136)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:104)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:402)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:596)
at org.eclipse.equinox.launcher.Main.run(Main.java:1467)
at org.eclipse.equinox.launcher.Main.main(Main.java:1440)
[2023-03-18 21:56:23] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-18 21:56:23] [INFO ] After 38627ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :0 real:11
Parikh walk visited 0 properties in 409 ms.
Support contains 216 out of 1131 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1131/1131 places, 1547/1547 transitions.
Applied a total of 0 rules in 24 ms. Remains 1131 /1131 variables (removed 0) and now considering 1547/1547 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 24 ms. Remains : 1131/1131 places, 1547/1547 transitions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 1131/1131 places, 1547/1547 transitions.
Applied a total of 0 rules in 65 ms. Remains 1131 /1131 variables (removed 0) and now considering 1547/1547 (removed 0) transitions.
[2023-03-18 21:56:24] [INFO ] Invariant cache hit.
[2023-03-18 21:56:25] [INFO ] Implicit Places using invariants in 976 ms returned []
[2023-03-18 21:56:25] [INFO ] Invariant cache hit.
[2023-03-18 21:56:26] [INFO ] State equation strengthened by 643 read => feed constraints.
[2023-03-18 21:56:37] [INFO ] Implicit Places using invariants and state equation in 12157 ms returned []
Implicit Place search using SMT with State Equation took 13164 ms to find 0 implicit places.
[2023-03-18 21:56:37] [INFO ] Redundant transitions in 225 ms returned []
[2023-03-18 21:56:37] [INFO ] Invariant cache hit.
[2023-03-18 21:56:38] [INFO ] Dead Transitions using invariants and state equation in 906 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 14385 ms. Remains : 1131/1131 places, 1547/1547 transitions.
Graph (trivial) has 251 edges and 1131 vertex of which 2 / 1131 are part of one of the 1 SCC in 2 ms
Free SCC test removed 1 places
Drop transitions removed 2 transitions
Reduce isomorphic transitions removed 2 transitions.
Reduce places removed 1 places and 0 transitions.
Ensure Unique test removed 2 transitions
Reduce isomorphic transitions removed 2 transitions.
Iterating post reduction 0 with 3 rules applied. Total rules applied 4 place count 1129 transition count 1543
Performed 1 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 1 with 1 Pre rules applied. Total rules applied 4 place count 1129 transition count 1542
Deduced a syphon composed of 1 places in 2 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 1 with 2 rules applied. Total rules applied 6 place count 1128 transition count 1542
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 2 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 1 with 2 rules applied. Total rules applied 8 place count 1127 transition count 1541
Drop transitions removed 64 transitions
Redundant transition composition rules discarded 64 transitions
Iterating global reduction 1 with 64 rules applied. Total rules applied 72 place count 1127 transition count 1477
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 1 with 1 rules applied. Total rules applied 73 place count 1126 transition count 1477
Partial Free-agglomeration rule applied 60 times.
Drop transitions removed 60 transitions
Iterating global reduction 2 with 60 rules applied. Total rules applied 133 place count 1126 transition count 1477
Drop transitions removed 41 transitions
Redundant transition composition rules discarded 41 transitions
Iterating global reduction 2 with 41 rules applied. Total rules applied 174 place count 1126 transition count 1436
Applied a total of 174 rules in 251 ms. Remains 1126 /1131 variables (removed 5) and now considering 1436/1547 (removed 111) transitions.
Running SMT prover for 11 properties.
// Phase 1: matrix 1436 rows 1126 cols
[2023-03-18 21:56:38] [INFO ] Computed 398 place invariants in 5 ms
[2023-03-18 21:56:39] [INFO ] After 294ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0 real:11
[2023-03-18 21:56:39] [INFO ] [Nat]Absence check using 398 positive place invariants in 102 ms returned sat
[2023-03-18 21:56:41] [INFO ] After 1706ms SMT Verify possible using state equation in natural domain returned unsat :0 sat :11
[2023-03-18 21:56:41] [INFO ] Deduced a trap composed of 5 places in 179 ms of which 1 ms to minimize.
[2023-03-18 21:56:41] [INFO ] Deduced a trap composed of 9 places in 188 ms of which 1 ms to minimize.
[2023-03-18 21:56:42] [INFO ] Deduced a trap composed of 20 places in 168 ms of which 0 ms to minimize.
[2023-03-18 21:56:42] [INFO ] Deduced a trap composed of 22 places in 160 ms of which 0 ms to minimize.
[2023-03-18 21:56:42] [INFO ] Deduced a trap composed of 30 places in 159 ms of which 0 ms to minimize.
[2023-03-18 21:56:42] [INFO ] Deduced a trap composed of 13 places in 147 ms of which 0 ms to minimize.
[2023-03-18 21:56:43] [INFO ] Deduced a trap composed of 25 places in 156 ms of which 1 ms to minimize.
[2023-03-18 21:56:43] [INFO ] Trap strengthening (SAT) tested/added 8/7 trap constraints in 1634 ms
[2023-03-18 21:56:43] [INFO ] Deduced a trap composed of 16 places in 197 ms of which 1 ms to minimize.
[2023-03-18 21:56:43] [INFO ] Deduced a trap composed of 12 places in 156 ms of which 1 ms to minimize.
[2023-03-18 21:56:43] [INFO ] Deduced a trap composed of 12 places in 158 ms of which 0 ms to minimize.
[2023-03-18 21:56:44] [INFO ] Deduced a trap composed of 11 places in 155 ms of which 1 ms to minimize.
[2023-03-18 21:56:44] [INFO ] Deduced a trap composed of 26 places in 188 ms of which 1 ms to minimize.
[2023-03-18 21:56:44] [INFO ] Deduced a trap composed of 24 places in 150 ms of which 1 ms to minimize.
[2023-03-18 21:56:44] [INFO ] Deduced a trap composed of 13 places in 149 ms of which 1 ms to minimize.
[2023-03-18 21:56:44] [INFO ] Trap strengthening (SAT) tested/added 8/7 trap constraints in 1705 ms
[2023-03-18 21:56:45] [INFO ] Deduced a trap composed of 12 places in 97 ms of which 1 ms to minimize.
[2023-03-18 21:56:45] [INFO ] Deduced a trap composed of 15 places in 120 ms of which 1 ms to minimize.
[2023-03-18 21:56:45] [INFO ] Trap strengthening (SAT) tested/added 3/2 trap constraints in 435 ms
[2023-03-18 21:56:45] [INFO ] Deduced a trap composed of 30 places in 101 ms of which 1 ms to minimize.
[2023-03-18 21:56:45] [INFO ] Trap strengthening (SAT) tested/added 2/1 trap constraints in 201 ms
[2023-03-18 21:56:46] [INFO ] Deduced a trap composed of 25 places in 106 ms of which 1 ms to minimize.
[2023-03-18 21:56:46] [INFO ] Deduced a trap composed of 13 places in 123 ms of which 0 ms to minimize.
[2023-03-18 21:56:46] [INFO ] Deduced a trap composed of 10 places in 113 ms of which 1 ms to minimize.
[2023-03-18 21:56:46] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 588 ms
[2023-03-18 21:56:47] [INFO ] Deduced a trap composed of 12 places in 111 ms of which 0 ms to minimize.
[2023-03-18 21:56:47] [INFO ] Deduced a trap composed of 24 places in 116 ms of which 1 ms to minimize.
[2023-03-18 21:56:47] [INFO ] Deduced a trap composed of 14 places in 88 ms of which 1 ms to minimize.
[2023-03-18 21:56:47] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 617 ms
[2023-03-18 21:56:48] [INFO ] After 8360ms SMT Verify possible using trap constraints in natural domain returned unsat :0 sat :11
Attempting to minimize the solution found.
Minimization took 1343 ms.
[2023-03-18 21:56:49] [INFO ] After 10265ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :11
[2023-03-18 21:56:49] [INFO ] Flatten gal took : 71 ms
[2023-03-18 21:56:49] [INFO ] Flatten gal took : 61 ms
[2023-03-18 21:56:49] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality4130690672139655850.gal : 13 ms
[2023-03-18 21:56:49] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality4474487035994313249.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality4130690672139655850.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality4474487035994313249.prop' '--nowitness' '--gen-order' 'FOLLOW'
its-reach command run as :
/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...328
Loading property file /tmp/ReachabilityCardinality4474487035994313249.prop.
SDD proceeding with computation,11 properties remain. new max is 4
SDD size :1 after 5
SDD proceeding with computation,11 properties remain. new max is 8
SDD size :5 after 10
SDD proceeding with computation,11 properties remain. new max is 16
SDD size :10 after 19
SDD proceeding with computation,11 properties remain. new max is 32
SDD size :19 after 22
SDD proceeding with computation,11 properties remain. new max is 64
SDD size :22 after 49
SDD proceeding with computation,11 properties remain. new max is 128
SDD size :49 after 267319
SDD proceeding with computation,11 properties remain. new max is 256
SDD size :267319 after 3.49192e+12
SDD proceeding with computation,11 properties remain. new max is 512
SDD size :3.49192e+12 after 1.64185e+24
Detected timeout of ITS tools.
[2023-03-18 21:57:04] [INFO ] Flatten gal took : 58 ms
[2023-03-18 21:57:04] [INFO ] Applying decomposition
[2023-03-18 21:57:04] [INFO ] Flatten gal took : 47 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph4777726495611280757.txt' '-o' '/tmp/graph4777726495611280757.bin' '-w' '/tmp/graph4777726495611280757.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph4777726495611280757.bin' '-l' '-1' '-v' '-w' '/tmp/graph4777726495611280757.weights' '-q' '0' '-e' '0.001'
[2023-03-18 21:57:05] [INFO ] Decomposing Gal with order
[2023-03-18 21:57:05] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-18 21:57:05] [INFO ] Removed a total of 1243 redundant transitions.
[2023-03-18 21:57:05] [INFO ] Flatten gal took : 132 ms
[2023-03-18 21:57:05] [INFO ] Fuse similar labels procedure discarded/fused a total of 22 labels/synchronizations in 42 ms.
[2023-03-18 21:57:05] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality12949419880179264910.gal : 19 ms
[2023-03-18 21:57:05] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality10205946591154922326.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality12949419880179264910.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality10205946591154922326.prop' '--nowitness'
its-reach command run as :
/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...309
Loading property file /tmp/ReachabilityCardinality10205946591154922326.prop.
SDD proceeding with computation,11 properties remain. new max is 4
SDD size :1 after 1
SDD proceeding with computation,11 properties remain. new max is 8
SDD size :1 after 225
SDD proceeding with computation,11 properties remain. new max is 16
SDD size :225 after 131553
SDD proceeding with computation,11 properties remain. new max is 32
SDD size :131553 after 1.84732e+08
SDD proceeding with computation,11 properties remain. new max is 64
SDD size :1.84732e+08 after 4.7037e+11
SDD proceeding with computation,11 properties remain. new max is 128
SDD size :4.7037e+11 after 1.36821e+23
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
petri\_inst\_inst\_mod\_flat,3.10877e+155,6.05187,205556,3571,55,436411,536,2797,910583,118,1390,0
Total reachable state count : 3.108774559738317044871186279474071137849e+155
Verifying 11 reachability properties.
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-01 does not hold.
No reachable states exhibit your property : ShieldRVt-PT-100B-ReachabilityFireability-01
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-01,0,6.0761,205556,1,0,436411,536,2822,910583,126,1390,1311
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-04 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-04,1.15144e+130,6.09942,205556,1933,43,436411,536,2956,910583,129,1390,3055
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-05 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-05,3.22897e+112,6.11684,205556,1078,43,436411,536,2974,910583,129,1390,4292
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-06 does not hold.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-06,1.14998e+130,6.12402,205556,2580,43,436411,536,2975,910583,129,1390,4662
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-07 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-07,2.39413e+141,6.15116,205556,3443,48,436411,536,3011,910583,129,1390,6917
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-08 does not hold.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-08,1.59742e+152,6.17513,205556,1653,45,436411,536,3063,910583,129,1390,8954
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-09 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-09,6.12665e+68,6.20295,205556,808,40,436411,536,3146,910583,130,1390,15224
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-10 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-10,5.96792e+119,6.20575,205556,2140,44,436411,536,3146,910583,130,1390,15224
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-12 does not hold.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-12,5.17984e+152,6.24223,205556,2876,50,436411,536,3225,910583,130,1390,19232
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-14 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-14,7.66651e+129,6.24558,205556,2414,43,436411,536,3225,910583,130,1390,19232
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-15 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-15,1.31425e+151,6.24806,205556,2271,46,436411,536,3225,910583,130,1390,19232
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-01 FALSE TECHNIQUES OVER_APPROXIMATION
ITS runner failed with exception null
java.lang.InterruptedException
at java.base/java.lang.Object.wait(Native Method)
at java.base/java.lang.Thread.join(Thread.java:1304)
at java.base/java.lang.Thread.join(Thread.java:1372)
at fr.lip6.move.gal.application.runner.AbstractRunner.join(AbstractRunner.java:27)
at fr.lip6.move.gal.application.runner.its.ITSRunner.join(ITSRunner.java:177)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.verifyWithSDD(GlobalPropertySolver.java:675)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.lambda$2(ReachabilitySolver.java:63)
at java.base/java.lang.Thread.run(Thread.java:833)
[2023-03-18 21:57:12] [INFO ] Flatten gal took : 159 ms
[2023-03-18 21:57:12] [INFO ] Applying decomposition
[2023-03-18 21:57:12] [INFO ] Flatten gal took : 165 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph17987296873802554428.txt' '-o' '/tmp/graph17987296873802554428.bin' '-w' '/tmp/graph17987296873802554428.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph17987296873802554428.bin' '-l' '-1' '-v' '-w' '/tmp/graph17987296873802554428.weights' '-q' '0' '-e' '0.001'
[2023-03-18 21:57:12] [INFO ] Decomposing Gal with order
[2023-03-18 21:57:13] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-18 21:57:13] [INFO ] Removed a total of 600 redundant transitions.
[2023-03-18 21:57:13] [INFO ] Flatten gal took : 270 ms
[2023-03-18 21:57:14] [INFO ] Fuse similar labels procedure discarded/fused a total of 0 labels/synchronizations in 20 ms.
[2023-03-18 21:57:14] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality605525529486234095.gal : 39 ms
[2023-03-18 21:57:14] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality4840635283580095074.prop : 3 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality605525529486234095.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality4840635283580095074.prop' '--nowitness'
its-reach command run as :
/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...306
Loading property file /tmp/ReachabilityCardinality4840635283580095074.prop.
SDD proceeding with computation,10 properties remain. new max is 4
SDD size :1 after 1
SDD proceeding with computation,10 properties remain. new max is 8
SDD size :1 after 83
SDD proceeding with computation,10 properties remain. new max is 16
SDD size :83 after 1218
SDD proceeding with computation,10 properties remain. new max is 32
SDD size :1218 after 3212
SDD proceeding with computation,10 properties remain. new max is 64
SDD size :3212 after 2.07289e+15
SDD proceeding with computation,10 properties remain. new max is 128
SDD size :2.07289e+15 after 2.84419e+57
Detected timeout of ITS tools.
Detected timeout of ITS tools.
[2023-03-18 22:27:16] [INFO ] Flatten gal took : 542 ms
Using solver Z3 to compute partial order matrices.
Built C files in :
/tmp/ltsmin15967358806562626344
[2023-03-18 22:27:17] [INFO ] Too many transitions (1547) to apply POR reductions. Disabling POR matrices.
[2023-03-18 22:27:17] [INFO ] Applying decomposition
[2023-03-18 22:27:17] [INFO ] Built C files in 291ms conformant to PINS (ltsmin variant)in folder :/tmp/ltsmin15967358806562626344
Running compilation step : cd /tmp/ltsmin15967358806562626344;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/limit_time.pl' '72' 'gcc' '-c' '-I/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/include/' '-I.' '-std=c99' '-fPIC' '-O0' 'model.c'
[2023-03-18 22:27:17] [INFO ] Flatten gal took : 439 ms
Converted graph to binary with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/convert-linux64' '-i' '/tmp/graph3851401095367874300.txt' '-o' '/tmp/graph3851401095367874300.bin' '-w' '/tmp/graph3851401095367874300.weights'
Built communities with : '/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202303021504/bin/louvain-linux64' '/tmp/graph3851401095367874300.bin' '-l' '-1' '-v' '-w' '/tmp/graph3851401095367874300.weights' '-q' '0' '-e' '0.001'
[2023-03-18 22:27:19] [INFO ] Decomposing Gal with order
[2023-03-18 22:27:19] [INFO ] Rewriting arrays to variables to allow decomposition.
[2023-03-18 22:27:19] [INFO ] Removed a total of 1878 redundant transitions.
[2023-03-18 22:27:19] [INFO ] Flatten gal took : 146 ms
[2023-03-18 22:27:20] [INFO ] Fuse similar labels procedure discarded/fused a total of 826 labels/synchronizations in 418 ms.
[2023-03-18 22:27:20] [INFO ] Time to serialize gal into /tmp/ReachabilityFireability2592974615096339271.gal : 56 ms
[2023-03-18 22:27:20] [INFO ] Time to serialize properties into /tmp/ReachabilityFireability4571714155983601964.prop : 1 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityFireability2592974615096339271.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityFireability4571714155983601964.prop' '--nowitness'
its-reach command run as :
/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202303021504/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...307
Loading property file /tmp/ReachabilityFireability4571714155983601964.prop.
SDD proceeding with computation,10 properties remain. new max is 4
SDD size :1 after 1
SDD proceeding with computation,10 properties remain. new max is 8
SDD size :1 after 1
SDD proceeding with computation,10 properties remain. new max is 16
SDD size :1 after 441
SDD proceeding with computation,10 properties remain. new max is 32
SDD size :441 after 3.01839e+06
SDD proceeding with computation,10 properties remain. new max is 64
SDD size :3.01839e+06 after 2.85194e+08
SDD proceeding with computation,10 properties remain. new max is 128
SDD size :2.85194e+08 after 4.88762e+16
SDD proceeding with computation,10 properties remain. new max is 256
SDD size :4.88762e+16 after 7.60115e+21
SDD proceeding with computation,10 properties remain. new max is 512
SDD size :7.60115e+21 after 1.47766e+25
Compilation finished in 4075 ms.
Running link step : cd /tmp/ltsmin15967358806562626344;'gcc' '-shared' '-o' 'gal.so' 'model.o'
Link finished in 122 ms.
Running LTSmin : cd /tmp/ltsmin15967358806562626344;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.ltsmin.binaries_1.0.0.202303021504/bin/pins2lts-mc-linux64' './gal.so' '--threads=8' '-p' '--pins-guards' '--when' '-i' 'ShieldRVtPT100BReachabilityFireability04==true'
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-15 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-15 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-14 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-14 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-10 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-10 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-09 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-09 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-07 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-07 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-06 does not hold.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-06 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-05 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-05 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-04 is true.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-04 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
SDD proceeding with computation,2 properties remain. new max is 512
SDD size :5.62262e+36 after 7.13689e+146
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
petri\_inst\_inst\_mod\_flat,4.37185e+155,12.4992,198440,3099,357,427967,6101,2320,882910,317,39398,0
Total reachable state count : 4.371845271150071855353177362235184784947e+155
Verifying 10 reachability properties.
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-04 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-04,1.73707e+152,12.5378,198440,1931,304,427967,6101,2495,882910,329,39398,1673
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-05 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-05,4.30378e+139,12.5482,198440,1283,178,427967,6101,2552,882910,332,39398,3067
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-06 does not hold.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-06,2.59493e+153,12.5518,198440,1860,252,427967,6101,2557,882910,332,39398,3161
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-07 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-07,2.29939e+153,12.5687,198440,2414,314,427967,6101,2642,882910,332,39398,4787
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-08 does not hold.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-08 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-08,2.394e+152,12.5829,198440,1623,218,427967,6101,2695,882910,333,39398,6650
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-09 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-09,4.38881e+142,12.6131,198440,1398,183,427967,6101,2881,882910,334,39398,12676
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-10 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-10,5.06587e+148,12.615,198440,1696,225,427967,6101,2882,882910,334,39398,12676
Invariant property ShieldRVt-PT-100B-ReachabilityFireability-12 does not hold.
FORMULA ShieldRVt-PT-100B-ReachabilityFireability-12 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL COLLATERAL_PROCESSING USE_NUPN
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-12,7.28438e+152,12.642,198440,2707,248,427967,6101,2981,882910,335,39398,16203
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-14 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-14,2.36562e+86,12.6432,198440,832,139,427967,6101,2982,882910,335,39398,16203
Reachability property ShieldRVt-PT-100B-ReachabilityFireability-15 is true.
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
ShieldRVt-PT-100B-ReachabilityFireability-15,1.40703e+154,12.6455,198440,2124,314,427967,6101,2984,882910,335,39398,16203
WARNING : LTS min runner thread was asked to interrupt. Dying gracefully.
Total runtime 1991791 ms.
BK_STOP 1679178467190
--------------------
content from stderr:
+ export BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ ReachabilityFireability = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution ReachabilityFireability -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202303021504.jar
+ VERSION=202303021504
+ echo 'Running Version 202303021504'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination ReachabilityFireability -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 3600
Sequence of Actions to be Executed by the VM
This is useful if one wants to reexecute the tool in the VM from the submitted image disk.
set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="ShieldRVt-PT-100B"
export BK_EXAMINATION="ReachabilityFireability"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"
# this is specific to your benchmark or test
export BIN_DIR="$HOME/BenchKit/bin"
# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi
# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-5348"
echo " Executing tool itstools"
echo " Input is ShieldRVt-PT-100B, examination is ReachabilityFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r421-tajo-167905975100351"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/ShieldRVt-PT-100B.tgz
mv ShieldRVt-PT-100B execution
cd execution
if [ "ReachabilityFireability" = "ReachabilityDeadlock" ] || [ "ReachabilityFireability" = "UpperBounds" ] || [ "ReachabilityFireability" = "QuasiLiveness" ] || [ "ReachabilityFireability" = "StableMarking" ] || [ "ReachabilityFireability" = "Liveness" ] || [ "ReachabilityFireability" = "OneSafe" ] || [ "ReachabilityFireability" = "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 [ "ReachabilityFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityFireability" != "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 "ReachabilityFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityFireability.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 [ "ReachabilityFireability" = "ReachabilityDeadlock" ] || [ "ReachabilityFireability" = "QuasiLiveness" ] || [ "ReachabilityFireability" = "StableMarking" ] || [ "ReachabilityFireability" = "Liveness" ] || [ "ReachabilityFireability" = "OneSafe" ] ; then
echo "FORMULA_NAME ReachabilityFireability"
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 ;