Execution Chart

We display below the execution chart for this examination (boot time has been removed).

Trace from the execution

Formatting '/local/x2003239/mcc2019-input.r195-csrt-155246554100223.qcow2', fmt=qcow2 size=4294967296 backing_file=/local/x2003239/mcc2019-input.qcow2 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.......................................................................
=====================================================================
Generated by BenchKit 2-3954
Executing tool itstoolsm
Input is FlexibleBarrier-PT-14a, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r195-csrt-155246554100223
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 328K
-rw-r--r-- 1 mcc users 3.0K Feb 11 00:29 CTLCardinality.txt
-rw-r--r-- 1 mcc users 16K Feb 11 00:29 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.3K Feb 6 22:22 CTLFireability.txt
-rw-r--r-- 1 mcc users 15K Feb 6 22:22 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 10 17:31 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.1K Mar 10 17:31 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 109 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 347 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.5K Feb 4 23:49 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K Feb 4 23:49 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Feb 4 22:35 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.9K Feb 4 22:35 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.2K Feb 3 08:25 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 15K Feb 3 08:25 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.8K Jan 31 01:18 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 17K Jan 31 01:18 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Feb 4 22:20 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K Feb 4 22:20 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 equiv_col
-rw-r--r-- 1 mcc users 4 Jan 29 09:34 instance
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 iscolored
-rw-r--r-- 1 mcc users 0 Jan 29 09:34 model-fix.log
-rw-r--r-- 1 mcc users 169K Mar 10 17:31 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 FlexibleBarrier-PT-14a-LTLFireability-00
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-01
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-02
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-03
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-04
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-05
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-06
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-07
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-08
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-09
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-10
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-11
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-12
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-13
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-14
FORMULA_NAME FlexibleBarrier-PT-14a-LTLFireability-15

=== Now, execution of the tool begins

BK_START 1553721984070

