Execution Chart

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

Trace from the execution

Formatting '/data/fko/mcc2019-input.r197-oct2-155272230100057.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fko/mcc2019-input.qcow2 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 NQueens-PT-25, examination is GlobalProperties
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r197-oct2-155272230100057
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 680K
-rw-r--r-- 1 mcc users 3.4K Feb 11 23:03 CTLCardinality.txt
-rw-r--r-- 1 mcc users 19K Feb 11 23:03 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.2K Feb 7 23:57 CTLFireability.txt
-rw-r--r-- 1 mcc users 19K Feb 7 23:57 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 10 17:31 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 100 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 338 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.5K Feb 5 00:16 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K Feb 5 00:16 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Feb 4 22:36 LTLFireability.txt
-rw-r--r-- 1 mcc users 8.9K Feb 4 22:36 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.1K Feb 4 06:32 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 22K Feb 4 06:32 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.8K Feb 1 00:07 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 14K Feb 1 00:07 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 4 22:21 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.6K Feb 4 22:21 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 equiv_col
-rw-r--r-- 1 mcc users 3 Jan 29 09:34 instance
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 iscolored
-rw-r--r-- 1 mcc users 516K 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 NQueens-PT-25-GlobalProperties-0

=== Now, execution of the tool begins

BK_START 1553629579513

Working with output stream class java.io.PrintStream
Flatten gal took : 442 ms
Constant places removed 625 places and 0 transitions.
Iterating post reduction 0 with 625 rules applied. Total rules applied 625 place count 148 transition count 625
Applied a total of 625 rules in 26 ms. Remains 148 /773 variables (removed 625) and now considering 625/625 (removed 0) transitions.
Random walk for 250 k steps run took 38114 ms.
// Phase 1: matrix 625 rows 148 cols
Random walk for 4 * 500 k steps run took 279974 ms.
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
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/GlobalProperties.pnml.gal, -t, CGAL, -ctl, DEADLOCK, --load-order, /home/mcc/execution/model.ord], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/GlobalProperties.pnml.gal -t CGAL -ctl DEADLOCK --load-order /home/mcc/execution/model.ord
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
// Phase 1: matrix 625 rows 148 cols
Successfully loaded order from file /home/mcc/execution/model.ord
No direction supplied, using forward translation only.
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]
Compilation finished in 11953 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 92 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -d], workingDir=/home/mcc/execution]
Detected timeout of ITS tools.
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/GlobalProperties.pnml.gal, -t, CGAL, -ctl, DEADLOCK], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/GlobalProperties.pnml.gal -t CGAL -ctl DEADLOCK
No direction supplied, using forward translation only.
Detected timeout of ITS tools.
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.201903251645/bin/convert-linux64, -i, /tmp/graph1506456122205601928.txt, -o, /tmp/graph1506456122205601928.bin, -w, /tmp/graph1506456122205601928.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.201903251645/bin/louvain-linux64, /tmp/graph1506456122205601928.bin, -l, -1, -v, -w, /tmp/graph1506456122205601928.weights, -q, 0, -e, 0.001], workingDir=null]
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ctl-linux64, --gc-threshold, 2000000, --quiet, -i, /home/mcc/execution/GlobalProperties.pnml.gal, -t, CGAL, -ctl, DEADLOCK], workingDir=/home/mcc/execution]

its-ctl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ctl-linux64 --gc-threshold 2000000 --quiet -i /home/mcc/execution/GlobalProperties.pnml.gal -t CGAL -ctl DEADLOCK
No direction supplied, using forward translation only.
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -d], workingDir=/home/mcc/execution]
255

BK_TIME_CONFINEMENT_REACHED

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

