About the Execution of 2020-gold for PolyORBNT-COL-S05J60
Execution Summary | |||||
Max Memory Used (MB) |
Time wait (ms) | CPU Usage (ms) | I/O Wait (ms) | Computed Result | Execution Status |
4284.728 | 3600000.00 | 310478.00 | 234.10 | TF?FTFTTTFFTFFFF | normal |
Execution Chart
We display below the execution chart for this examination (boot time has been removed).
Trace from the execution
Formatting '/data/fko/mcc2021-input.r170-oct2-162089287200195.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2021-input.qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
...........................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool gold2020
Input is PolyORBNT-COL-S05J60, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r170-oct2-162089287200195
=====================================================================
--------------------
preparation of the directory to be used:
/home/mcc/execution
total 444K
-rw-r--r-- 1 mcc users 16K May 5 16:58 CTLCardinality.txt
-rw-r--r-- 1 mcc users 101K May 10 09:43 CTLCardinality.xml
-rw-r--r-- 1 mcc users 12K May 5 16:58 CTLFireability.txt
-rw-r--r-- 1 mcc users 83K May 10 09:43 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 6 14:48 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.5K May 6 14:48 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.7K Mar 28 16:28 LTLCardinality.txt
-rw-r--r-- 1 mcc users 24K Mar 28 16:28 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Mar 28 16:28 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Mar 28 16:28 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.9K Mar 27 09:32 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 17K Mar 27 09:32 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.8K Mar 25 12:20 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 14K Mar 25 12:20 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Mar 22 08:13 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Mar 22 08:13 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 May 5 16:51 equiv_pt
-rw-r--r-- 1 mcc users 7 May 5 16:51 instance
-rw-r--r-- 1 mcc users 5 May 5 16:51 iscolored
-rw-r--r-- 1 mcc users 94K May 5 16:51 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 PolyORBNT-COL-S05J60-ReachabilityCardinality-00
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-01
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-02
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-03
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-04
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-05
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-06
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-07
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-08
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-09
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-10
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-11
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-12
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-13
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-14
FORMULA_NAME PolyORBNT-COL-S05J60-ReachabilityCardinality-15
=== Now, execution of the tool begins
BK_START 1621386470659
bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2021-05-19 01:07:54] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, ReachabilityCardinality, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -timeout, 3600, -rebuildPNML]
[2021-05-19 01:07:54] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2021-05-19 01:07:54] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2021-05-19 01:07:55] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 889 ms
[2021-05-19 01:07:55] [INFO ] sort/places :
D4->place_482,
Threads->FetchJobB,QueueJobE,NotifyEventJobQueuedE,NotifyEventEndOfCheckSourcesE,NotifyEventEndOfCheckSourcesB,place_523,place_522,place_521,place_520,place_518,place_500,Check_Sources_E,Check_Sources_B,place_782,place_787,Perform_Work_E,Schedule_Task_B,Try_Check_Sources_E,Try_Check_Sources_B,
D5->Schedule_Task_E,
D6->CreatedJobs,
Jobs->f3,f2,f1,AvailableJobId,
Dot->block,mo3,mo2,mo1,mi3,mi2,mi1,cSources,place_462,place_460,place_458,place_456,CanInjectEvent,JobCnt,cJobCnt,
Sources->ModifiedSrc,DataOnSrc,TheSour,
D1->FetchJobE,QueueJobB,NotifyEventJobQueuedB,Perform_Work_B,
[2021-05-19 01:07:55] [INFO ] ms3 symmetric to ms4 in transition trans_489
[2021-05-19 01:07:55] [INFO ] ms4 symmetric to ms1 in transition trans_489
[2021-05-19 01:07:55] [INFO ] ms1 symmetric to ms2 in transition trans_489
[2021-05-19 01:07:55] [INFO ] ms3 symmetric to ms1 in transition trans_488
[2021-05-19 01:07:55] [INFO ] ms1 symmetric to ms2 in transition trans_488
[2021-05-19 01:07:55] [INFO ] ms1 symmetric to ms2 in transition trans_487
[2021-05-19 01:07:55] [INFO ] Imported 48 HL places and 38 HL transitions for a total of 969 PT places and 2152.0 transition bindings in 70 ms.
[2021-05-19 01:07:55] [INFO ] Computed order based on color domains.
[2021-05-19 01:07:55] [INFO ] Unfolded HLPN to a Petri net with 969 places and 1375 transitions in 52 ms.
[2021-05-19 01:07:55] [INFO ] Unfolded HLPN properties in 0 ms.
Deduced a syphon composed of 60 places in 9 ms
Reduce places removed 60 places and 60 transitions.
Parsed 16 properties from file /home/mcc/execution/ReachabilityCardinality.xml in 119 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 10000 steps, including 683 resets, run finished after 258 ms. (steps per millisecond=38 ) properties seen :[0, 0, 0, 0, 0, 1, 1, 1, 0, 0, 1, 1, 0, 0, 0, 0]
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-11 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-10 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-07 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-06 TRUE TECHNIQUES TOPOLOGICAL RANDOM_WALK
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-05 FALSE TECHNIQUES TOPOLOGICAL RANDOM_WALK
Incomplete Best-First random walk after 10001 steps, including 53 resets, run finished after 54 ms. (steps per millisecond=185 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 45 resets, run finished after 40 ms. (steps per millisecond=250 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 111 resets, run finished after 41 ms. (steps per millisecond=243 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 121 resets, run finished after 39 ms. (steps per millisecond=256 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 141 resets, run finished after 38 ms. (steps per millisecond=263 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 249 resets, run finished after 45 ms. (steps per millisecond=222 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10000 steps, including 135 resets, run finished after 46 ms. (steps per millisecond=217 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 91 resets, run finished after 21 ms. (steps per millisecond=476 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 45 resets, run finished after 52 ms. (steps per millisecond=192 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 251 resets, run finished after 48 ms. (steps per millisecond=208 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Incomplete Best-First random walk after 10001 steps, including 250 resets, run finished after 36 ms. (steps per millisecond=277 ) properties seen :[0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
[2021-05-19 01:07:56] [INFO ] Flow matrix only has 1311 transitions (discarded 4 similar events)
// Phase 1: matrix 1311 rows 909 cols
[2021-05-19 01:07:56] [INFO ] Computed 142 place invariants in 83 ms
[2021-05-19 01:07:56] [INFO ] [Real]Absence check using 135 positive place invariants in 246 ms returned sat
[2021-05-19 01:07:57] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 67 ms returned sat
[2021-05-19 01:07:57] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:08:01] [INFO ] [Real]Absence check using state equation in 4253 ms returned sat
[2021-05-19 01:08:01] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:08:01] [INFO ] [Nat]Absence check using 135 positive place invariants in 182 ms returned sat
[2021-05-19 01:08:01] [INFO ] [Nat]Absence check using 135 positive and 7 generalized place invariants in 43 ms returned sat
[2021-05-19 01:08:01] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:08:04] [INFO ] [Nat]Absence check using state equation in 2515 ms returned unsat
[2021-05-19 01:08:04] [INFO ] [Real]Absence check using 135 positive place invariants in 266 ms returned sat
[2021-05-19 01:08:04] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 21 ms returned sat
[2021-05-19 01:08:04] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:08:06] [INFO ] [Real]Absence check using state equation in 2123 ms returned unsat
[2021-05-19 01:08:07] [INFO ] [Real]Absence check using 135 positive place invariants in 469 ms returned sat
[2021-05-19 01:08:07] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 49 ms returned sat
[2021-05-19 01:08:07] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:08:10] [INFO ] [Real]Absence check using state equation in 3262 ms returned sat
[2021-05-19 01:08:10] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:08:11] [INFO ] [Nat]Absence check using 135 positive place invariants in 137 ms returned sat
[2021-05-19 01:08:11] [INFO ] [Nat]Absence check using 135 positive and 7 generalized place invariants in 33 ms returned sat
[2021-05-19 01:08:11] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:08:13] [INFO ] [Nat]Absence check using state equation in 2629 ms returned sat
[2021-05-19 01:08:13] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-19 01:08:13] [INFO ] [Nat]Added 1 Read/Feed constraints in 27 ms returned sat
[2021-05-19 01:08:13] [INFO ] Computed and/alt/rep : 1309/34782/1305 causal constraints in 148 ms.
[2021-05-19 01:08:15] [INFO ] Added : 20 causal constraints over 4 iterations in 1980 ms. Result :(error "Solver has unexpectedly terminated")
[2021-05-19 01:08:15] [INFO ] [Real]Absence check using 135 positive place invariants in 81 ms returned sat
[2021-05-19 01:08:15] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 5 ms returned unsat
[2021-05-19 01:08:16] [INFO ] [Real]Absence check using 135 positive place invariants in 81 ms returned sat
[2021-05-19 01:08:16] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 20 ms returned sat
[2021-05-19 01:08:16] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:08:20] [INFO ] SMT solver returned unknown. Retrying;
[2021-05-19 01:08:20] [INFO ] [Real]Absence check using state equation in 4813 ms returned (error "Failed to check-sat")
[2021-05-19 01:08:21] [INFO ] [Real]Absence check using 135 positive place invariants in 404 ms returned unsat
[2021-05-19 01:08:22] [INFO ] [Real]Absence check using 135 positive place invariants in 518 ms returned sat
[2021-05-19 01:08:22] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 39 ms returned unsat
[2021-05-19 01:08:22] [INFO ] [Real]Absence check using 135 positive place invariants in 356 ms returned sat
[2021-05-19 01:08:22] [INFO ] [Real]Absence check using 135 positive and 7 generalized place invariants in 51 ms returned unsat
[2021-05-19 01:08:23] [INFO ] [Real]Absence check using 135 positive place invariants in 408 ms returned unsat
[2021-05-19 01:08:23] [INFO ] [Real]Absence check using 135 positive place invariants in 396 ms returned unsat
[2021-05-19 01:08:24] [INFO ] [Real]Absence check using 135 positive place invariants in 465 ms returned unsat
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-15 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-14 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-13 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-12 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-09 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-08 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-03 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-01 FALSE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-00 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Support contains 77 out of 909 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 909/909 places, 1315/1315 transitions.
Ensure Unique test removed 5 places
Performed 65 Post agglomeration using F-continuation condition.Transition count delta: 65
Iterating post reduction 0 with 70 rules applied. Total rules applied 70 place count 904 transition count 1250
Reduce places removed 65 places and 0 transitions.
Iterating post reduction 1 with 65 rules applied. Total rules applied 135 place count 839 transition count 1250
Performed 65 Pre agglomeration using Quasi-Persistent + Divergent Free condition..
Pre-agglomeration after 2 with 65 Pre rules applied. Total rules applied 135 place count 839 transition count 1185
Deduced a syphon composed of 65 places in 6 ms
Reduce places removed 65 places and 0 transitions.
Iterating global reduction 2 with 130 rules applied. Total rules applied 265 place count 774 transition count 1185
Symmetric choice reduction at 2 with 1 rule applications. Total rules 266 place count 774 transition count 1185
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 1 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 268 place count 773 transition count 1184
Performed 1 Post agglomeration using F-continuation condition.Transition count delta: 1
Deduced a syphon composed of 1 places in 1 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 2 with 2 rules applied. Total rules applied 270 place count 772 transition count 1183
Applied a total of 270 rules in 647 ms. Remains 772 /909 variables (removed 137) and now considering 1183/1315 (removed 132) transitions.
[2021-05-19 01:08:25] [INFO ] Flow matrix only has 1179 transitions (discarded 4 similar events)
// Phase 1: matrix 1179 rows 772 cols
[2021-05-19 01:08:25] [INFO ] Computed 137 place invariants in 194 ms
[2021-05-19 01:08:35] [INFO ] Dead Transitions using invariants and state equation in 10369 ms returned [743, 745, 748, 749, 750, 751, 752, 753, 755, 758, 762, 763, 764, 765, 766, 767, 768, 770, 773, 777, 782, 788, 789, 790, 791, 792, 793, 794, 795, 796, 797, 798, 799, 800, 801, 802, 803, 804, 805, 806, 807, 809, 810, 811, 812, 813, 814, 815, 816, 817, 818, 819, 820, 821, 822, 823, 824, 825, 826, 827, 829, 830, 831, 832, 833, 835, 838, 839, 840, 841, 842, 843, 844, 845, 846, 847, 848, 849, 850, 851, 852, 853, 854, 855, 856, 857, 858, 859, 860, 861, 862, 864, 865, 866, 867]
Found 95 dead transitions using SMT.
Drop transitions removed 95 transitions
Dead transitions reduction (with SMT) triggered by suspicious arc values removed 95 transitions :[867, 866, 865, 864, 862, 861, 860, 859, 858, 857, 856, 855, 854, 853, 852, 851, 850, 849, 848, 847, 846, 845, 844, 843, 842, 841, 840, 839, 838, 835, 833, 832, 831, 830, 829, 827, 826, 825, 824, 823, 822, 821, 820, 819, 818, 817, 816, 815, 814, 813, 812, 811, 810, 809, 807, 806, 805, 804, 803, 802, 801, 800, 799, 798, 797, 796, 795, 794, 793, 792, 791, 790, 789, 788, 782, 777, 773, 770, 768, 767, 766, 765, 764, 763, 762, 758, 755, 753, 752, 751, 750, 749, 748, 745, 743]
Starting structural reductions, iteration 1 : 772/909 places, 1088/1315 transitions.
Applied a total of 0 rules in 168 ms. Remains 772 /772 variables (removed 0) and now considering 1088/1088 (removed 0) transitions.
Finished structural reductions, in 2 iterations. Remains : 772/909 places, 1088/1315 transitions.
Incomplete random walk after 1000000 steps, including 58345 resets, run finished after 6349 ms. (steps per millisecond=157 ) properties seen :[0, 0]
Incomplete Best-First random walk after 1000001 steps, including 4294 resets, run finished after 1858 ms. (steps per millisecond=538 ) properties seen :[0, 0]
Incomplete Best-First random walk after 1000001 steps, including 4660 resets, run finished after 1250 ms. (steps per millisecond=800 ) properties seen :[0, 0]
Interrupted probabilistic random walk after 6062540 steps, run timeout after 30001 ms. (steps per millisecond=202 ) properties seen :[0, 0]
Probabilistic random walk after 6062540 steps, saw 1903862 distinct states, run finished after 30001 ms. (steps per millisecond=202 ) properties seen :[0, 0]
[2021-05-19 01:09:15] [INFO ] Flow matrix only has 1084 transitions (discarded 4 similar events)
// Phase 1: matrix 1084 rows 772 cols
[2021-05-19 01:09:15] [INFO ] Computed 137 place invariants in 45 ms
[2021-05-19 01:09:15] [INFO ] [Real]Absence check using 130 positive place invariants in 135 ms returned sat
[2021-05-19 01:09:15] [INFO ] [Real]Absence check using 130 positive and 7 generalized place invariants in 30 ms returned sat
[2021-05-19 01:09:15] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:09:18] [INFO ] [Real]Absence check using state equation in 3444 ms returned sat
[2021-05-19 01:09:18] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:09:19] [INFO ] [Nat]Absence check using 130 positive place invariants in 74 ms returned sat
[2021-05-19 01:09:19] [INFO ] [Nat]Absence check using 130 positive and 7 generalized place invariants in 15 ms returned sat
[2021-05-19 01:09:19] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:09:22] [INFO ] [Nat]Absence check using state equation in 3289 ms returned sat
[2021-05-19 01:09:22] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-19 01:09:22] [INFO ] [Nat]Added 1 Read/Feed constraints in 9 ms returned sat
[2021-05-19 01:09:23] [INFO ] Deduced a trap composed of 138 places in 749 ms
[2021-05-19 01:09:24] [INFO ] Deduced a trap composed of 138 places in 826 ms
[2021-05-19 01:09:26] [INFO ] Deduced a trap composed of 138 places in 1981 ms
[2021-05-19 01:09:27] [INFO ] Deduced a trap composed of 161 places in 774 ms
[2021-05-19 01:09:27] [INFO ] Deduced a trap composed of 162 places in 663 ms
[2021-05-19 01:09:28] [INFO ] Deduced a trap composed of 15 places in 712 ms
[2021-05-19 01:09:28] [INFO ] Trap strengthening (SAT) tested/added 7/6 trap constraints in 6378 ms
[2021-05-19 01:09:28] [INFO ] Computed and/alt/rep : 1082/22785/1078 causal constraints in 102 ms.
[2021-05-19 01:09:32] [INFO ] Added : 57 causal constraints over 12 iterations in 3417 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 67 ms.
[2021-05-19 01:09:32] [INFO ] [Real]Absence check using 130 positive place invariants in 71 ms returned sat
[2021-05-19 01:09:32] [INFO ] [Real]Absence check using 130 positive and 7 generalized place invariants in 20 ms returned sat
[2021-05-19 01:09:32] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:09:36] [INFO ] [Real]Absence check using state equation in 3323 ms returned sat
[2021-05-19 01:09:36] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:09:36] [INFO ] [Nat]Absence check using 130 positive place invariants in 129 ms returned sat
[2021-05-19 01:09:36] [INFO ] [Nat]Absence check using 130 positive and 7 generalized place invariants in 34 ms returned sat
[2021-05-19 01:09:36] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:09:38] [INFO ] [Nat]Absence check using state equation in 2062 ms returned unsat
FORMULA PolyORBNT-COL-S05J60-ReachabilityCardinality-04 TRUE TECHNIQUES STRUCTURAL_REDUCTION TOPOLOGICAL SAT_SMT
Incomplete Parikh walk after 8600 steps, including 755 resets, run finished after 58 ms. (steps per millisecond=148 ) properties seen :[0] could not realise parikh vector
Support contains 70 out of 772 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 772/772 places, 1088/1088 transitions.
Applied a total of 0 rules in 82 ms. Remains 772 /772 variables (removed 0) and now considering 1088/1088 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 772/772 places, 1088/1088 transitions.
Incomplete random walk after 1000000 steps, including 58253 resets, run finished after 4147 ms. (steps per millisecond=241 ) properties seen :[0]
Incomplete Best-First random walk after 1000001 steps, including 4341 resets, run finished after 1934 ms. (steps per millisecond=517 ) properties seen :[0]
Interrupted probabilistic random walk after 6164195 steps, run timeout after 30001 ms. (steps per millisecond=205 ) properties seen :[0]
Probabilistic random walk after 6164195 steps, saw 1937450 distinct states, run finished after 30008 ms. (steps per millisecond=205 ) properties seen :[0]
[2021-05-19 01:10:14] [INFO ] Flow matrix only has 1084 transitions (discarded 4 similar events)
// Phase 1: matrix 1084 rows 772 cols
[2021-05-19 01:10:14] [INFO ] Computed 137 place invariants in 21 ms
[2021-05-19 01:10:15] [INFO ] [Real]Absence check using 130 positive place invariants in 358 ms returned sat
[2021-05-19 01:10:15] [INFO ] [Real]Absence check using 130 positive and 7 generalized place invariants in 92 ms returned sat
[2021-05-19 01:10:15] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:10:21] [INFO ] [Real]Absence check using state equation in 6382 ms returned sat
[2021-05-19 01:10:21] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:10:22] [INFO ] [Nat]Absence check using 130 positive place invariants in 462 ms returned sat
[2021-05-19 01:10:22] [INFO ] [Nat]Absence check using 130 positive and 7 generalized place invariants in 71 ms returned sat
[2021-05-19 01:10:22] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:10:28] [INFO ] [Nat]Absence check using state equation in 5601 ms returned sat
[2021-05-19 01:10:28] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-19 01:10:28] [INFO ] [Nat]Added 1 Read/Feed constraints in 36 ms returned sat
[2021-05-19 01:10:28] [INFO ] Deduced a trap composed of 138 places in 792 ms
[2021-05-19 01:10:29] [INFO ] Deduced a trap composed of 138 places in 738 ms
[2021-05-19 01:10:31] [INFO ] Deduced a trap composed of 138 places in 1419 ms
[2021-05-19 01:10:35] [INFO ] Deduced a trap composed of 161 places in 4246 ms
[2021-05-19 01:10:36] [INFO ] Deduced a trap composed of 162 places in 654 ms
[2021-05-19 01:10:36] [INFO ] Deduced a trap composed of 15 places in 647 ms
[2021-05-19 01:10:37] [INFO ] Trap strengthening (SAT) tested/added 7/6 trap constraints in 9020 ms
[2021-05-19 01:10:37] [INFO ] Computed and/alt/rep : 1082/22785/1078 causal constraints in 140 ms.
[2021-05-19 01:10:40] [INFO ] Added : 57 causal constraints over 12 iterations in 3285 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 36 ms.
Incomplete Parikh walk after 8600 steps, including 750 resets, run finished after 56 ms. (steps per millisecond=153 ) properties seen :[0] could not realise parikh vector
Support contains 70 out of 772 places. Attempting structural reductions.
Starting structural reductions, iteration 0 : 772/772 places, 1088/1088 transitions.
Applied a total of 0 rules in 34 ms. Remains 772 /772 variables (removed 0) and now considering 1088/1088 (removed 0) transitions.
Finished structural reductions, in 1 iterations. Remains : 772/772 places, 1088/1088 transitions.
Starting structural reductions, iteration 0 : 772/772 places, 1088/1088 transitions.
Applied a total of 0 rules in 36 ms. Remains 772 /772 variables (removed 0) and now considering 1088/1088 (removed 0) transitions.
[2021-05-19 01:10:40] [INFO ] Flow matrix only has 1084 transitions (discarded 4 similar events)
// Phase 1: matrix 1084 rows 772 cols
[2021-05-19 01:10:40] [INFO ] Computed 137 place invariants in 23 ms
[2021-05-19 01:10:44] [INFO ] Implicit Places using invariants in 3331 ms returned []
[2021-05-19 01:10:44] [INFO ] Flow matrix only has 1084 transitions (discarded 4 similar events)
// Phase 1: matrix 1084 rows 772 cols
[2021-05-19 01:10:44] [INFO ] Computed 137 place invariants in 21 ms
[2021-05-19 01:10:46] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-19 01:10:53] [INFO ] Implicit Places using invariants and state equation in 9138 ms returned []
Implicit Place search using SMT with State Equation took 12483 ms to find 0 implicit places.
[2021-05-19 01:10:53] [INFO ] Redundant transitions in 104 ms returned []
[2021-05-19 01:10:53] [INFO ] Flow matrix only has 1084 transitions (discarded 4 similar events)
// Phase 1: matrix 1084 rows 772 cols
[2021-05-19 01:10:53] [INFO ] Computed 137 place invariants in 32 ms
[2021-05-19 01:10:56] [INFO ] Dead Transitions using invariants and state equation in 3206 ms returned []
Finished structural reductions, in 1 iterations. Remains : 772/772 places, 1088/1088 transitions.
Incomplete random walk after 100000 steps, including 5711 resets, run finished after 534 ms. (steps per millisecond=187 ) properties seen :[0]
[2021-05-19 01:10:57] [INFO ] Flow matrix only has 1084 transitions (discarded 4 similar events)
// Phase 1: matrix 1084 rows 772 cols
[2021-05-19 01:10:57] [INFO ] Computed 137 place invariants in 20 ms
[2021-05-19 01:10:57] [INFO ] [Real]Absence check using 130 positive place invariants in 143 ms returned sat
[2021-05-19 01:10:57] [INFO ] [Real]Absence check using 130 positive and 7 generalized place invariants in 20 ms returned sat
[2021-05-19 01:10:57] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:10:58] [INFO ] [Real]Absence check using state equation in 1593 ms returned sat
[2021-05-19 01:10:58] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:10:59] [INFO ] [Nat]Absence check using 130 positive place invariants in 486 ms returned sat
[2021-05-19 01:10:59] [INFO ] [Nat]Absence check using 130 positive and 7 generalized place invariants in 26 ms returned sat
[2021-05-19 01:10:59] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:11:02] [INFO ] [Nat]Absence check using state equation in 3019 ms returned sat
[2021-05-19 01:11:02] [INFO ] State equation strengthened by 1 read => feed constraints.
[2021-05-19 01:11:02] [INFO ] [Nat]Added 1 Read/Feed constraints in 8 ms returned sat
[2021-05-19 01:11:03] [INFO ] Deduced a trap composed of 138 places in 760 ms
[2021-05-19 01:11:05] [INFO ] Deduced a trap composed of 138 places in 2067 ms
[2021-05-19 01:11:06] [INFO ] Deduced a trap composed of 138 places in 753 ms
[2021-05-19 01:11:07] [INFO ] Deduced a trap composed of 161 places in 715 ms
[2021-05-19 01:11:09] [INFO ] Deduced a trap composed of 162 places in 1929 ms
[2021-05-19 01:11:10] [INFO ] Deduced a trap composed of 15 places in 1319 ms
[2021-05-19 01:11:10] [INFO ] Trap strengthening (SAT) tested/added 7/6 trap constraints in 8153 ms
[2021-05-19 01:11:10] [INFO ] Computed and/alt/rep : 1082/22785/1078 causal constraints in 71 ms.
[2021-05-19 01:11:14] [INFO ] Added : 57 causal constraints over 12 iterations in 3469 ms. Result :sat
Ensure Unique test removed 4 transitions
Reduce isomorphic transitions removed 4 transitions.
Iterating post reduction 0 with 4 rules applied. Total rules applied 4 place count 772 transition count 1084
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 772 transition count 1083
Deduced a syphon composed of 1 places in 0 ms
Reduce places removed 1 places and 0 transitions.
Iterating global reduction 1 with 2 rules applied. Total rules applied 6 place count 771 transition count 1083
Free-agglomeration rule applied 1 times.
Iterating global reduction 1 with 1 rules applied. Total rules applied 7 place count 771 transition count 1082
Reduce places removed 1 places and 0 transitions.
Iterating post reduction 1 with 1 rules applied. Total rules applied 8 place count 770 transition count 1082
Free-agglomeration rule (complex) applied 5 times.
Iterating global reduction 2 with 5 rules applied. Total rules applied 13 place count 770 transition count 1077
Reduce places removed 5 places and 0 transitions.
Iterating post reduction 2 with 5 rules applied. Total rules applied 18 place count 765 transition count 1077
Applied a total of 18 rules in 138 ms. Remains 765 /772 variables (removed 7) and now considering 1077/1088 (removed 11) transitions.
// Phase 1: matrix 1077 rows 765 cols
[2021-05-19 01:11:14] [INFO ] Computed 137 place invariants in 30 ms
[2021-05-19 01:11:14] [INFO ] [Real]Absence check using 130 positive place invariants in 116 ms returned sat
[2021-05-19 01:11:14] [INFO ] [Real]Absence check using 130 positive and 7 generalized place invariants in 37 ms returned sat
[2021-05-19 01:11:14] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2021-05-19 01:11:16] [INFO ] [Real]Absence check using state equation in 1594 ms returned sat
[2021-05-19 01:11:16] [INFO ] Solution in real domain found non-integer solution.
[2021-05-19 01:11:16] [INFO ] [Nat]Absence check using 130 positive place invariants in 283 ms returned sat
[2021-05-19 01:11:16] [INFO ] [Nat]Absence check using 130 positive and 7 generalized place invariants in 32 ms returned sat
[2021-05-19 01:11:16] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2021-05-19 01:11:18] [INFO ] [Nat]Absence check using state equation in 2053 ms returned sat
[2021-05-19 01:11:19] [INFO ] Computed and/alt/rep : 1076/22699/1076 causal constraints in 113 ms.
[2021-05-19 01:11:23] [INFO ] Added : 61 causal constraints over 13 iterations in 4573 ms. Result :sat
Attempting to minimize the solution found.
Minimization took 67 ms.
[2021-05-19 01:11:23] [INFO ] Export to MCC properties in file /home/mcc/execution/ReachabilityCardinality.sr.xml took 3 ms.
[2021-05-19 01:11:23] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 23 ms.
[2021-05-19 01:11:24] [INFO ] Flatten gal took : 216 ms
info: Time: 3600 - MCC
vrfy: Checking ReachabilityCardinality @ PolyORBNT-COL-S05J60 @ 3570 seconds
vrfy: finished
info: timeLeft: 3556
rslt: Output for ReachabilityCardinality @ PolyORBNT-COL-S05J60
{
"build":
{
"architecture": 64,
"assertions": false,
"build_hostname": "mcc2019",
"build_system": "x86_64-unknown-linux-gnu",
"optimizations": true,
"package_version": "2.0",
"svn_version": "3189M"
},
"call":
{
"exec_host": "mcc2020",
"localtimelimit": 0,
"markinglimit": null,
"parameters":
[
"--pnmlnet",
"model.pnml",
"--xmlformula",
"--formula=ReachabilityCardinality.xml",
"--mcc",
"--donotcomputecapacities",
"--encoder=simplecompressed",
"--check=modelchecking",
"--stubborn=tarjan",
"--stateequation=par",
"--timelimit=3570",
"--localtimelimit=0",
"--json=ReachabilityCardinality.json",
"--jsoninclude=formula,formulastat,net"
],
"starttime": "Wed May 19 01:11:24 2021
",
"timelimit": 3570
},
"child": null,
"exit":
{
"error": null,
"localtimelimitreached": true,
"memory": 27104,
"runtime": 14.000000,
"signal": null,
"timelimitreached": false
},
"files":
{
"formula": "ReachabilityCardinality.xml",
"net": "model.pnml"
},
"formula":
{
"count":
{
"A": 1,
"E": 0,
"F": 0,
"G": 1,
"U": 0,
"X": 0,
"aconj": 0,
"adisj": 1,
"aneg": 0,
"comp": 3,
"cont": 0,
"dl": 0,
"fir": 0,
"nodl": 0,
"place_references": 69,
"taut": 0,
"tconj": 0,
"tdisj": 0,
"tneg": 0,
"transition_references": 0,
"unfir": 0,
"visible_places": 69,
"visible_transitions": 0
},
"processed": "A (G (((p311 <= p698) OR (p125 + p126 + p127 + p128 + p129 + p130 + p131 + p132 + p133 + p134 + p135 + p136 + p137 + p138 + p139 + p140 + p141 + p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p168 + p169 + p170 + p171 + p172 + p173 + p174 + p175 + p176 + p177 + p178 + p179 + p180 + p181 + p182 + p183 + p184 + p185 <= p690 + p691 + p692 + p693 + p694) OR (1 <= p313))))",
"processed_size": 507,
"rewrites": 2,
"skeleton": "A(G(**))"
},
"net":
{
"arcs": 5513,
"conflict_clusters": 72,
"places": 772,
"places_significant": 635,
"singleton_clusters": 0,
"transitions": 1088
},
"task":
{
"search":
{
"store":
{
"encoder": "simple compression",
"type": "prefix"
},
"stubborn":
{
"type": "reachability preserving/insertion"
},
"threads": 1,
"type": "dfs"
},
"stateequation":
{
"literals": 3,
"problems": 3
},
"type": "invariance",
"workflow": "stateequation||search"
}
}
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: input: PNML file (--pnml)
lola: reading net from model.pnml
lola: reading pnml
lola: PNML file contains place/transition net
lola: finished parsing
lola: closed net file model.pnml
lola: 1860/268435456 symbol table entries, 0 collisions
lola: preprocessing...
lola: Size of bit vector: 24704
lola: finding significant places
lola: 772 places, 1088 transitions, 635 significant places
lola: compute conflict clusters
lola: computed conflict clusters
lola: Computing conflicting sets
lola: Computing back conflicting sets
lola: TASK
lola: Reading formula in XML format (--xmlformula)
lola: reading pnml
lola: reading formula from ReachabilityCardinality.xml
lola: LP says that atomic proposition is always false: (2 <= p769)
lola: A (G (((p311 <= p698) OR (p125 + p126 + p127 + p128 + p129 + p130 + p131 + p132 + p133 + p134 + p135 + p136 + p137 + p138 + p139 + p140 + p141 + p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p168 + p169 + p170 + p171 + p172 + p173 + p174 + p175 + p176 + p177 + p178 + p179 + p180 + p181 + p182 + p183 + p184 + p185 <= p690 + p691 + p692 + p693 + p694) OR (1 <= p313))))
lola: checking invariance
lola: Planning: workflow for reachability check: stateequation||search (--findpath=off)
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: processed formula: A (G (((p311 <= p698) OR (p125 + p126 + p127 + p128 + p129 + p130 + p131 + p132 + p133 + p134 + p135 + p136 + p137 + p138 + p139 + p140 + p141 + p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p168 + p169 + p170 + p171 + p172 + p173 + p174 + p175 + p176 + p177 + p1... (shortened)
lola: processed formula length: 507
lola: 2 rewrites
lola: closed formula file ReachabilityCardinality.xml
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: SEARCH (state space)
lola: state space: using reachability graph (--search=depth)
lola: state space: using reachability preserving stubborn set method with insertion algorithm (--stubborn=tarjan)
lola: built state equation task
lola: RUNNING
lola: subprocess will run for 0 seconds at most (--localtimelimit)
lola: state equation task get result started, id 0
lola: rewrite Frontend/Parser/formula_rewrite.k:721
lola: rewrite Frontend/Parser/formula_rewrite.k:787
lola: state equation task get result rewrite finished id 0
lola: state equation task get result unparse finished++ id 0
lola: formula 0: ((p698 + 1 <= p311) AND (p690 + p691 + p692 + p693 + p694 + 1 <= p125 + p126 + p127 + p128 + p129 + p130 + p131 + p132 + p133 + p134 + p135 + p136 + p137 + p138 + p139 + p140 + p141 + p142 + p143 + p144 + p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p168 + p169 + p170 + p171 + p172 + p173 + p174 + p175 + p176 + p177 + p178 + p179 + p180 + p181 + p182 + p183 + p184 + p185) AND (p313 <= 0))
lola: state equation task get result unparse finished id 0
lola: state equation: Generated DNF with 3 literals and 1 conjunctive subformulas
lola: local time limit reached - aborting
lola: state equation: write sara problem file to ReachabilityCardinality-0.sara
lola: state equation: calling and running sara
lola: memory consumption: 27104 KB
lola: time consumption: 14 seconds
lola: print data as JSON (--json)
lola: writing JSON to ReachabilityCardinality.json
lola: closed JSON file ReachabilityCardinality.json
rslt: finished
--------------------
content from stderr:
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="PolyORBNT-COL-S05J60"
export BK_EXAMINATION="ReachabilityCardinality"
export BK_TOOL="gold2020"
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-4028"
echo " Executing tool gold2020"
echo " Input is PolyORBNT-COL-S05J60, examination is ReachabilityCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r170-oct2-162089287200195"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"
tar xzf /home/mcc/BenchKit/INPUTS/PolyORBNT-COL-S05J60.tgz
mv PolyORBNT-COL-S05J60 execution
cd execution
if [ "ReachabilityCardinality" = "ReachabilityDeadlock" ] || [ "ReachabilityCardinality" = "UpperBounds" ] || [ "ReachabilityCardinality" = "QuasiLiveness" ] || [ "ReachabilityCardinality" = "StableMarking" ] || [ "ReachabilityCardinality" = "Liveness" ] || [ "ReachabilityCardinality" = "OneSafe" ] || [ "ReachabilityCardinality" = "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 [ "ReachabilityCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "ReachabilityCardinality" != "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 "ReachabilityCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property ReachabilityCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "ReachabilityCardinality.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 [ "ReachabilityCardinality" = "ReachabilityDeadlock" ] || [ "ReachabilityCardinality" = "QuasiLiveness" ] || [ "ReachabilityCardinality" = "StableMarking" ] || [ "ReachabilityCardinality" = "Liveness" ] || [ "ReachabilityCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME ReachabilityCardinality"
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 ;