Working with output stream class java.io.PrintStream
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock, --load-order, /home/mcc/execution/model.ord], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock --load-order /home/mcc/execution/model.ord
Read 16 LTL properties
Successfully loaded order from file /home/mcc/execution/model.ord
Checking formula 0 : !((F((("((p53>=1)&&(p170>=1))")U("((p28>=1)&&(p170>=1))"))U(("(((p107>=1)&&(p120>=1))&&(p169>=1))")U("(((p83>=1)&&(p96>=1))&&(p169>=1))")))))
Formula 0 simplified : !F(("((p53>=1)&&(p170>=1))" U "((p28>=1)&&(p170>=1))") U ("(((p107>=1)&&(p120>=1))&&(p169>=1))" U "(((p83>=1)&&(p96>=1))&&(p169>=1))"))
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 394
// Phase 1: matrix 394 rows 171 cols
invariant :p85 + p86 + p87 + p88 + p89 + p90 + p91 + p92 + p93 + p94 + p95 + p96 + -1'p170 = 0
invariant :p73 + p74 + p75 + p76 + p77 + p78 + p79 + p80 + p81 + p82 + p83 + p84 + -1'p170 = 0
invariant :p121 + p122 + p123 + p124 + p125 + p126 + p127 + p128 + p129 + p130 + p131 + p132 + -1'p170 = 0
invariant :p133 + p134 + p135 + p136 + p137 + p138 + p139 + p140 + p141 + p142 + p143 + p144 + -1'p170 = 0
invariant :p0 + p170 = 1
invariant :p169 + -1'p170 = 0
invariant :p1 + p2 + p3 + p4 + p5 + p6 + p7 + p8 + p9 + p10 + p11 + p12 + -1'p170 = 0
invariant :p13 + p14 + p15 + p16 + p17 + p18 + p19 + p20 + p21 + p22 + p23 + p24 + -1'p170 = 0
invariant :p61 + p62 + p63 + p64 + p65 + p66 + p67 + p68 + p69 + p70 + p71 + p72 + -1'p170 = 0
invariant :p49 + p50 + p51 + p52 + p53 + p54 + p55 + p56 + p57 + p58 + p59 + p60 + -1'p170 = 0
invariant :p109 + p110 + p111 + p112 + p113 + p114 + p115 + p116 + p117 + p118 + p119 + p120 + -1'p170 = 0
invariant :p97 + p98 + p99 + p100 + p101 + p102 + p103 + p104 + p105 + p106 + p107 + p108 + -1'p170 = 0
invariant :p145 + p146 + p147 + p148 + p149 + p150 + p151 + p152 + p153 + p154 + p155 + p156 + -1'p170 = 0
invariant :p157 + p158 + p159 + p160 + p161 + p162 + p163 + p164 + p165 + p166 + p167 + p168 + -1'p170 = 0
invariant :p25 + p26 + p27 + p28 + p29 + p30 + p31 + p32 + p33 + p34 + p35 + p36 + -1'p170 = 0
invariant :p37 + p38 + p39 + p40 + p41 + p42 + p43 + p44 + p45 + p46 + p47 + p48 + -1'p170 = 0
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
sparsehash FATAL ERROR: failed to allocate 38 groups
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Could not compile executable .CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 16 LTL properties
Checking formula 0 : !((F((("((u5.p53>=1)&&(u16.p170>=1))")U("((u3.p28>=1)&&(u16.p170>=1))"))U(("(((u9.p107>=1)&&(u10.p120>=1))&&(u15.p169>=1))")U("(((u7.p83>=1)&&(u8.p96>=1))&&(u15.p169>=1))")))))
Formula 0 simplified : !F(("((u5.p53>=1)&&(u16.p170>=1))" U "((u3.p28>=1)&&(u16.p170>=1))") U ("(((u9.p107>=1)&&(u10.p120>=1))&&(u15.p169>=1))" U "(((u7.p83>=1)&&(u8.p96>=1))&&(u15.p169>=1))"))
built 120 ordering constraints for composite.
Reverse transition relation is exact ! Faster fixpoint algorithm enabled.
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
20 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,0.342167,22148,1,0,12549,1023,1443,14203,275,6143,17136
an accepting run exists (use option '-e' to print it)
Formula 0 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-00 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 1 : !((F(F(("(((u1.p11>=1)&&(u6.p72>=1))&&(u15.p169>=1))")U("(((u4.p47>=1)&&(u9.p108>=1))&&(u15.p169>=1))")))))
Formula 1 simplified : !F("(((u1.p11>=1)&&(u6.p72>=1))&&(u15.p169>=1))" U "(((u4.p47>=1)&&(u9.p108>=1))&&(u15.p169>=1))")
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
14 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,0.478144,28088,1,0,27295,1091,1506,31892,275,7675,35679
an accepting run exists (use option '-e' to print it)
Formula 1 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-01 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 2 : !(((G(("(((u3.p35>=1)&&(u12.p144>=1))&&(u15.p169>=1))")U("(u2.p23>=1)")))U(G(F("(u4.p37>=1)")))))
Formula 2 simplified : !(G("(((u3.p35>=1)&&(u12.p144>=1))&&(u15.p169>=1))" U "(u2.p23>=1)") U GF"(u4.p37>=1)")
4 unique states visited
4 strongly connected components in search stack
5 transitions explored
4 items max in DFS search stack
6 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,0.581127,32280,1,0,32979,1327,1773,37398,277,9568,42903
an accepting run exists (use option '-e' to print it)
Formula 2 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-02 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 3 : !((G(G(X("((u10.p110>=1)&&(u16.p170>=1))")))))
Formula 3 simplified : !GX"((u10.p110>=1)&&(u16.p170>=1))"
4 unique states visited
4 strongly connected components in search stack
4 transitions explored
4 items max in DFS search stack
1 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,0.584076,32532,1,0,32986,1345,1802,37406,277,9585,43085
an accepting run exists (use option '-e' to print it)
Formula 3 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-03 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 4 : !((G(("(u9.p97>=1)")U("(u8.p96>=1)"))))
Formula 4 simplified : !G("(u9.p97>=1)" U "(u8.p96>=1)")
3 unique states visited
3 strongly connected components in search stack
3 transitions explored
3 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,0.586731,32728,1,0,32986,1345,1837,37406,278,9585,43124
an accepting run exists (use option '-e' to print it)
Formula 4 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-04 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 5 : !(((X(G(G("(((u7.p83>=1)&&(u8.p96>=1))&&(u15.p169>=1))"))))U(X(F(G("(((u4.p47>=1)&&(u9.p108>=1))&&(u15.p169>=1))"))))))
Formula 5 simplified : !(XG"(((u7.p83>=1)&&(u8.p96>=1))&&(u15.p169>=1))" U XFG"(((u4.p47>=1)&&(u9.p108>=1))&&(u15.p169>=1))")
3 unique states visited
3 strongly connected components in search stack
3 transitions explored
3 items max in DFS search stack
77 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.35608,59576,1,0,95410,1612,1860,99009,278,13661,89356
an accepting run exists (use option '-e' to print it)
Formula 5 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-05 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 6 : !(((F(("((u12.p138>=1)&&(u15.p169>=1))")U("(((u5.p60>=1)&&(u6.p71>=1))&&(u15.p169>=1))")))U(G(X(G("(((u4.p47>=1)&&(u11.p132>=1))&&(u15.p169>=1))"))))))
Formula 6 simplified : !(F("((u12.p138>=1)&&(u15.p169>=1))" U "(((u5.p60>=1)&&(u6.p71>=1))&&(u15.p169>=1))") U GXG"(((u4.p47>=1)&&(u11.p132>=1))&&(u15.p169>=1))")
5 unique states visited
5 strongly connected components in search stack
6 transitions explored
5 items max in DFS search stack
1 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.36578,60188,1,0,95758,1616,1928,99555,278,13775,90023
an accepting run exists (use option '-e' to print it)
Formula 6 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-06 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 7 : !((F((G(X("(u1.p12>=1)")))U(X("(((u4.p48>=1)&&(u10.p119>=1))&&(u15.p169>=1))")))))
Formula 7 simplified : !F(GX"(u1.p12>=1)" U X"(((u4.p48>=1)&&(u10.p119>=1))&&(u15.p169>=1))")
3 unique states visited
3 strongly connected components in search stack
3 transitions explored
3 items max in DFS search stack
18 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.54613,64412,1,0,105555,1660,1974,113646,278,14294,102018
an accepting run exists (use option '-e' to print it)
Formula 7 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-07 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 8 : !((X("((u5.p53>=1)&&(u16.p170>=1))")))
Formula 8 simplified : !X"((u5.p53>=1)&&(u16.p170>=1))"
4 unique states visited
4 strongly connected components in search stack
4 transitions explored
4 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.54683,64676,1,0,105555,1660,1980,113646,278,14294,102034
an accepting run exists (use option '-e' to print it)
Formula 8 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-08 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 9 : !((G(F("(u12.p133>=1)"))))
Formula 9 simplified : !GF"(u12.p133>=1)"
4 unique states visited
4 strongly connected components in search stack
5 transitions explored
4 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.55003,64676,1,0,105613,1660,2026,113698,278,14308,102193
an accepting run exists (use option '-e' to print it)
Formula 9 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-09 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 10 : !((F("(u10.p113>=1)")))
Formula 10 simplified : !F"(u10.p113>=1)"
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
3 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.58377,65728,1,0,108802,1665,2104,116339,279,14455,107051
an accepting run exists (use option '-e' to print it)
Formula 10 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-10 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 11 : !((X(F("(u3.p32>=1)"))))
Formula 11 simplified : !XF"(u3.p32>=1)"
3 unique states visited
3 strongly connected components in search stack
3 transitions explored
3 items max in DFS search stack
5 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.63037,67576,1,0,113778,1665,2307,120789,280,14488,113773
an accepting run exists (use option '-e' to print it)
Formula 11 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-11 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 12 : !(((F("((u12.p138>=1)&&(u15.p169>=1))"))U(G(G(X("(((u5.p60>=1)&&(u14.p167>=1))&&(u15.p169>=1))"))))))
Formula 12 simplified : !(F"((u12.p138>=1)&&(u15.p169>=1))" U GX"(((u5.p60>=1)&&(u14.p167>=1))&&(u15.p169>=1))")
5 unique states visited
5 strongly connected components in search stack
6 transitions explored
5 items max in DFS search stack
2 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.64897,68056,1,0,114186,1715,2402,121472,280,14857,114412
an accepting run exists (use option '-e' to print it)
Formula 12 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-12 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 13 : !((G("(((u11.p131>=1)&&(u12.p144>=1))&&(u15.p169>=1))")))
Formula 13 simplified : !G"(((u11.p131>=1)&&(u12.p144>=1))&&(u15.p169>=1))"
3 unique states visited
3 strongly connected components in search stack
3 transitions explored
3 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.65094,68320,1,0,114186,1715,2432,121472,280,14857,114429
an accepting run exists (use option '-e' to print it)
Formula 13 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-13 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 14 : !((((X("(((u9.p108>=1)&&(u11.p131>=1))&&(u15.p169>=1))"))U(X("(((u6.p72>=1)&&(u11.p131>=1))&&(u15.p169>=1))")))U(G(G(G("(((u2.p24>=1)&&(u8.p95>=1))&&(u15.p169>=1))"))))))
Formula 14 simplified : !((X"(((u9.p108>=1)&&(u11.p131>=1))&&(u15.p169>=1))" U X"(((u6.p72>=1)&&(u11.p131>=1))&&(u15.p169>=1))") U G"(((u2.p24>=1)&&(u8.p95>=1))&&(u15.p169>=1))")
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
1 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.66167,68644,1,0,114705,1718,2504,122241,280,14925,115284
an accepting run exists (use option '-e' to print it)
Formula 14 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-14 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 15 : !((false))
Formula 15 simplified : 1
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.66186,68644,1,0,114705,1718,2504,122241,280,14925,115285
an accepting run exists (use option '-e' to print it)
Formula 15 is FALSE accepting run found.
FORMULA FlexibleBarrier-PT-14a-LTLFireability-15 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN

