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-155272230100048.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-20, examination is GlobalProperties
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r197-oct2-155272230100048
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 492K
-rw-r--r-- 1 mcc users 3.2K Feb 11 23:02 CTLCardinality.txt
-rw-r--r-- 1 mcc users 17K Feb 11 23:02 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.4K Feb 7 23:56 CTLFireability.txt
-rw-r--r-- 1 mcc users 21K Feb 7 23:56 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:15 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K Feb 5 00:15 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Feb 4 22:36 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.9K Feb 4 22:36 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.1K Feb 4 06:32 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 15K Feb 4 06:32 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.1K Feb 1 00:07 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 16K 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 335K 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-20-GlobalProperties-0

=== Now, execution of the tool begins

BK_START 1553628146360

Working with output stream class java.io.PrintStream
Flatten gal took : 204 ms
Constant places removed 400 places and 0 transitions.
Iterating post reduction 0 with 400 rules applied. Total rules applied 400 place count 118 transition count 400
Applied a total of 400 rules in 17 ms. Remains 118 /518 variables (removed 400) and now considering 400/400 (removed 0) transitions.
Random walk for 250 k steps run took 28110 ms.
// Phase 1: matrix 400 rows 118 cols
Random walk for 4 * 500 k steps run took 193147 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]
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.

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
// Phase 1: matrix 400 rows 118 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 4810 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 60 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.
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
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/graph2963579330797591461.txt, -o, /tmp/graph2963579330797591461.bin, -w, /tmp/graph2963579330797591461.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/graph2963579330797591461.bin, -l, -1, -v, -w, /tmp/graph2963579330797591461.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.
sparsehash FATAL ERROR: failed to allocate 32 groups

BK_STOP 1553631518456