+ export BINDIR=/home/mcc/BenchKit/
+ BINDIR=/home/mcc/BenchKit/
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ GlobalProperties = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution GlobalProperties -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 GlobalProperties -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 26, 2019 7:46:21 PM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, GlobalProperties, -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 26, 2019 7:46:21 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 26, 2019 7:46:21 PM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 192 ms
Mar 26, 2019 7:46:21 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 775 places.
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 625 transitions.
Mar 26, 2019 7:46:22 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 77 ms
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 2 fixed domain variables (out of 775 variables) in GAL type NQueens_PT_25
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: Found a total of 2 constant array cells/variables (out of 775 variables) in type NQueens_PT_25
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: L_49,R_0,
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 2 fixed domain variables (out of 775 variables) in GAL type NQueens_PT_25
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: Found a total of 2 constant array cells/variables (out of 775 variables) in type NQueens_PT_25
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: L_49,R_0,
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.Simplifier simplifyConstantVariables
INFO: Removed 2 constant variables :L_49=1, R_0=1
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.PropertySimplifier evalInInitialState
WARNING: Unexpected boolean logic operator in evalInInitialState fr.lip6.move.gal.impl.EXImpl
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-25-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 7:46:22 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 439 ms
Mar 26, 2019 7:46:22 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.simple.gal : 138 ms
Mar 26, 2019 7:46:23 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 625 transitions.
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 625 transitions.
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-25-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 181 ms
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 625 transitions.
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 148 places.
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 625 transitions.
java.lang.NullPointerException
at fr.lip6.move.gal.application.Application.computeOrderWithGreatSPN(Application.java:475)
at fr.lip6.move.gal.application.Application.runMultiITS(Application.java:392)
at fr.lip6.move.gal.application.Application.start(Application.java:319)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:40)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:137)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:107)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:400)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:595)
at org.eclipse.equinox.launcher.Main.run(Main.java:1501)
at org.eclipse.equinox.launcher.Main.main(Main.java:1474)
Mar 26, 2019 7:51:42 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/GlobalProperties.pnml.gal : 3 ms
Mar 26, 2019 7:51:42 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 0 place invariants in 30 ms
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 148 variables to be positive in 925 ms
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 625 transitions.
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/625 took 1 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 82 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 625 transitions.
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 54 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:51:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 625 transitions.
Mar 26, 2019 7:51:47 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(28/625) took 3240 ms. Total solver calls (SAT/UNSAT): 1935(1935/0)
Mar 26, 2019 7:51:50 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(58/625) took 6429 ms. Total solver calls (SAT/UNSAT): 3783(3783/0)
Mar 26, 2019 7:51:53 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(81/625) took 9698 ms. Total solver calls (SAT/UNSAT): 5123(5123/0)
Mar 26, 2019 7:51:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(93/625) took 13137 ms. Total solver calls (SAT/UNSAT): 5798(5798/0)
Mar 26, 2019 7:52:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(115/625) took 16387 ms. Total solver calls (SAT/UNSAT): 7024(7024/0)
Mar 26, 2019 7:52:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(135/625) took 20790 ms. Total solver calls (SAT/UNSAT): 8060(8060/0)
Mar 26, 2019 7:52:09 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(138/625) took 25483 ms. Total solver calls (SAT/UNSAT): 8228(8228/0)
Mar 26, 2019 7:52:13 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(141/625) took 29712 ms. Total solver calls (SAT/UNSAT): 8396(8396/0)
Mar 26, 2019 7:52:17 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(143/625) took 33530 ms. Total solver calls (SAT/UNSAT): 8508(8508/0)
Mar 26, 2019 7:52:20 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(145/625) took 36639 ms. Total solver calls (SAT/UNSAT): 8618(8618/0)
Mar 26, 2019 7:52:23 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(147/625) took 39896 ms. Total solver calls (SAT/UNSAT): 8720(8720/0)
Mar 26, 2019 7:52:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(150/625) took 43888 ms. Total solver calls (SAT/UNSAT): 8858(8858/0)
Mar 26, 2019 7:52:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(153/625) took 47283 ms. Total solver calls (SAT/UNSAT): 8995(8995/0)
Mar 26, 2019 7:52:35 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(156/625) took 51489 ms. Total solver calls (SAT/UNSAT): 9160(9160/0)
Mar 26, 2019 7:52:38 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(158/625) took 54721 ms. Total solver calls (SAT/UNSAT): 9270(9270/0)
Mar 26, 2019 7:52:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(160/625) took 57865 ms. Total solver calls (SAT/UNSAT): 9380(9380/0)
Mar 26, 2019 7:52:46 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(163/625) took 62295 ms. Total solver calls (SAT/UNSAT): 9541(9541/0)
Mar 26, 2019 7:52:50 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(167/625) took 66069 ms. Total solver calls (SAT/UNSAT): 9729(9729/0)
Mar 26, 2019 7:52:53 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(170/625) took 69430 ms. Total solver calls (SAT/UNSAT): 9849(9849/0)
Mar 26, 2019 7:52:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(174/625) took 73338 ms. Total solver calls (SAT/UNSAT): 10065(10065/0)
Mar 26, 2019 7:53:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(177/625) took 76991 ms. Total solver calls (SAT/UNSAT): 10227(10227/0)
Mar 26, 2019 7:53:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(179/625) took 80362 ms. Total solver calls (SAT/UNSAT): 10335(10335/0)
Mar 26, 2019 7:53:07 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(188/625) took 83365 ms. Total solver calls (SAT/UNSAT): 10749(10749/0)
Mar 26, 2019 7:53:10 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(196/625) took 87027 ms. Total solver calls (SAT/UNSAT): 11156(11156/0)
Mar 26, 2019 7:53:14 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(198/625) took 90590 ms. Total solver calls (SAT/UNSAT): 11262(11262/0)
Mar 26, 2019 7:53:17 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(203/625) took 93656 ms. Total solver calls (SAT/UNSAT): 11511(11511/0)
Mar 26, 2019 7:53:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(207/625) took 97454 ms. Total solver calls (SAT/UNSAT): 11675(11675/0)
Mar 26, 2019 7:53:24 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(238/625) took 100635 ms. Total solver calls (SAT/UNSAT): 13135(13135/0)
Mar 26, 2019 7:53:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(249/625) took 103645 ms. Total solver calls (SAT/UNSAT): 13632(13632/0)
Mar 26, 2019 7:53:31 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(259/625) took 107686 ms. Total solver calls (SAT/UNSAT): 14078(14078/0)
Mar 26, 2019 7:53:34 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(264/625) took 111020 ms. Total solver calls (SAT/UNSAT): 14328(14328/0)
Mar 26, 2019 7:53:38 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(271/625) took 114199 ms. Total solver calls (SAT/UNSAT): 14622(14622/0)
Mar 26, 2019 7:53:42 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(279/625) took 118528 ms. Total solver calls (SAT/UNSAT): 14942(14942/0)
Mar 26, 2019 7:53:46 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(282/625) took 122827 ms. Total solver calls (SAT/UNSAT): 15089(15089/0)
Mar 26, 2019 7:53:49 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(290/625) took 125872 ms. Total solver calls (SAT/UNSAT): 15472(15472/0)
Mar 26, 2019 7:53:53 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(302/625) took 129191 ms. Total solver calls (SAT/UNSAT): 15922(15922/0)
Mar 26, 2019 7:53:57 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(305/625) took 133370 ms. Total solver calls (SAT/UNSAT): 16066(16066/0)
Mar 26, 2019 7:54:00 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(311/625) took 136547 ms. Total solver calls (SAT/UNSAT): 16354(16354/0)
Mar 26, 2019 7:54:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(314/625) took 140366 ms. Total solver calls (SAT/UNSAT): 16492(16492/0)
Mar 26, 2019 7:54:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(319/625) took 144075 ms. Total solver calls (SAT/UNSAT): 16682(16682/0)
Mar 26, 2019 7:54:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(325/625) took 147669 ms. Total solver calls (SAT/UNSAT): 16868(16868/0)
Mar 26, 2019 7:54:14 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(336/625) took 150958 ms. Total solver calls (SAT/UNSAT): 17374(17374/0)
Mar 26, 2019 7:54:18 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(348/625) took 154247 ms. Total solver calls (SAT/UNSAT): 17782(17782/0)
Mar 26, 2019 7:54:21 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(353/625) took 157538 ms. Total solver calls (SAT/UNSAT): 18002(18002/0)
Mar 26, 2019 7:54:25 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(357/625) took 161532 ms. Total solver calls (SAT/UNSAT): 18178(18178/0)
Mar 26, 2019 7:54:28 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(360/625) took 164958 ms. Total solver calls (SAT/UNSAT): 18310(18310/0)
Mar 26, 2019 7:54:32 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(365/625) took 168304 ms. Total solver calls (SAT/UNSAT): 18500(18500/0)
Mar 26, 2019 7:54:35 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(376/625) took 171318 ms. Total solver calls (SAT/UNSAT): 18872(18872/0)
Mar 26, 2019 7:54:38 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(421/625) took 174351 ms. Total solver calls (SAT/UNSAT): 20461(20461/0)
Mar 26, 2019 7:54:41 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(452/625) took 177352 ms. Total solver calls (SAT/UNSAT): 21431(21431/0)
Mar 26, 2019 7:54:44 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(477/625) took 180966 ms. Total solver calls (SAT/UNSAT): 22172(22172/0)
Mar 26, 2019 7:54:47 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(508/625) took 183975 ms. Total solver calls (SAT/UNSAT): 22980(22980/0)
Mar 26, 2019 7:54:51 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(540/625) took 187097 ms. Total solver calls (SAT/UNSAT): 23715(23715/0)
Mar 26, 2019 7:54:54 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(576/625) took 190116 ms. Total solver calls (SAT/UNSAT): 24357(24357/0)
Mar 26, 2019 7:54:56 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 192447 ms. Total solver calls (SAT/UNSAT): 24800(24800/0)
Mar 26, 2019 7:54:56 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 625 transitions.
Mar 26, 2019 7:54:56 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 69 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:54:56 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 194513ms conformant to PINS in folder :/home/mcc/execution
Mar 26, 2019 8:11:45 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-25-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:11:45 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 837 ms
Mar 26, 2019 8:11:45 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/GlobalProperties.pnml.gal : 59 ms
Mar 26, 2019 8:31:45 PM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 26, 2019 8:31:46 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-25-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:31:46 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 444 ms
Mar 26, 2019 8:31:46 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-25-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:31:46 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 274 ms
Begin: Tue Mar 26 20:31:46 2019
Mar 26, 2019 8:31:46 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Decomposing Gal with order
Mar 26, 2019 8:31:46 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting arrays to variables to allow decomposition.
Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_0 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_1 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_2 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_3 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_4 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_5 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_6 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_7 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_8 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_9 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_10 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_11 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_12 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_13 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_14 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_15 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_16 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_17 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_18 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_19 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_20 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_21 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_22 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_23 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cX_24 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_0 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_1 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_2 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_3 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_4 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_5 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_6 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_7 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_8 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_9 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_10 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_11 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_12 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_13 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_14 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_15 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_16 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_17 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_18 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_19 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_20 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_21 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_22 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_23 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to cY_24 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_0 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_1 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_2 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_3 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_4 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_5 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_6 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_7 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_8 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_9 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_10 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_11 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_12 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_13 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_14 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_15 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_16 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_17 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_18 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_19 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_20 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_21 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_22 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_23 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_24 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_25 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_26 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_27 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_28 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_29 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_30 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_31 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_32 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_33 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_34 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_35 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_36 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_37 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_38 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_39 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_40 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_41 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_42 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_43 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_44 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_45 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_46 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_47 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to L_48 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_1 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_2 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_3 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_4 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_5 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_6 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_7 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_8 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_9 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_10 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_11 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_12 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_13 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_14 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_15 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_16 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_17 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_18 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_19 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_20 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_21 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_22 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_23 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_24 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_25 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_26 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_27 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_28 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_29 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_30 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_31 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_32 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_33 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_34 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_35 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_36 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_37 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_38 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_39 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_40 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_41 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_42 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_43 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_44 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_45 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_46 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_47 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_48 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.CompositeBuilder$Partition getIndex
INFO: Could not find partition element corresponding to R_49 in partition

Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.application.MccTranslator applyOrder
WARNING: Could not apply decomposition. Using flat GAL structure.
java.lang.ArrayIndexOutOfBoundsException: -1
at org.eclipse.emf.common.util.BasicEList.get(BasicEList.java:348)
at fr.lip6.move.gal.instantiate.CompositeBuilder.galToCompositeWithPartition(CompositeBuilder.java:560)
at fr.lip6.move.gal.instantiate.CompositeBuilder.decomposeWithOrder(CompositeBuilder.java:147)
at fr.lip6.move.gal.application.MccTranslator.applyOrder(MccTranslator.java:129)
at fr.lip6.move.gal.application.MccTranslator.flattenSpec(MccTranslator.java:156)
at fr.lip6.move.gal.application.Application.runMultiITS(Application.java:427)
at fr.lip6.move.gal.application.Application.start(Application.java:319)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:40)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:137)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:107)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:400)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:595)
at org.eclipse.equinox.launcher.Main.run(Main.java:1501)
at org.eclipse.equinox.launcher.Main.main(Main.java:1474)
Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-25-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:31:47 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 235 ms
Mar 26, 2019 8:31:47 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/GlobalProperties.pnml.gal : 4 ms
pins2lts-mc, 0.000: Registering PINS so language module
pins2lts-mc( 0/ 8), 0.028: Loading model from ./gal.so
pins2lts-mc( 6/ 8), 0.037: library has no initializer
pins2lts-mc( 6/ 8), 0.037: loading model GAL
pins2lts-mc( 4/ 8), 0.037: library has no initializer
pins2lts-mc( 4/ 8), 0.037: loading model GAL
pins2lts-mc( 1/ 8), 0.037: library has no initializer
pins2lts-mc( 1/ 8), 0.038: loading model GAL
pins2lts-mc( 0/ 8), 0.029: library has no initializer
pins2lts-mc( 0/ 8), 0.030: loading model GAL
pins2lts-mc( 7/ 8), 0.037: library has no initializer
pins2lts-mc( 7/ 8), 0.038: loading model GAL
pins2lts-mc( 5/ 8), 0.029: library has no initializer
pins2lts-mc( 5/ 8), 0.030: loading model GAL
pins2lts-mc( 2/ 8), 0.037: library has no initializer
pins2lts-mc( 2/ 8), 0.039: loading model GAL
pins2lts-mc( 3/ 8), 0.020: library has no initializer
pins2lts-mc( 3/ 8), 0.032: loading model GAL
pins2lts-mc( 4/ 8), 0.451: completed loading model GAL
pins2lts-mc( 7/ 8), 0.457: completed loading model GAL
pins2lts-mc( 1/ 8), 0.458: completed loading model GAL
pins2lts-mc( 2/ 8), 0.469: completed loading model GAL
pins2lts-mc( 3/ 8), 0.464: completed loading model GAL
pins2lts-mc( 6/ 8), 0.482: completed loading model GAL
pins2lts-mc( 0/ 8), 0.535: completed loading model GAL
pins2lts-mc( 0/ 8), 0.535: Initializing POR dependencies: labels 626, guards 625
pins2lts-mc( 5/ 8), 0.745: completed loading model GAL
pins2lts-mc( 0/ 8), 2.677: There are 626 state labels and 1 edge labels
pins2lts-mc( 0/ 8), 2.677: State length is 148, there are 625 groups
pins2lts-mc( 0/ 8), 2.677: Running bfs using 8 cores
pins2lts-mc( 0/ 8), 2.677: Using a non-indexing tree table with 2^27 elements
pins2lts-mc( 0/ 8), 2.677: Successor permutation: none
pins2lts-mc( 0/ 8), 2.677: Visible groups: 0 / 625, labels: 0 / 626
pins2lts-mc( 0/ 8), 2.677: POR cycle proviso: none
pins2lts-mc( 0/ 8), 2.677: Global bits: 0, count bits: 0, local bits: 0
pins2lts-mc( 3/ 8), 38.816: ~0 levels ~960 states ~520784 transitions
pins2lts-mc( 1/ 8), 95.749: ~1 levels ~1920 states ~1003280 transitions
pins2lts-mc( 6/ 8), 179.816: ~1 levels ~3840 states ~1828176 transitions
pins2lts-mc( 6/ 8), 254.915: ~1 levels ~7680 states ~3620664 transitions
pins2lts-mc( 6/ 8), 386.372: ~1 levels ~15360 states ~7196744 transitions
pins2lts-mc( 7/ 8), 670.847: ~1 levels ~30720 states ~14577096 transitions
pins2lts-mc( 5/ 8), 1241.187: ~1 levels ~61440 states ~29067984 transitions
pins2lts-mc( 5/ 8), 2333.027: ~1 levels ~122880 states ~58139728 transitions
pins2lts-mc( 0/ 8), 2860.062: Error: tree leafs table full! Change -s/--ratio.
pins2lts-mc( 0/ 8), 2872.114:
pins2lts-mc( 0/ 8), 2872.114: mean standard work distribution: 2.5% (states) 1.8% (transitions)
pins2lts-mc( 0/ 8), 2872.114:
pins2lts-mc( 0/ 8), 2872.114: Explored 148357 states 69509614 transitions, fanout: 468.529
pins2lts-mc( 0/ 8), 2872.114: Total exploration time 2869.300 sec (2857.460 sec minimum, 2861.721 sec on average)
pins2lts-mc( 0/ 8), 2872.114: States per second: 52, Transitions per second: 24225
pins2lts-mc( 0/ 8), 2872.114:
pins2lts-mc( 0/ 8), 2872.114: Queue width: 8B, total height: 30082066, memory: 229.51MB
pins2lts-mc( 0/ 8), 2872.114: Tree memory: 486.7MB, 16.9 B/state, compr.: 2.8%
pins2lts-mc( 0/ 8), 2872.114: Tree fill ratio (roots/leafs): 22.0%/100.0%
pins2lts-mc( 0/ 8), 2872.114: Stored 632 string chucks using 0MB
pins2lts-mc( 0/ 8), 2872.114: Total memory used for chunk indexing: 0MB
pins2lts-mc( 0/ 8), 2872.114: Est. total memory use: 716.2MB (~1253.5MB paged-in)
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, -d], workingDir=/home/mcc/execution]
255
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:168)
at fr.lip6.move.gal.application.LTSminRunner.access$9(LTSminRunner.java:122)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:91)
at java.lang.Thread.run(Thread.java:748)

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="NQueens-PT-25"
export BK_EXAMINATION="GlobalProperties"
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 NQueens-PT-25, examination is GlobalProperties"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r197-oct2-155272230100057"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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