BK_STOP 1553722828343

--------------------
content from stderr:

+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ LTLFireability = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLFireability -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination LTLFireability -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss8m -Xms40m -Xmx8192m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -greatspnpath, /home/mcc/BenchKit//greatspn/, -order, META, -manyOrder, -smt]
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 99 ms
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 171 places.
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 578 transitions.
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Found NUPN structural information;
Mar 27, 2019 9:26:26 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 28 ms
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 164 ms
Mar 27, 2019 9:26:26 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 97 ms
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 578 transitions.
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 578 transitions.
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 171 places.
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 578 transitions.
Mar 27, 2019 9:26:27 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 12 ms
Mar 27, 2019 9:26:27 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 16 place invariants in 62 ms
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 171 variables to be positive in 515 ms
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 578 transitions.
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/578 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 52 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 27, 2019 9:26:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 578 transitions.
Mar 27, 2019 9:26:28 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 32 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 27, 2019 9:26:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 578 transitions.
Mar 27, 2019 9:26:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(0/578) took 93 ms. Total solver calls (SAT/UNSAT): 70(0/70)
Mar 27, 2019 9:26:35 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(31/578) took 3125 ms. Total solver calls (SAT/UNSAT): 3817(3747/70)
Mar 27, 2019 9:26:38 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(62/578) took 6192 ms. Total solver calls (SAT/UNSAT): 7771(7701/70)
Mar 27, 2019 9:26:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(94/578) took 9239 ms. Total solver calls (SAT/UNSAT): 11851(11781/70)
Mar 27, 2019 9:26:46 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(114/578) took 14417 ms. Total solver calls (SAT/UNSAT): 14729(14625/104)
Mar 27, 2019 9:26:50 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(115/578) took 18529 ms. Total solver calls (SAT/UNSAT): 15191(15029/162)
Mar 27, 2019 9:27:06 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(116/578) took 34796 ms. Total solver calls (SAT/UNSAT): 15652(15432/220)
Mar 27, 2019 9:27:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(117/578) took 49618 ms. Total solver calls (SAT/UNSAT): 16112(15834/278)
Mar 27, 2019 9:27:34 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(118/578) took 62796 ms. Total solver calls (SAT/UNSAT): 16571(16235/336)
Mar 27, 2019 9:27:46 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(119/578) took 74630 ms. Total solver calls (SAT/UNSAT): 17029(16635/394)
Mar 27, 2019 9:28:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(120/578) took 88875 ms. Total solver calls (SAT/UNSAT): 17486(17034/452)
Mar 27, 2019 9:28:13 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(121/578) took 101220 ms. Total solver calls (SAT/UNSAT): 17942(17432/510)
Mar 27, 2019 9:28:29 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(122/578) took 118103 ms. Total solver calls (SAT/UNSAT): 18397(17829/568)
Mar 27, 2019 9:28:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(123/578) took 131807 ms. Total solver calls (SAT/UNSAT): 18851(18225/626)
Mar 27, 2019 9:28:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(124/578) took 145743 ms. Total solver calls (SAT/UNSAT): 19304(18620/684)
Mar 27, 2019 9:29:13 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(125/578) took 161383 ms. Total solver calls (SAT/UNSAT): 19756(19014/742)
Mar 27, 2019 9:29:29 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(126/578) took 177419 ms. Total solver calls (SAT/UNSAT): 20207(19407/800)
Mar 27, 2019 9:29:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(127/578) took 191394 ms. Total solver calls (SAT/UNSAT): 20657(19799/858)
Mar 27, 2019 9:29:55 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(128/578) took 204029 ms. Total solver calls (SAT/UNSAT): 21106(20215/891)
Mar 27, 2019 9:30:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(129/578) took 216849 ms. Total solver calls (SAT/UNSAT): 21554(20606/948)
Mar 27, 2019 9:30:23 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(130/578) took 231237 ms. Total solver calls (SAT/UNSAT): 22001(20996/1005)
Mar 27, 2019 9:30:36 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(131/578) took 244607 ms. Total solver calls (SAT/UNSAT): 22447(21385/1062)
Mar 27, 2019 9:30:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(132/578) took 260188 ms. Total solver calls (SAT/UNSAT): 22892(21773/1119)
Mar 27, 2019 9:31:09 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(133/578) took 278104 ms. Total solver calls (SAT/UNSAT): 23336(22160/1176)
Mar 27, 2019 9:31:24 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(134/578) took 293068 ms. Total solver calls (SAT/UNSAT): 23779(22546/1233)
Mar 27, 2019 9:31:34 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(135/578) took 302240 ms. Total solver calls (SAT/UNSAT): 24221(22931/1290)
Mar 27, 2019 9:31:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(136/578) took 317048 ms. Total solver calls (SAT/UNSAT): 24662(23315/1347)
Mar 27, 2019 9:32:03 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(137/578) took 331384 ms. Total solver calls (SAT/UNSAT): 25102(23698/1404)
Mar 27, 2019 9:32:17 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(138/578) took 345240 ms. Total solver calls (SAT/UNSAT): 25541(24080/1461)
Mar 27, 2019 9:32:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(139/578) took 359772 ms. Total solver calls (SAT/UNSAT): 25979(24461/1518)
Mar 27, 2019 9:32:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(140/578) took 371303 ms. Total solver calls (SAT/UNSAT): 26416(24841/1575)
Mar 27, 2019 9:32:58 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(141/578) took 386353 ms. Total solver calls (SAT/UNSAT): 26852(25220/1632)
Mar 27, 2019 9:33:13 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(142/578) took 402084 ms. Total solver calls (SAT/UNSAT): 27287(25623/1664)
Mar 27, 2019 9:33:28 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(143/578) took 416380 ms. Total solver calls (SAT/UNSAT): 27721(26001/1720)
Mar 27, 2019 9:33:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(144/578) took 431579 ms. Total solver calls (SAT/UNSAT): 28154(26378/1776)
Mar 27, 2019 9:33:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(145/578) took 445817 ms. Total solver calls (SAT/UNSAT): 28586(26754/1832)
Mar 27, 2019 9:34:12 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(146/578) took 460733 ms. Total solver calls (SAT/UNSAT): 29017(27129/1888)
Mar 27, 2019 9:34:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(147/578) took 474139 ms. Total solver calls (SAT/UNSAT): 29447(27503/1944)
Mar 27, 2019 9:34:38 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(148/578) took 487082 ms. Total solver calls (SAT/UNSAT): 29876(27876/2000)
Mar 27, 2019 9:34:52 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(149/578) took 500997 ms. Total solver calls (SAT/UNSAT): 30304(28248/2056)
Mar 27, 2019 9:35:06 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(150/578) took 514745 ms. Total solver calls (SAT/UNSAT): 30731(28619/2112)
Mar 27, 2019 9:35:20 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(151/578) took 528238 ms. Total solver calls (SAT/UNSAT): 31157(28989/2168)
Mar 27, 2019 9:35:35 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(152/578) took 543730 ms. Total solver calls (SAT/UNSAT): 31582(29358/2224)
Mar 27, 2019 9:35:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(153/578) took 556482 ms. Total solver calls (SAT/UNSAT): 32006(29726/2280)
Mar 27, 2019 9:36:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(154/578) took 573961 ms. Total solver calls (SAT/UNSAT): 32429(30093/2336)
Mar 27, 2019 9:36:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(155/578) took 587807 ms. Total solver calls (SAT/UNSAT): 32851(30459/2392)
Mar 27, 2019 9:36:35 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(156/578) took 604087 ms. Total solver calls (SAT/UNSAT): 33272(30849/2423)
Mar 27, 2019 9:36:50 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(157/578) took 618278 ms. Total solver calls (SAT/UNSAT): 33692(31214/2478)
Mar 27, 2019 9:37:02 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(158/578) took 630183 ms. Total solver calls (SAT/UNSAT): 34111(31578/2533)
Mar 27, 2019 9:37:14 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(159/578) took 642786 ms. Total solver calls (SAT/UNSAT): 34529(31941/2588)
Mar 27, 2019 9:37:25 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(160/578) took 654022 ms. Total solver calls (SAT/UNSAT): 34946(32303/2643)
Mar 27, 2019 9:37:40 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(161/578) took 668251 ms. Total solver calls (SAT/UNSAT): 35362(32664/2698)
Mar 27, 2019 9:37:49 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(162/578) took 678049 ms. Total solver calls (SAT/UNSAT): 35777(33024/2753)
Mar 27, 2019 9:38:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(163/578) took 693821 ms. Total solver calls (SAT/UNSAT): 36191(33383/2808)
Mar 27, 2019 9:38:18 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(164/578) took 706576 ms. Total solver calls (SAT/UNSAT): 36604(33741/2863)
Mar 27, 2019 9:38:28 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(165/578) took 716778 ms. Total solver calls (SAT/UNSAT): 37016(34098/2918)
Mar 27, 2019 9:38:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(166/578) took 729114 ms. Total solver calls (SAT/UNSAT): 37427(34454/2973)
Mar 27, 2019 9:38:53 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(167/578) took 741411 ms. Total solver calls (SAT/UNSAT): 37837(34809/3028)
Mar 27, 2019 9:39:02 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(168/578) took 750916 ms. Total solver calls (SAT/UNSAT): 38246(35163/3083)
Mar 27, 2019 9:39:14 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(169/578) took 762386 ms. Total solver calls (SAT/UNSAT): 38654(35516/3138)
Mar 27, 2019 9:39:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(170/578) took 775499 ms. Total solver calls (SAT/UNSAT): 39061(35893/3168)
Mar 27, 2019 9:39:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(171/578) took 789987 ms. Total solver calls (SAT/UNSAT): 39467(36245/3222)
Mar 27, 2019 9:39:55 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(172/578) took 803236 ms. Total solver calls (SAT/UNSAT): 39872(36596/3276)
Mar 27, 2019 9:40:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(173/578) took 816749 ms. Total solver calls (SAT/UNSAT): 40276(36946/3330)
Skipping mayMatrices nes/nds SMT solver raised an exception or timeout.
java.lang.RuntimeException: SMT solver raised an exception or timeout.
at fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver.computeCoEnablingMatrix(NecessaryEnablingsolver.java:480)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printLabels(Gal2PinsTransformerNext.java:530)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printDependencyMatrix(Gal2PinsTransformerNext.java:209)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.buildBodyFile(Gal2PinsTransformerNext.java:85)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.transform(Gal2PinsTransformerNext.java:830)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:71)
at java.lang.Thread.run(Thread.java:748)
Mar 27, 2019 9:40:17 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 830570ms conformant to PINS in folder :/home/mcc/execution

