About the Execution of Marcie+red for Sudoku-COL-AN15
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
9625.432 | 3600000.00 | 3711308.00 | 9828.40 | ??T???FT?F??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.r490-tall-167912708200113.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 Sudoku-COL-AN15, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r490-tall-167912708200113
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 424K
-rw-r--r-- 1 mcc users 8.8K Feb 26 09:59 CTLCardinality.txt
-rw-r--r-- 1 mcc users 97K Feb 26 09:59 CTLCardinality.xml
-rw-r--r-- 1 mcc users 5.0K Feb 26 08:56 CTLFireability.txt
-rw-r--r-- 1 mcc users 42K Feb 26 08:56 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.5K Feb 25 17:17 LTLCardinality.txt
-rw-r--r-- 1 mcc users 23K Feb 25 17:17 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Feb 25 17:17 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Feb 25 17:17 LTLFireability.xml
-rw-r--r-- 1 mcc users 7.9K Feb 26 10:46 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 74K Feb 26 10:46 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 8.1K Feb 26 10:08 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 65K Feb 26 10:08 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 25 17:17 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.6K Feb 25 17:17 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 equiv_pt
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 instance
-rw-r--r-- 1 mcc users 5 Mar 5 18:23 iscolored
-rw-r--r-- 1 mcc users 6.5K 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 Sudoku-COL-AN15-CTLCardinality-00
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-01
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-02
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-03
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-04
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-05
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-06
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-07
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-08
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-09
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-10
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-11
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-12
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-13
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-14
FORMULA_NAME Sudoku-COL-AN15-CTLCardinality-15
=== Now, execution of the tool begins
BK_START 1679188285055
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=CTLCardinality
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=3600
BK_INPUT=Sudoku-COL-AN15
Applying reductions before tool marcie
Invoking reducer
Running Version 202303021504
[2023-03-19 01:11:26] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, CTLCardinality, -timeout, 360, -rebuildPNML]
[2023-03-19 01:11:26] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2023-03-19 01:11:26] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
log4j:WARN No appenders could be found for logger (org.apache.axiom.locator.DefaultOMMetaFactoryLocator).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
[2023-03-19 01:11:26] [WARNING] Using fallBack plugin, rng conformance not checked
[2023-03-19 01:11:27] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 584 ms
[2023-03-19 01:11:27] [INFO ] Imported 4 HL places and 1 HL transitions for a total of 4050 PT places and 3375.0 transition bindings in 10 ms.
Parsed 16 properties from file /home/mcc/execution/CTLCardinality.xml in 21 ms.
[2023-03-19 01:11:27] [INFO ] Built PT skeleton of HLPN with 4 places and 1 transitions 4 arcs in 4 ms.
[2023-03-19 01:11:27] [INFO ] Skeletonized 16 HLPN properties in 2 ms.
Computed a total of 4 stabilizing places and 1 stable transitions
Complete graph has no SCC; deadlocks are unavoidable. place count 4 transition count 1
Detected that all paths lead to deadlock. Applying this knowledge to assert that all AP eventually converge (and all enablings converge to false).
AF dead knowledge conclusive for 2 formulas.
Remains 16 properties that can be checked using skeleton over-approximation.
Computed a total of 4 stabilizing places and 1 stable transitions
Complete graph has no SCC; deadlocks are unavoidable. place count 4 transition count 1
Detected that all paths lead to deadlock. Applying this knowledge to assert that all AP eventually converge (and all enablings converge to false).
Incomplete random walk after 10214 steps, including 44 resets, run finished after 38 ms. (steps per millisecond=268 ) properties (out of 85) seen :69
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 12 ms. (steps per millisecond=94 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 2 ms. (steps per millisecond=567 ) properties (out of 16) seen :0
Incomplete Best-First random walk after 1134 steps, including 4 resets, run finished after 3 ms. (steps per millisecond=378 ) properties (out of 16) seen :0
Running SMT prover for 16 properties.
// Phase 1: matrix 1 rows 4 cols
[2023-03-19 01:11:27] [INFO ] Computed 3 place invariants in 3 ms
[2023-03-19 01:11:27] [INFO ] [Real]Absence check using 3 positive place invariants in 1 ms returned sat
[2023-03-19 01:11:27] [INFO ] After 4ms SMT Verify possible using state equation in real domain returned unsat :7 sat :1 real:8
[2023-03-19 01:11:27] [INFO ] After 8ms SMT Verify possible using trap constraints in real domain returned unsat :7 sat :1 real:8
Attempting to minimize the solution found.
Minimization took 5 ms.
[2023-03-19 01:11:27] [INFO ] After 179ms SMT Verify possible using all constraints in real domain returned unsat :7 sat :1 real:8
[2023-03-19 01:11:27] [INFO ] [Nat]Absence check using 3 positive place invariants in 1 ms returned sat
[2023-03-19 01:11:27] [INFO ] After 8ms SMT Verify possible using state equation in natural domain returned unsat :13 sat :3
[2023-03-19 01:11:27] [INFO ] After 14ms SMT Verify possible using trap constraints in natural domain returned unsat :13 sat :3
Attempting to minimize the solution found.
Minimization took 4 ms.
[2023-03-19 01:11:27] [INFO ] After 58ms SMT Verify possible using all constraints in natural domain returned unsat :13 sat :3
Fused 16 Parikh solutions to 3 different solutions.
Finished Parikh walk after 143 steps, including 0 resets, run visited all 1 properties in 2 ms. (steps per millisecond=71 )
Parikh walk visited 3 properties in 9 ms.
Successfully simplified 13 atomic propositions for a total of 16 simplifications.
FORMULA Sudoku-COL-AN15-CTLCardinality-06 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-19 01:11:27] [INFO ] Initial state reduction rules for CTL removed 2 formulas.
[2023-03-19 01:11:27] [INFO ] Flatten gal took : 18 ms
FORMULA Sudoku-COL-AN15-CTLCardinality-12 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA Sudoku-COL-AN15-CTLCardinality-09 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-19 01:11:27] [INFO ] Flatten gal took : 1 ms
Domain [N(15), N(15)] of place Rows breaks symmetries in sort N
[2023-03-19 01:11:27] [INFO ] Unfolded HLPN to a Petri net with 4050 places and 3375 transitions 13500 arcs in 66 ms.
[2023-03-19 01:11:27] [INFO ] Unfolded 13 HLPN properties in 8 ms.
Support contains 4050 out of 4050 places. Attempting structural reductions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 33 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
// Phase 1: matrix 3375 rows 4050 cols
[2023-03-19 01:11:28] [INFO ] Computed 675 place invariants in 47 ms
[2023-03-19 01:11:28] [INFO ] Implicit Places using invariants in 680 ms returned []
[2023-03-19 01:11:28] [INFO ] Invariant cache hit.
[2023-03-19 01:11:29] [INFO ] Implicit Places using invariants and state equation in 370 ms returned []
Implicit Place search using SMT with State Equation took 1055 ms to find 0 implicit places.
[2023-03-19 01:11:29] [INFO ] Invariant cache hit.
[2023-03-19 01:11:31] [INFO ] Dead Transitions using invariants and state equation in 2050 ms found 0 transitions.
Finished structural reductions in LTL mode , in 1 iterations and 3140 ms. Remains : 4050/4050 places, 3375/3375 transitions.
Support contains 4050 out of 4050 places after structural reductions.
[2023-03-19 01:11:31] [INFO ] Flatten gal took : 357 ms
[2023-03-19 01:11:32] [INFO ] Flatten gal took : 245 ms
[2023-03-19 01:11:34] [INFO ] Input system was already deterministic with 3375 transitions.
Incomplete random walk after 10000 steps, including 50 resets, run finished after 5081 ms. (steps per millisecond=1 ) properties (out of 68) seen :50
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 32 ms. (steps per millisecond=31 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 100 ms. (steps per millisecond=10 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 99 ms. (steps per millisecond=10 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 104 ms. (steps per millisecond=9 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 32 ms. (steps per millisecond=31 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 31 ms. (steps per millisecond=32 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 18 ms. (steps per millisecond=55 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 30 ms. (steps per millisecond=33 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 148 ms. (steps per millisecond=6 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 31 ms. (steps per millisecond=32 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 45 ms. (steps per millisecond=22 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 31 ms. (steps per millisecond=32 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 149 ms. (steps per millisecond=6 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 39 ms. (steps per millisecond=25 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 27 ms. (steps per millisecond=37 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 17 ms. (steps per millisecond=58 ) properties (out of 18) seen :0
Incomplete Best-First random walk after 1001 steps, including 0 resets, run finished after 83 ms. (steps per millisecond=12 ) properties (out of 18) seen :0
Running SMT prover for 18 properties.
[2023-03-19 01:11:40] [INFO ] Invariant cache hit.
[2023-03-19 01:11:46] [INFO ] After 1513ms SMT Verify possible using all constraints in real domain returned unsat :1 sat :0 real:17
[2023-03-19 01:11:47] [INFO ] [Nat]Absence check using 675 positive place invariants in 198 ms returned sat
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:629)
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.solver.logic.AtomicReducerSR.checkAtomicPropositionsLogic(AtomicReducerSR.java:105)
at fr.lip6.move.gal.application.solver.logic.AtomicReducerSR.strongReductions(AtomicReducerSR.java:44)
at fr.lip6.move.gal.application.solver.ltl.LTLPropertySolver.preSolveForLogic(LTLPropertySolver.java:176)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:626)
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-19 01:12:11] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-19 01:12:11] [INFO ] After 25054ms SMT Verify possible using all constraints in natural domain returned unsat :1 sat :0 real:17
Fused 18 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 0 ms.
Support contains 4050 out of 4050 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 67 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 67 ms. Remains : 4050/4050 places, 3375/3375 transitions.
Incomplete random walk after 10000 steps, including 50 resets, run finished after 4716 ms. (steps per millisecond=2 ) properties (out of 8) seen :1
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 960 ms. (steps per millisecond=10 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 138 ms. (steps per millisecond=72 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 410 ms. (steps per millisecond=24 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 340 ms. (steps per millisecond=29 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 135 ms. (steps per millisecond=74 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 139 ms. (steps per millisecond=71 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 819 ms. (steps per millisecond=12 ) properties (out of 7) seen :0
Running SMT prover for 7 properties.
[2023-03-19 01:12:18] [INFO ] Invariant cache hit.
[2023-03-19 01:12:20] [INFO ] [Real]Absence check using 675 positive place invariants in 211 ms returned sat
[2023-03-19 01:12:25] [INFO ] After 2785ms SMT Verify possible using state equation in real domain returned unsat :0 sat :3 real:4
[2023-03-19 01:12:26] [INFO ] After 3662ms SMT Verify possible using trap constraints in real domain returned unsat :0 sat :3 real:4
Attempting to minimize the solution found.
Minimization took 469 ms.
[2023-03-19 01:12:26] [INFO ] After 6831ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :3 real:4
[2023-03-19 01:12:27] [INFO ] [Nat]Absence check using 675 positive place invariants in 220 ms returned sat
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:629)
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.solver.logic.AtomicReducerSR.checkAtomicPropositionsLogic(AtomicReducerSR.java:105)
at fr.lip6.move.gal.application.solver.logic.AtomicReducerSR.strongReductions(AtomicReducerSR.java:44)
at fr.lip6.move.gal.application.solver.ltl.LTLPropertySolver.preSolveForLogic(LTLPropertySolver.java:176)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:626)
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-19 01:12:51] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-19 01:12:51] [INFO ] After 25051ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :3 real:4
Fused 7 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 0 ms.
Support contains 4050 out of 4050 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 44 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 44 ms. Remains : 4050/4050 places, 3375/3375 transitions.
Incomplete random walk after 10000 steps, including 50 resets, run finished after 4615 ms. (steps per millisecond=2 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 973 ms. (steps per millisecond=10 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 147 ms. (steps per millisecond=68 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 415 ms. (steps per millisecond=24 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 348 ms. (steps per millisecond=28 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 146 ms. (steps per millisecond=68 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 148 ms. (steps per millisecond=67 ) properties (out of 7) seen :0
Incomplete Best-First random walk after 10001 steps, including 2 resets, run finished after 817 ms. (steps per millisecond=12 ) properties (out of 7) seen :0
Probabilistic random walk after 149501 steps, saw 149450 distinct states, run finished after 21131 ms. (steps per millisecond=7 ) properties seen :0
Running SMT prover for 7 properties.
[2023-03-19 01:13:20] [INFO ] Invariant cache hit.
[2023-03-19 01:13:22] [INFO ] [Real]Absence check using 675 positive place invariants in 202 ms returned sat
[2023-03-19 01:13:26] [INFO ] After 2807ms SMT Verify possible using state equation in real domain returned unsat :0 sat :3 real:4
[2023-03-19 01:13:27] [INFO ] After 3551ms SMT Verify possible using trap constraints in real domain returned unsat :0 sat :3 real:4
Attempting to minimize the solution found.
Minimization took 460 ms.
[2023-03-19 01:13:27] [INFO ] After 6566ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :3 real:4
[2023-03-19 01:13:28] [INFO ] [Nat]Absence check using 675 positive place invariants in 205 ms returned sat
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Error writing to Z3 solver: java.io.IOException: Stream closed...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:629)
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.solver.logic.AtomicReducerSR.checkAtomicPropositionsLogic(AtomicReducerSR.java:105)
at fr.lip6.move.gal.application.solver.logic.AtomicReducerSR.strongReductions(AtomicReducerSR.java:44)
at fr.lip6.move.gal.application.solver.ltl.LTLPropertySolver.preSolveForLogic(LTLPropertySolver.java:176)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:626)
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-19 01:13:52] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2023-03-19 01:13:52] [INFO ] After 25029ms SMT Verify possible using all constraints in natural domain returned unsat :0 sat :3 real:4
Fused 7 Parikh solutions to 1 different solutions.
Parikh walk visited 0 properties in 0 ms.
Support contains 4050 out of 4050 places. Attempting structural reductions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 44 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 45 ms. Remains : 4050/4050 places, 3375/3375 transitions.
Starting structural reductions in REACHABILITY mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 61 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
[2023-03-19 01:13:52] [INFO ] Invariant cache hit.
[2023-03-19 01:13:53] [INFO ] Implicit Places using invariants in 604 ms returned []
[2023-03-19 01:13:53] [INFO ] Invariant cache hit.
[2023-03-19 01:13:54] [INFO ] Implicit Places using invariants and state equation in 840 ms returned []
Implicit Place search using SMT with State Equation took 1477 ms to find 0 implicit places.
[2023-03-19 01:13:54] [INFO ] Redundant transitions in 211 ms returned []
[2023-03-19 01:13:54] [INFO ] Invariant cache hit.
[2023-03-19 01:13:56] [INFO ] Dead Transitions using invariants and state equation in 1908 ms found 0 transitions.
Finished structural reductions in REACHABILITY mode , in 1 iterations and 3672 ms. Remains : 4050/4050 places, 3375/3375 transitions.
Successfully simplified 10 atomic propositions for a total of 12 simplifications.
[2023-03-19 01:13:56] [INFO ] Flatten gal took : 207 ms
[2023-03-19 01:13:57] [INFO ] Flatten gal took : 175 ms
[2023-03-19 01:13:58] [INFO ] Input system was already deterministic with 3375 transitions.
Computed a total of 4050 stabilizing places and 3375 stable transitions
Complete graph has no SCC; deadlocks are unavoidable. place count 4050 transition count 3375
Detected that all paths lead to deadlock. Applying this knowledge to assert that all AP eventually converge (and all enablings converge to false).
AF dead knowledge conclusive for 1 formulas.
Starting structural reductions in SI_CTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 167 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in SI_CTL mode , in 1 iterations and 167 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:13:58] [INFO ] Flatten gal took : 121 ms
[2023-03-19 01:13:59] [INFO ] Flatten gal took : 132 ms
[2023-03-19 01:13:59] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Reduce places removed 3375 places and 0 transitions.
Iterating post reduction 0 with 3375 rules applied. Total rules applied 3375 place count 675 transition count 3375
Applied a total of 3375 rules in 161 ms. Remains 675 /4050 variables (removed 3375) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 162 ms. Remains : 675/4050 places, 3375/3375 transitions.
[2023-03-19 01:13:59] [INFO ] Flatten gal took : 95 ms
[2023-03-19 01:13:59] [INFO ] Flatten gal took : 90 ms
[2023-03-19 01:13:59] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 9 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 9 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:00] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
[2023-03-19 01:14:00] [INFO ] Flatten gal took : 120 ms
FORMULA Sudoku-COL-AN15-CTLCardinality-02 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2023-03-19 01:14:00] [INFO ] Flatten gal took : 119 ms
[2023-03-19 01:14:00] [INFO ] Input system was already deterministic with 3375 transitions.
Support contains 0 out of 4050 places (down from 4050) after GAL structural reductions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 8 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 10 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:00] [INFO ] Flatten gal took : 112 ms
[2023-03-19 01:14:00] [INFO ] Flatten gal took : 123 ms
[2023-03-19 01:14:00] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 21 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 21 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:01] [INFO ] Flatten gal took : 116 ms
[2023-03-19 01:14:01] [INFO ] Flatten gal took : 119 ms
[2023-03-19 01:14:01] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 15 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 16 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:01] [INFO ] Flatten gal took : 112 ms
[2023-03-19 01:14:01] [INFO ] Flatten gal took : 123 ms
[2023-03-19 01:14:01] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in SI_CTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Graph (complete) has 10125 edges and 4050 vertex of which 675 are kept as prefixes of interest. Removing 3375 places using SCC suffix rule.8 ms
Discarding 3375 places :
Also discarding 0 output transitions
Applied a total of 1 rules in 80 ms. Remains 675 /4050 variables (removed 3375) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in SI_CTL mode , in 1 iterations and 80 ms. Remains : 675/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:02] [INFO ] Flatten gal took : 87 ms
[2023-03-19 01:14:02] [INFO ] Flatten gal took : 95 ms
[2023-03-19 01:14:02] [INFO ] Input system was already deterministic with 3375 transitions.
Finished random walk after 390 steps, including 1 resets, run visited all 1 properties in 87 ms. (steps per millisecond=4 )
FORMULA Sudoku-COL-AN15-CTLCardinality-07 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 8 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 9 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:02] [INFO ] Flatten gal took : 126 ms
[2023-03-19 01:14:02] [INFO ] Flatten gal took : 139 ms
[2023-03-19 01:14:03] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 16 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 16 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:03] [INFO ] Flatten gal took : 121 ms
[2023-03-19 01:14:03] [INFO ] Flatten gal took : 128 ms
[2023-03-19 01:14:03] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 14 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 15 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:03] [INFO ] Flatten gal took : 108 ms
[2023-03-19 01:14:03] [INFO ] Flatten gal took : 116 ms
[2023-03-19 01:14:04] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 36 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 37 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:04] [INFO ] Flatten gal took : 110 ms
[2023-03-19 01:14:04] [INFO ] Flatten gal took : 120 ms
[2023-03-19 01:14:04] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 7 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 7 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:04] [INFO ] Flatten gal took : 134 ms
[2023-03-19 01:14:04] [INFO ] Flatten gal took : 123 ms
[2023-03-19 01:14:05] [INFO ] Input system was already deterministic with 3375 transitions.
Starting structural reductions in LTL mode, iteration 0 : 4050/4050 places, 3375/3375 transitions.
Applied a total of 0 rules in 7 ms. Remains 4050 /4050 variables (removed 0) and now considering 3375/3375 (removed 0) transitions.
Finished structural reductions in LTL mode , in 1 iterations and 8 ms. Remains : 4050/4050 places, 3375/3375 transitions.
[2023-03-19 01:14:05] [INFO ] Flatten gal took : 108 ms
[2023-03-19 01:14:05] [INFO ] Flatten gal took : 118 ms
[2023-03-19 01:14:05] [INFO ] Input system was already deterministic with 3375 transitions.
[2023-03-19 01:14:05] [INFO ] Flatten gal took : 150 ms
[2023-03-19 01:14:06] [INFO ] Flatten gal took : 155 ms
[2023-03-19 01:14:06] [INFO ] Export to MCC of 11 properties in file /home/mcc/execution/CTLCardinality.sr.xml took 30 ms.
[2023-03-19 01:14:06] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml of net with 4050 places, 3375 transitions and 13500 arcs took 16 ms.
Total runtime 160358 ms.
There are residual formulas that ITS could not solve within timeout
timeout --kill-after=10s --signal=SIGINT 1m for testing only
Marcie built on Linux at 2019-11-18.
A model checker for Generalized Stochastic Petri nets
authors: Alex Tovchigrechko (IDD package and CTL model checking)
Martin Schwarick (Symbolic numerical analysis and CSL model checking)
Christian Rohr (Simulative and approximative numerical model checking)
marcie@informatik.tu-cottbus.de
called as: /home/mcc/BenchKit/bin//../reducer/bin//../../marcie/bin/marcie --net-file=model.pnml --mcc-file=CTLCardinality.xml --memory=6 --mcc-mode
parse successfull
net created successfully
Net: Petri
(NrP: 4050 NrTr: 3375 NrArc: 13500)
parse formulas
formulas created successfully
place and transition orderings generation:0m 1.434sec
net check time: 0m 0.002sec
init dd package: 0m 2.874sec
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16393216 kB
MemFree: 6514488 kB
After kill :
MemTotal: 16393216 kB
MemFree: 16092784 kB
BK_TIME_CONFINEMENT_REACHED
--------------------
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 CTLCardinality -timeout 360 -rebuildPNML
check for maximal unmarked siphon
ok
check for constant places
ok
check if there are places and transitions
ok
check if there are transitions without pre-places
ok
check if at least one transition is enabled in m0
ok
check if there are transitions that can never fire
ok
initing FirstDep: 0m 0.014sec
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="Sudoku-COL-AN15"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="marciexred"
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 marciexred"
echo " Input is Sudoku-COL-AN15, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r490-tall-167912708200113"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/Sudoku-COL-AN15.tgz
mv Sudoku-COL-AN15 execution
cd execution
if [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "UpperBounds" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] || [ "CTLCardinality" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '
echo "FORMULA_NAME $x"
done
elif [ "CTLCardinality" = "ReachabilityDeadlock" ] || [ "CTLCardinality" = "QuasiLiveness" ] || [ "CTLCardinality" = "StableMarking" ] || [ "CTLCardinality" = "Liveness" ] || [ "CTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME CTLCardinality"
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;