--------------------
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:22:28 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:22:28 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 26, 2019 7:22:28 PM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 154 ms
Mar 26, 2019 7:22:28 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 520 places.
Mar 26, 2019 7:22:28 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 400 transitions.
Mar 26, 2019 7:22:28 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 32 ms
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 2 fixed domain variables (out of 520 variables) in GAL type NQueens_PT_20
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: Found a total of 2 constant array cells/variables (out of 520 variables) in type NQueens_PT_20
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: L_39,R_0,
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 2 fixed domain variables (out of 520 variables) in GAL type NQueens_PT_20
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: Found a total of 2 constant array cells/variables (out of 520 variables) in type NQueens_PT_20
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: L_39,R_0,
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.Simplifier simplifyConstantVariables
INFO: Removed 2 constant variables :L_39=1, R_0=1
Mar 26, 2019 7:22:29 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:22:29 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-20-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 201 ms
Mar 26, 2019 7:22:29 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.simple.gal : 8 ms
Mar 26, 2019 7:22:29 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 400 transitions.
Mar 26, 2019 7:26:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-20-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 7:26:11 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 196 ms
Mar 26, 2019 7:26:11 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 400 transitions.
Mar 26, 2019 7:26:11 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 400 transitions.
Mar 26, 2019 7:26:11 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 118 places.
Mar 26, 2019 7:26:11 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 400 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:26:11 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/GlobalProperties.pnml.gal : 19 ms
Mar 26, 2019 7:26:12 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 0 place invariants in 34 ms
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 118 variables to be positive in 3881 ms
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 400 transitions.
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/400 took 1 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 140 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 400 transitions.
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 18 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:26:16 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 400 transitions.
Mar 26, 2019 7:26:20 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(1/400) took 3720 ms. Total solver calls (SAT/UNSAT): 113(113/0)
Mar 26, 2019 7:26:23 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(3/400) took 7007 ms. Total solver calls (SAT/UNSAT): 223(223/0)
Mar 26, 2019 7:26:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(5/400) took 10107 ms. Total solver calls (SAT/UNSAT): 331(331/0)
Mar 26, 2019 7:26:29 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(7/400) took 13391 ms. Total solver calls (SAT/UNSAT): 439(439/0)
Mar 26, 2019 7:26:33 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(10/400) took 17590 ms. Total solver calls (SAT/UNSAT): 596(596/0)
Mar 26, 2019 7:26:37 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(12/400) took 20751 ms. Total solver calls (SAT/UNSAT): 702(702/0)
Mar 26, 2019 7:26:40 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(16/400) took 24197 ms. Total solver calls (SAT/UNSAT): 906(906/0)
Mar 26, 2019 7:26:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(25/400) took 27435 ms. Total solver calls (SAT/UNSAT): 1358(1358/0)
Mar 26, 2019 7:26:47 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(30/400) took 31227 ms. Total solver calls (SAT/UNSAT): 1600(1600/0)
Mar 26, 2019 7:26:51 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(35/400) took 35167 ms. Total solver calls (SAT/UNSAT): 1834(1834/0)
Mar 26, 2019 7:26:54 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(37/400) took 38365 ms. Total solver calls (SAT/UNSAT): 1932(1932/0)
Mar 26, 2019 7:26:58 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(40/400) took 41763 ms. Total solver calls (SAT/UNSAT): 2079(2079/0)
Mar 26, 2019 7:27:01 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(44/400) took 45583 ms. Total solver calls (SAT/UNSAT): 2255(2255/0)
Mar 26, 2019 7:27:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(47/400) took 49287 ms. Total solver calls (SAT/UNSAT): 2399(2399/0)
Mar 26, 2019 7:27:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(51/400) took 52388 ms. Total solver calls (SAT/UNSAT): 2587(2587/0)
Mar 26, 2019 7:27:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(55/400) took 55489 ms. Total solver calls (SAT/UNSAT): 2757(2757/0)
Mar 26, 2019 7:27:15 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(59/400) took 59336 ms. Total solver calls (SAT/UNSAT): 2945(2945/0)
Mar 26, 2019 7:27:18 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(63/400) took 62491 ms. Total solver calls (SAT/UNSAT): 3121(3121/0)
Mar 26, 2019 7:27:23 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(71/400) took 67010 ms. Total solver calls (SAT/UNSAT): 3473(3473/0)
Mar 26, 2019 7:27:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(74/400) took 70561 ms. Total solver calls (SAT/UNSAT): 3602(3602/0)
Mar 26, 2019 7:27:30 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(77/400) took 73752 ms. Total solver calls (SAT/UNSAT): 3713(3713/0)
Mar 26, 2019 7:27:33 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(80/400) took 77475 ms. Total solver calls (SAT/UNSAT): 3848(3848/0)
Mar 26, 2019 7:27:37 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(83/400) took 81215 ms. Total solver calls (SAT/UNSAT): 3983(3983/0)
Mar 26, 2019 7:27:40 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(99/400) took 84422 ms. Total solver calls (SAT/UNSAT): 4648(4648/0)
Mar 26, 2019 7:27:44 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(121/400) took 88367 ms. Total solver calls (SAT/UNSAT): 5496(5496/0)
Mar 26, 2019 7:27:48 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(133/400) took 92171 ms. Total solver calls (SAT/UNSAT): 5964(5964/0)
Mar 26, 2019 7:27:51 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(140/400) took 95411 ms. Total solver calls (SAT/UNSAT): 6225(6225/0)
Mar 26, 2019 7:27:55 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(152/400) took 98807 ms. Total solver calls (SAT/UNSAT): 6645(6645/0)
Mar 26, 2019 7:27:58 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(170/400) took 101823 ms. Total solver calls (SAT/UNSAT): 7284(7284/0)
Mar 26, 2019 7:28:01 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(189/400) took 104909 ms. Total solver calls (SAT/UNSAT): 7935(7935/0)
Mar 26, 2019 7:28:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(210/400) took 108911 ms. Total solver calls (SAT/UNSAT): 8631(8631/0)
Mar 26, 2019 7:28:08 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(224/400) took 112291 ms. Total solver calls (SAT/UNSAT): 9105(9105/0)
Mar 26, 2019 7:28:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(229/400) took 115628 ms. Total solver calls (SAT/UNSAT): 9223(9223/0)
Mar 26, 2019 7:28:15 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(252/400) took 119589 ms. Total solver calls (SAT/UNSAT): 9912(9912/0)
Mar 26, 2019 7:28:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(269/400) took 123320 ms. Total solver calls (SAT/UNSAT): 10372(10372/0)
Mar 26, 2019 7:28:23 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(273/400) took 126782 ms. Total solver calls (SAT/UNSAT): 10488(10488/0)
Mar 26, 2019 7:28:26 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(280/400) took 130592 ms. Total solver calls (SAT/UNSAT): 10636(10636/0)
Mar 26, 2019 7:28:30 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(293/400) took 133882 ms. Total solver calls (SAT/UNSAT): 10958(10958/0)
Mar 26, 2019 7:28:33 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(309/400) took 137106 ms. Total solver calls (SAT/UNSAT): 11311(11311/0)
Mar 26, 2019 7:28:37 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(328/400) took 140719 ms. Total solver calls (SAT/UNSAT): 11710(11710/0)
Mar 26, 2019 7:28:40 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(341/400) took 143729 ms. Total solver calls (SAT/UNSAT): 11939(11939/0)
Mar 26, 2019 7:28:43 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(361/400) took 146746 ms. Total solver calls (SAT/UNSAT): 12236(12236/0)
Mar 26, 2019 7:28:46 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(370/400) took 149774 ms. Total solver calls (SAT/UNSAT): 12343(12343/0)
Mar 26, 2019 7:28:49 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 152763 ms. Total solver calls (SAT/UNSAT): 12540(12540/0)
Mar 26, 2019 7:28:49 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 400 transitions.
Mar 26, 2019 7:28:49 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 23 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 7:28:49 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 158005ms conformant to PINS in folder :/home/mcc/execution
Mar 26, 2019 7:46:13 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-20-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 7:46:13 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 534 ms
Mar 26, 2019 7:46:13 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/GlobalProperties.pnml.gal : 27 ms
pins2lts-mc, 0.051: Registering PINS so language module
pins2lts-mc( 0/ 8), 0.065: Loading model from ./gal.so
pins2lts-mc( 7/ 8), 0.024: library has no initializer
pins2lts-mc( 7/ 8), 0.024: loading model GAL
pins2lts-mc( 0/ 8), 0.067: library has no initializer
pins2lts-mc( 0/ 8), 0.067: loading model GAL
pins2lts-mc( 6/ 8), 0.051: library has no initializer
pins2lts-mc( 6/ 8), 0.055: loading model GAL
pins2lts-mc( 1/ 8), 0.028: library has no initializer
pins2lts-mc( 2/ 8), 0.081: library has no initializer
pins2lts-mc( 2/ 8), 0.112: loading model GAL
pins2lts-mc( 5/ 8), 0.055: library has no initializer
pins2lts-mc( 3/ 8), 0.051: library has no initializer
pins2lts-mc( 3/ 8), 0.110: loading model GAL
pins2lts-mc( 5/ 8), 0.111: loading model GAL
pins2lts-mc( 4/ 8), 0.055: library has no initializer
pins2lts-mc( 4/ 8), 0.111: loading model GAL
pins2lts-mc( 1/ 8), 0.060: loading model GAL
pins2lts-mc( 7/ 8), 0.435: completed loading model GAL
pins2lts-mc( 0/ 8), 0.503: completed loading model GAL
pins2lts-mc( 0/ 8), 0.554: Initializing POR dependencies: labels 401, guards 400
pins2lts-mc( 3/ 8), 0.550: completed loading model GAL
pins2lts-mc( 4/ 8), 0.640: completed loading model GAL
pins2lts-mc( 2/ 8), 0.681: completed loading model GAL
pins2lts-mc( 1/ 8), 0.683: completed loading model GAL
pins2lts-mc( 5/ 8), 0.726: completed loading model GAL
pins2lts-mc( 6/ 8), 0.765: completed loading model GAL
pins2lts-mc( 0/ 8), 2.374: There are 401 state labels and 1 edge labels
pins2lts-mc( 0/ 8), 2.374: State length is 118, there are 400 groups
pins2lts-mc( 0/ 8), 2.374: Running bfs using 8 cores
pins2lts-mc( 0/ 8), 2.374: Using a non-indexing tree table with 2^27 elements
pins2lts-mc( 0/ 8), 2.374: Successor permutation: none
pins2lts-mc( 0/ 8), 2.374: Visible groups: 0 / 400, labels: 0 / 401
pins2lts-mc( 0/ 8), 2.374: POR cycle proviso: none
pins2lts-mc( 0/ 8), 2.374: Global bits: 0, count bits: 0, local bits: 0
pins2lts-mc( 1/ 8), 202.552: ~1 levels ~960 states ~316864 transitions
pins2lts-mc( 1/ 8), 244.207: ~1 levels ~1920 states ~594408 transitions
pins2lts-mc( 2/ 8), 315.153: ~1 levels ~3840 states ~1104424 transitions
pins2lts-mc( 5/ 8), 392.913: ~1 levels ~7680 states ~2140040 transitions
pins2lts-mc( 5/ 8), 491.814: ~1 levels ~15360 states ~4263472 transitions
pins2lts-mc( 7/ 8), 571.831: ~1 levels ~30720 states ~8654776 transitions
pins2lts-mc( 7/ 8), 716.937: ~1 levels ~61440 states ~17302312 transitions
pins2lts-mc( 5/ 8), 1004.195: ~2 levels ~122880 states ~30054664 transitions
pins2lts-mc( 5/ 8), 1624.332: ~2 levels ~245760 states ~57930464 transitions
pins2lts-mc( 1/ 8), 1764.172: Error: tree leafs table full! Change -s/--ratio.
pins2lts-mc( 0/ 8), 1768.285:
pins2lts-mc( 0/ 8), 1768.285: mean standard work distribution: 3.1% (states) 1.9% (transitions)
pins2lts-mc( 0/ 8), 1768.285:
pins2lts-mc( 0/ 8), 1768.285: Explored 256330 states 62679746 transitions, fanout: 244.528
pins2lts-mc( 0/ 8), 1768.285: Total exploration time 1765.880 sec (1762.790 sec minimum, 1764.449 sec on average)
pins2lts-mc( 0/ 8), 1768.285: States per second: 145, Transitions per second: 35495
pins2lts-mc( 0/ 8), 1768.285:
pins2lts-mc( 0/ 8), 1768.285: Queue width: 8B, total height: 28485414, memory: 217.33MB
pins2lts-mc( 0/ 8), 1768.285: Tree memory: 475.3MB, 17.3 B/state, compr.: 3.7%
pins2lts-mc( 0/ 8), 1768.285: Tree fill ratio (roots/leafs): 21.0%/100.0%
pins2lts-mc( 0/ 8), 1768.285: Stored 402 string chucks using 0MB
pins2lts-mc( 0/ 8), 1768.285: Total memory used for chunk indexing: 0MB
pins2lts-mc( 0/ 8), 1768.285: Est. total memory use: 692.6MB (~1241.3MB 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)
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-20-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 55 ms
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-20-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 220 ms
Begin: Tue Mar 26 20:06:14 2019
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Decomposing Gal with order
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting arrays to variables to allow decomposition.
Mar 26, 2019 8:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 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:06:14 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property NQueens-PT-20-GlobalProperties-0 is trivially true : it is verified in initial state.
Mar 26, 2019 8:06:14 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 65 ms
Mar 26, 2019 8:06:14 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/GlobalProperties.pnml.gal : 15 ms
ITS-tools command line returned an error code 1

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-20"
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-20, 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-155272230100048"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/NQueens-PT-20.tgz
mv NQueens-PT-20 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 ;