cc1: out of memory allocating 110840 bytes after a total of 3350528 bytes
java.lang.RuntimeException: Could not compile executable .CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
at fr.lip6.move.gal.application.LTSminRunner.compilePINS(LTSminRunner.java:242)
at fr.lip6.move.gal.application.LTSminRunner.access$6(LTSminRunner.java:225)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:75)
at java.lang.Thread.run(Thread.java:748)
ITS-tools command line returned an error code 1
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 105 ms
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 100 ms
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Decomposing Gal with order
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting arrays to variables to allow decomposition.
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t382,t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,t224,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t234,t234,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t502,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,t234,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 25 events :t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 365 events :t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,t184,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t212,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t238,t212,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t230,t230,t230,t230,t230,t230,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t454,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,t230,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t220,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t334,t220,t220,t220,t220,t220,t220,t220,t220,t220,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t228,t228,t228,t228,t228,t228,t228,t228,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t430,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,t228,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t526,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,t236,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t358,t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,t222,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t232,t232,t232,t232,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t478,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,t232,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t216,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t286,t216,t216,t216,t216,t216,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t214,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t262,t214,t214,t214,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t218,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t310,t218,t218,t218,t218,t218,t218,t218,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 48 events :t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t406,t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,t226,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 69 events :t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,t114,
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.Instantiator fuseIsomorphicEffects
INFO: Removed a total of 1083 redundant transitions.
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 253 ms
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu9_flat :[u9.t125, u9.t167, u9.t139, u9.t181, u9.t153]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu7_flat :[u7.t180, u7.t152, u7.t166, u7.t124, u7.t138]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu13_flat :[u13.t183, u13.t127, u13.t169, u13.t155, u13.t141]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu2_flat :[u2.t204, u2.t190]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu4_flat :[u4.t203, u4.t189]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu11_flat :[u11.t154, u11.t140, u11.t182, u11.t126, u11.t168]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu6_flat :[u6.t202, u6.t188]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu10_flat :[u10.t172, u10.t130, u10.t144, u10.t158, u10.t116]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu5_flat :[u5.t193, u5.t207]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu2_flat :[u2.t162, u2.t176, u2.t120, u2.t134, u2.t148]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu8_flat :[u8.t187, u8.t201]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu14_flat :[u14.t198, u14.t184]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu7_flat :[u7.t208, u7.t194]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu1_flat :[u1.t149, u1.t135, u1.t163, u1.t121, u1.t177]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu12_flat :[u12.t185, u12.t199]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu5_flat :[u5.t151, u5.t137, u5.t179, u5.t123, u5.t165]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu6_flat :[u6.t146, u6.t132, u6.t160, u6.t174, u6.t118]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu9_flat :[u9.t195, u9.t209]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu13_flat :[u13.t211, u13.t197]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu10_flat :[u10.t186, u10.t200]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu3_flat :[u3.t122, u3.t178, u3.t150, u3.t164, u3.t136]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu11_flat :[u11.t210, u11.t196]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu4_flat :[u4.t161, u4.t119, u4.t175, u4.t147, u4.t133]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu1_flat :[u1.t205, u1.t191]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu8_flat :[u8.t131, u8.t173, u8.t117, u8.t159, u8.t145]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu14_flat :[u14.t156, u14.t114, u14.t142, u14.t170, u14.t128]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu3_flat :[u3.t206, u3.t192]
Mar 27, 2019 9:40:25 PM fr.lip6.move.gal.instantiate.CompositeBuilder fuseSimilarLabels
INFO: Found fuseable labels in Tu12_flat :[u12.t115, u12.t171, u12.t129, u12.t157, u12.t143]
Mar 27, 2019 9:40:25 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 18 ms
Mar 27, 2019 9:40:25 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms

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="FlexibleBarrier-PT-14a"
export BK_EXAMINATION="LTLFireability"
export BK_TOOL="itstoolsm"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"

# 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-3954"
echo " Executing tool itstoolsm"
echo " Input is FlexibleBarrier-PT-14a, examination is LTLFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r195-csrt-155246554100223"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/FlexibleBarrier-PT-14a.tgz
mv FlexibleBarrier-PT-14a execution
cd execution
if [ "LTLFireability" = "GlobalProperties" ] ; then
rm -f GenericPropertiesVerdict.xml
fi
if [ "LTLFireability" = "UpperBounds" ] ; 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 [ "LTLFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "LTLFireability" != "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 "LTLFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property LTLFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "LTLFireability.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 '' LTLFireability.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
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 ;