Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2019-input.r190-smll-155225126500025.qcow2', fmt=qcow2 size=4294967296 backing_file='/data/fkordon/mcc2019-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
....................
=====================================================================
Generated by BenchKit 2-3957
Executing tool itstoolsm
Input is CSRepetitions-COL-04, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r190-smll-155225126500025
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 188K
-rw-r--r-- 1 mcc users 5.0K Feb 9 08:24 CTLCardinality.txt
-rw-r--r-- 1 mcc users 24K Feb 9 08:24 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.5K Feb 5 06:51 CTLFireability.txt
-rw-r--r-- 1 mcc users 22K Feb 5 06:51 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 10 17:31 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.0K Mar 10 17:31 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 107 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 345 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.6K Feb 4 23:04 LTLCardinality.txt
-rw-r--r-- 1 mcc users 10K Feb 4 23:04 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Feb 4 22:32 LTLFireability.txt
-rw-r--r-- 1 mcc users 9.9K Feb 4 22:32 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.7K Feb 2 01:39 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 15K Feb 2 01:39 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Jan 29 14:59 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 14K Jan 29 14:59 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Feb 4 22:18 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K Feb 4 22:18 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Jan 29 09:34 equiv_pt
-rw-r--r-- 1 mcc users 3 Jan 29 09:34 instance
-rw-r--r-- 1 mcc users 5 Jan 29 09:34 iscolored
-rw-r--r-- 1 mcc users 14K 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 CSRepetitions-COL-04-LTLFireability-00
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-01
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-02
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-03
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-04
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-05
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-06
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-07
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-08
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-09
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-10
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-11
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-12
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-13
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-14
FORMULA_NAME CSRepetitions-COL-04-LTLFireability-15

=== Now, execution of the tool begins

BK_START 1553550434724

21:47:17.636 [main] ERROR PNML validation - The rng grammar file can't be accessed : www.pnml.org
21:47:17.639 [main] ERROR import - Grammar file errors have been raised, the validation can't be done, process will continue without Grammar validation
Working with output stream class java.io.PrintStream
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock, --load-order, /home/mcc/execution/model.ord], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock --load-order /home/mcc/execution/model.ord
Read 16 LTL properties
Successfully loaded order from file /home/mcc/execution/model.ord
Checking formula 0 : !((G(F(X(("((((((((((((((((clientWaiting_0>=1)||(clientWaiting_1>=1))||(clientWaiting_2>=1))||(clientWaiting_3>=1))||(clientWaiting_4>=1))||(clientWaiting_5>=1))||(clientWaiting_6>=1))||(clientWaiting_7>=1))||(clientWaiting_8>=1))||(clientWaiting_9>=1))||(clientWaiting_10>=1))||(clientWaiting_11>=1))||(clientWaiting_12>=1))||(clientWaiting_13>=1))||(clientWaiting_14>=1))||(clientWaiting_15>=1))")U("(((((((((((((((((((((((((((((((((((((((((((((((((((((((((((((((((serverAnwering_0>=1)&&(clientSending_0>=1))||((serverAnwering_4>=1)&&(clientSending_1>=1)))||((serverAnwering_8>=1)&&(clientSending_2>=1)))||((serverAnwering_12>=1)&&(clientSending_3>=1)))||((serverAnwering_16>=1)&&(clientSending_4>=1)))||((serverAnwering_20>=1)&&(clientSending_5>=1)))||((serverAnwering_24>=1)&&(clientSending_6>=1)))||((serverAnwering_28>=1)&&(clientSending_7>=1)))||((serverAnwering_32>=1)&&(clientSending_8>=1)))||((serverAnwering_36>=1)&&(clientSending_9>=1)))||((serverAnwering_40>=1)&&(clientSending_10>=1)))||((serverAnwering_44>=1)&&(clientSending_11>=1)))||((serverAnwering_48>=1)&&(clientSending_12>=1)))||((serverAnwering_52>=1)&&(clientSending_13>=1)))||((serverAnwering_56>=1)&&(clientSending_14>=1)))||((serverAnwering_60>=1)&&(clientSending_15>=1)))||((serverAnwering_1>=1)&&(clientSending_0>=1)))||((serverAnwering_5>=1)&&(clientSending_1>=1)))||((serverAnwering_9>=1)&&(clientSending_2>=1)))||((serverAnwering_13>=1)&&(clientSending_3>=1)))||((serverAnwering_17>=1)&&(clientSending_4>=1)))||((serverAnwering_21>=1)&&(clientSending_5>=1)))||((serverAnwering_25>=1)&&(clientSending_6>=1)))||((serverAnwering_29>=1)&&(clientSending_7>=1)))||((serverAnwering_33>=1)&&(clientSending_8>=1)))||((serverAnwering_37>=1)&&(clientSending_9>=1)))||((serverAnwering_41>=1)&&(clientSending_10>=1)))||((serverAnwering_45>=1)&&(clientSending_11>=1)))||((serverAnwering_49>=1)&&(clientSending_12>=1)))||((serverAnwering_53>=1)&&(clientSending_13>=1)))||((serverAnwering_57>=1)&&(clientSending_14>=1)))||((serverAnwering_61>=1)&&(clientSending_15>=1)))||((serverAnwering_2>=1)&&(clientSending_0>=1)))||((serverAnwering_6>=1)&&(clientSending_1>=1)))||((serverAnwering_10>=1)&&(clientSending_2>=1)))||((serverAnwering_14>=1)&&(clientSending_3>=1)))||((serverAnwering_18>=1)&&(clientSending_4>=1)))||((serverAnwering_22>=1)&&(clientSending_5>=1)))||((serverAnwering_26>=1)&&(clientSending_6>=1)))||((serverAnwering_30>=1)&&(clientSending_7>=1)))||((serverAnwering_34>=1)&&(clientSending_8>=1)))||((serverAnwering_38>=1)&&(clientSending_9>=1)))||((serverAnwering_42>=1)&&(clientSending_10>=1)))||((serverAnwering_46>=1)&&(clientSending_11>=1)))||((serverAnwering_50>=1)&&(clientSending_12>=1)))||((serverAnwering_54>=1)&&(clientSending_13>=1)))||((serverAnwering_58>=1)&&(clientSending_14>=1)))||((serverAnwering_62>=1)&&(clientSending_15>=1)))||((serverAnwering_3>=1)&&(clientSending_0>=1)))||((serverAnwering_7>=1)&&(clientSending_1>=1)))||((serverAnwering_11>=1)&&(clientSending_2>=1)))||((serverAnwering_15>=1)&&(clientSending_3>=1)))||((serverAnwering_19>=1)&&(clientSending_4>=1)))||((serverAnwering_23>=1)&&(clientSending_5>=1)))||((serverAnwering_27>=1)&&(clientSending_6>=1)))||((serverAnwering_31>=1)&&(clientSending_7>=1)))||((serverAnwering_35>=1)&&(clientSending_8>=1)))||((serverAnwering_39>=1)&&(clientSending_9>=1)))||((serverAnwering_43>=1)&&(clientSending_10>=1)))||((serverAnwering_47>=1)&&(clientSending_11>=1)))||((serverAnwering_51>=1)&&(clientSending_12>=1)))||((serverAnwering_55>=1)&&(clientSending_13>=1)))||((serverAnwering_59>=1)&&(clientSending_14>=1)))||((serverAnwering_63>=1)&&(clientSending_15>=1)))"))))))
Formula 0 simplified : !GFX("((((((((((((((((clientWaiting_0>=1)||(clientWaiting_1>=1))||(clientWaiting_2>=1))||(clientWaiting_3>=1))||(clientWaiting_4>=1))||(clientWaiting_5>=1))||(clientWaiting_6>=1))||(clientWaiting_7>=1))||(clientWaiting_8>=1))||(clientWaiting_9>=1))||(clientWaiting_10>=1))||(clientWaiting_11>=1))||(clientWaiting_12>=1))||(clientWaiting_13>=1))||(clientWaiting_14>=1))||(clientWaiting_15>=1))" U "(((((((((((((((((((((((((((((((((((((((((((((((((((((((((((((((((serverAnwering_0>=1)&&(clientSending_0>=1))||((serverAnwering_4>=1)&&(clientSending_1>=1)))||((serverAnwering_8>=1)&&(clientSending_2>=1)))||((serverAnwering_12>=1)&&(clientSending_3>=1)))||((serverAnwering_16>=1)&&(clientSending_4>=1)))||((serverAnwering_20>=1)&&(clientSending_5>=1)))||((serverAnwering_24>=1)&&(clientSending_6>=1)))||((serverAnwering_28>=1)&&(clientSending_7>=1)))||((serverAnwering_32>=1)&&(clientSending_8>=1)))||((serverAnwering_36>=1)&&(clientSending_9>=1)))||((serverAnwering_40>=1)&&(clientSending_10>=1)))||((serverAnwering_44>=1)&&(clientSending_11>=1)))||((serverAnwering_48>=1)&&(clientSending_12>=1)))||((serverAnwering_52>=1)&&(clientSending_13>=1)))||((serverAnwering_56>=1)&&(clientSending_14>=1)))||((serverAnwering_60>=1)&&(clientSending_15>=1)))||((serverAnwering_1>=1)&&(clientSending_0>=1)))||((serverAnwering_5>=1)&&(clientSending_1>=1)))||((serverAnwering_9>=1)&&(clientSending_2>=1)))||((serverAnwering_13>=1)&&(clientSending_3>=1)))||((serverAnwering_17>=1)&&(clientSending_4>=1)))||((serverAnwering_21>=1)&&(clientSending_5>=1)))||((serverAnwering_25>=1)&&(clientSending_6>=1)))||((serverAnwering_29>=1)&&(clientSending_7>=1)))||((serverAnwering_33>=1)&&(clientSending_8>=1)))||((serverAnwering_37>=1)&&(clientSending_9>=1)))||((serverAnwering_41>=1)&&(clientSending_10>=1)))||((serverAnwering_45>=1)&&(clientSending_11>=1)))||((serverAnwering_49>=1)&&(clientSending_12>=1)))||((serverAnwering_53>=1)&&(clientSending_13>=1)))||((serverAnwering_57>=1)&&(clientSending_14>=1)))||((serverAnwering_61>=1)&&(clientSending_15>=1)))||((serverAnwering_2>=1)&&(clientSending_0>=1)))||((serverAnwering_6>=1)&&(clientSending_1>=1)))||((serverAnwering_10>=1)&&(clientSending_2>=1)))||((serverAnwering_14>=1)&&(clientSending_3>=1)))||((serverAnwering_18>=1)&&(clientSending_4>=1)))||((serverAnwering_22>=1)&&(clientSending_5>=1)))||((serverAnwering_26>=1)&&(clientSending_6>=1)))||((serverAnwering_30>=1)&&(clientSending_7>=1)))||((serverAnwering_34>=1)&&(clientSending_8>=1)))||((serverAnwering_38>=1)&&(clientSending_9>=1)))||((serverAnwering_42>=1)&&(clientSending_10>=1)))||((serverAnwering_46>=1)&&(clientSending_11>=1)))||((serverAnwering_50>=1)&&(clientSending_12>=1)))||((serverAnwering_54>=1)&&(clientSending_13>=1)))||((serverAnwering_58>=1)&&(clientSending_14>=1)))||((serverAnwering_62>=1)&&(clientSending_15>=1)))||((serverAnwering_3>=1)&&(clientSending_0>=1)))||((serverAnwering_7>=1)&&(clientSending_1>=1)))||((serverAnwering_11>=1)&&(clientSending_2>=1)))||((serverAnwering_15>=1)&&(clientSending_3>=1)))||((serverAnwering_19>=1)&&(clientSending_4>=1)))||((serverAnwering_23>=1)&&(clientSending_5>=1)))||((serverAnwering_27>=1)&&(clientSending_6>=1)))||((serverAnwering_31>=1)&&(clientSending_7>=1)))||((serverAnwering_35>=1)&&(clientSending_8>=1)))||((serverAnwering_39>=1)&&(clientSending_9>=1)))||((serverAnwering_43>=1)&&(clientSending_10>=1)))||((serverAnwering_47>=1)&&(clientSending_11>=1)))||((serverAnwering_51>=1)&&(clientSending_12>=1)))||((serverAnwering_55>=1)&&(clientSending_13>=1)))||((serverAnwering_59>=1)&&(clientSending_14>=1)))||((serverAnwering_63>=1)&&(clientSending_15>=1)))")
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
// Phase 1: matrix 176 rows 117 cols
invariant :clientSending_15 + clientWaiting_15 = 1
invariant :serverWaiting_0 + serverAnwering_0 + serverAnwering_4 + serverAnwering_8 + serverAnwering_12 + serverAnwering_16 + serverAnwering_20 + serverAnwering_24 + serverAnwering_28 + serverAnwering_32 + serverAnwering_36 + serverAnwering_40 + serverAnwering_44 + serverAnwering_48 + serverAnwering_52 + serverAnwering_56 + serverAnwering_60 = 1
invariant :serverWaiting_3 + serverAnwering_3 + serverAnwering_7 + serverAnwering_11 + serverAnwering_15 + serverAnwering_19 + serverAnwering_23 + serverAnwering_27 + serverAnwering_31 + serverAnwering_35 + serverAnwering_39 + serverAnwering_43 + serverAnwering_47 + serverAnwering_51 + serverAnwering_55 + serverAnwering_59 + serverAnwering_63 = 1
invariant :clientSending_9 + clientWaiting_9 = 1
invariant :clientSending_5 + clientWaiting_5 = 1
invariant :clientSending_7 + clientWaiting_7 = 1
invariant :clientSending_8 + clientWaiting_8 = 1
invariant :clientSending_11 + clientWaiting_11 = 1
invariant :clientSending_2 + clientWaiting_2 = 1
invariant :clientSending_1 + clientWaiting_1 = 1
invariant :clientSending_6 + clientWaiting_6 = 1
invariant :clientSending_13 + clientWaiting_13 = 1
invariant :clientSending_4 + clientWaiting_4 = 1
invariant :serverWaiting_2 + serverAnwering_2 + serverAnwering_6 + serverAnwering_10 + serverAnwering_14 + serverAnwering_18 + serverAnwering_22 + serverAnwering_26 + serverAnwering_30 + serverAnwering_34 + serverAnwering_38 + serverAnwering_42 + serverAnwering_46 + serverAnwering_50 + serverAnwering_54 + serverAnwering_58 + serverAnwering_62 = 1
invariant :clientSending_12 + clientWaiting_12 = 1
invariant :clientSending_10 + clientWaiting_10 = 1
invariant :clientSending_14 + clientWaiting_14 = 1
invariant :serverWaiting_1 + serverAnwering_1 + serverAnwering_5 + serverAnwering_9 + serverAnwering_13 + serverAnwering_17 + serverAnwering_21 + serverAnwering_25 + serverAnwering_29 + serverAnwering_33 + serverAnwering_37 + serverAnwering_41 + serverAnwering_45 + serverAnwering_49 + serverAnwering_53 + serverAnwering_57 + serverAnwering_61 = 1
invariant :clientSending_0 + clientWaiting_0 = 1
invariant :clientSending_3 + clientWaiting_3 = 1
Reverse transition relation is NOT exact ! Due to transitions t80, t81, t82, t83, t84, t85, t86, t87, t88, t89, t90, t91, t92, t93, t94, t95, t96, t97, t98, t99, t100, t101, t102, t103, t104, t105, t106, t107, t108, t109, t110, t111, t112, t113, t114, t115, t116, t117, t118, t119, t120, t121, t122, t123, t124, t125, t126, t127, t128, t129, t130, t131, t132, t133, t134, t135, t136, t137, t138, t139, t140, t141, t142, t143, t144, t145, t146, t147, t148, t149, t150, t151, t152, t153, t154, t155, t156, t157, t158, t159, t160, t161, t162, t163, t164, t165, t166, t167, t168, t169, t170, t171, t172, t173, t174, t175, Intersection with reachable at each step enabled. (destroyed/reverse/intersect/total) :0/80/96/176
Computing Next relation with stutter on 1 deadlock states
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 2854 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 55 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, [](<>(X(((LTLAP0==true))U((LTLAP1==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 506 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-00 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, <>((LTLAP2==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 283 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-01 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ([]([]([]((LTLAP2==true)))))U(<>(X([]((LTLAP2==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 53 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-02 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, (<>((LTLAP1==true)))U((X((LTLAP0==true)))U((LTLAP0==true))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 540 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-03 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, [](<>(<>(<>([]((LTLAP1==true)))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 326 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-04 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(<>(X(<>(X((LTLAP0==true)))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 501 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-05 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, <>(<>((<>((LTLAP3==true)))U([]((LTLAP4==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 309 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-06 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, (((LTLAP0==true))U([]((LTLAP1==true))))U(((LTLAP0==true))U(<>((LTLAP2==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 149 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-07 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ([](((LTLAP0==true))U((LTLAP3==true))))U([](X([]((LTLAP2==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 257 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-08 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, ((LTLAP4==true))U(X(<>([]((LTLAP0==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 244 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-09 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X((LTLAP1==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 571 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-10 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(X(X([]((LTLAP0==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
WARNING : LTSmin timed out (>225 s) on command CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(X(X([]((LTLAP0==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, ((LTLAP4==true))U((LTLAP0==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 161 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-12 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(X(X(<>(<>((LTLAP1==true)))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 146 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-13 FALSE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X((LTLAP0==true)), --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 307 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-14 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, -p, --pins-guards, --when, --ltl, true, --buchi-type=spotba], workingDir=/home/mcc/execution]
LTSmin run took 239 ms.
FORMULA CSRepetitions-COL-04-LTLFireability-15 TRUE TECHNIQUES PARTIAL_ORDER EXPLICIT LTSMIN SAT_SMT
Retrying LTSmin with larger timeout 1800 s
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, X(X(X([]((LTLAP0==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
3 unique states visited
3 strongly connected components in search stack
4 transitions explored
3 items max in DFS search stack
21456 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,214.609,2295568,1,0,482,1.24676e+07,17,205,2134,1.01912e+07,97
an accepting run exists (use option '-e' to print it)
Formula 0 is FALSE accepting run found.
FORMULA CSRepetitions-COL-04-LTLFireability-00 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 1 : !((F("((((((((((((((((requestBuffer_0>=1)||(requestBuffer_1>=1))||(requestBuffer_2>=1))||(requestBuffer_3>=1))||(requestBuffer_4>=1))||(requestBuffer_5>=1))||(requestBuffer_6>=1))||(requestBuffer_7>=1))||(requestBuffer_8>=1))||(requestBuffer_9>=1))||(requestBuffer_10>=1))||(requestBuffer_11>=1))||(requestBuffer_12>=1))||(requestBuffer_13>=1))||(requestBuffer_14>=1))||(requestBuffer_15>=1))")))
Formula 1 simplified : !F"((((((((((((((((requestBuffer_0>=1)||(requestBuffer_1>=1))||(requestBuffer_2>=1))||(requestBuffer_3>=1))||(requestBuffer_4>=1))||(requestBuffer_5>=1))||(requestBuffer_6>=1))||(requestBuffer_7>=1))||(requestBuffer_8>=1))||(requestBuffer_9>=1))||(requestBuffer_10>=1))||(requestBuffer_11>=1))||(requestBuffer_12>=1))||(requestBuffer_13>=1))||(requestBuffer_14>=1))||(requestBuffer_15>=1))"
Computing Next relation with stutter on 1 deadlock states
1 unique states visited
0 strongly connected components in search stack
0 transitions explored
1 items max in DFS search stack
670 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,221.338,2295568,1,0,482,1.24676e+07,27,205,2674,1.01912e+07,272
no accepting run found
Formula 1 is TRUE no accepting run found.
FORMULA CSRepetitions-COL-04-LTLFireability-01 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL USE_NUPN
Checking formula 2 : !(((G(G(G("((((((((((((((((requestBuffer_0>=1)||(requestBuffer_1>=1))||(requestBuffer_2>=1))||(requestBuffer_3>=1))||(requestBuffer_4>=1))||(requestBuffer_5>=1))||(requestBuffer_6>=1))||(requestBuffer_7>=1))||(requestBuffer_8>=1))||(requestBuffer_9>=1))||(requestBuffer_10>=1))||(requestBuffer_11>=1))||(requestBuffer_12>=1))||(requestBuffer_13>=1))||(requestBuffer_14>=1))||(requestBuffer_15>=1))"))))U(F(X(G("((((((((((((((((requestBuffer_0>=1)||(requestBuffer_1>=1))||(requestBuffer_2>=1))||(requestBuffer_3>=1))||(requestBuffer_4>=1))||(requestBuffer_5>=1))||(requestBuffer_6>=1))||(requestBuffer_7>=1))||(requestBuffer_8>=1))||(requestBuffer_9>=1))||(requestBuffer_10>=1))||(requestBuffer_11>=1))||(requestBuffer_12>=1))||(requestBuffer_13>=1))||(requestBuffer_14>=1))||(requestBuffer_15>=1))"))))))
Formula 2 simplified : !(G"((((((((((((((((requestBuffer_0>=1)||(requestBuffer_1>=1))||(requestBuffer_2>=1))||(requestBuffer_3>=1))||(requestBuffer_4>=1))||(requestBuffer_5>=1))||(requestBuffer_6>=1))||(requestBuffer_7>=1))||(requestBuffer_8>=1))||(requestBuffer_9>=1))||(requestBuffer_10>=1))||(requestBuffer_11>=1))||(requestBuffer_12>=1))||(requestBuffer_13>=1))||(requestBuffer_14>=1))||(requestBuffer_15>=1))" U FXG"((((((((((((((((requestBuffer_0>=1)||(requestBuffer_1>=1))||(requestBuffer_2>=1))||(requestBuffer_3>=1))||(requestBuffer_4>=1))||(requestBuffer_5>=1))||(requestBuffer_6>=1))||(requestBuffer_7>=1))||(requestBuffer_8>=1))||(requestBuffer_9>=1))||(requestBuffer_10>=1))||(requestBuffer_11>=1))||(requestBuffer_12>=1))||(requestBuffer_13>=1))||(requestBuffer_14>=1))||(requestBuffer_15>=1))")
Computing Next relation with stutter on 1 deadlock states
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, --when, --ltl, X(X(X([]((LTLAP0==true))))), --buchi-type=spotba], workingDir=/home/mcc/execution]
255
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-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 1 LTL properties
Checking formula 0 : !((X(X(X(G("((((((((((((((((Client0.clientWaiting_0>=1)||(Client1.clientWaiting_1>=1))||(Client2.clientWaiting_2>=1))||(Client3.clientWaiting_3>=1))||(Client4.clientWaiting_4>=1))||(Client5.clientWaiting_5>=1))||(Client6.clientWaiting_6>=1))||(Client7.clientWaiting_7>=1))||(Client8.clientWaiting_8>=1))||(Client9.clientWaiting_9>=1))||(Client10.clientWaiting_10>=1))||(Client11.clientWaiting_11>=1))||(Client12.clientWaiting_12>=1))||(Client13.clientWaiting_13>=1))||(Client14.clientWaiting_14>=1))||(Client15.clientWaiting_15>=1))"))))))
Formula 0 simplified : !XXXG"((((((((((((((((Client0.clientWaiting_0>=1)||(Client1.clientWaiting_1>=1))||(Client2.clientWaiting_2>=1))||(Client3.clientWaiting_3>=1))||(Client4.clientWaiting_4>=1))||(Client5.clientWaiting_5>=1))||(Client6.clientWaiting_6>=1))||(Client7.clientWaiting_7>=1))||(Client8.clientWaiting_8>=1))||(Client9.clientWaiting_9>=1))||(Client10.clientWaiting_10>=1))||(Client11.clientWaiting_11>=1))||(Client12.clientWaiting_12>=1))||(Client13.clientWaiting_13>=1))||(Client14.clientWaiting_14>=1))||(Client15.clientWaiting_15>=1))"
built 161 ordering constraints for composite.
Reverse transition relation is NOT exact ! Due to transitions sendAnswer_0, sendAnswer_1, sendAnswer_2, sendAnswer_3, sendAnswer_4, sendAnswer_5, sendAnswer_6, sendAnswer_7, sendAnswer_8, sendAnswer_9, sendAnswer_10, sendAnswer_11, sendAnswer_12, sendAnswer_13, sendAnswer_14, sendAnswer_15, Client0.prepareRequest_0, Client0.loseRequest_0, Client1.prepareRequest_1, Client1.loseRequest_1, Client2.prepareRequest_2, Client2.loseRequest_2, Client3.prepareRequest_3, Client3.loseRequest_3, Client4.prepareRequest_4, Client4.loseRequest_4, Client5.prepareRequest_5, Client5.loseRequest_5, Client6.prepareRequest_6, Client6.loseRequest_6, Client7.prepareRequest_7, Client7.loseRequest_7, Client8.prepareRequest_8, Client8.loseRequest_8, Client9.prepareRequest_9, Client9.loseRequest_9, Client10.prepareRequest_10, Client10.loseRequest_10, Client11.prepareRequest_11, Client11.loseRequest_11, Client12.prepareRequest_12, Client12.loseRequest_12, Client13.prepareRequest_13, Client13.loseRequest_13, Client14.prepareRequest_14, Client14.loseRequest_14, Client15.prepareRequest_15, Client15.loseRequest_15, Intersection with reachable at each step enabled. (destroyed/reverse/intersect/total) :0/2/48/50
Computing Next relation with stutter on 1 deadlock states
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-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.201903251645/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 1 LTL properties
Checking formula 0 : !((X(X(X(G("((((((((((((((((Client0.clientWaiting_0>=1)||(Client1.clientWaiting_1>=1))||(Client2.clientWaiting_2>=1))||(Client3.clientWaiting_3>=1))||(Client4.clientWaiting_4>=1))||(Client5.clientWaiting_5>=1))||(Client6.clientWaiting_6>=1))||(Client7.clientWaiting_7>=1))||(Client8.clientWaiting_8>=1))||(Client9.clientWaiting_9>=1))||(Client10.clientWaiting_10>=1))||(Client11.clientWaiting_11>=1))||(Client12.clientWaiting_12>=1))||(Client13.clientWaiting_13>=1))||(Client14.clientWaiting_14>=1))||(Client15.clientWaiting_15>=1))"))))))
Formula 0 simplified : !XXXG"((((((((((((((((Client0.clientWaiting_0>=1)||(Client1.clientWaiting_1>=1))||(Client2.clientWaiting_2>=1))||(Client3.clientWaiting_3>=1))||(Client4.clientWaiting_4>=1))||(Client5.clientWaiting_5>=1))||(Client6.clientWaiting_6>=1))||(Client7.clientWaiting_7>=1))||(Client8.clientWaiting_8>=1))||(Client9.clientWaiting_9>=1))||(Client10.clientWaiting_10>=1))||(Client11.clientWaiting_11>=1))||(Client12.clientWaiting_12>=1))||(Client13.clientWaiting_13>=1))||(Client14.clientWaiting_14>=1))||(Client15.clientWaiting_15>=1))"
built 161 ordering constraints for composite.
Reverse transition relation is NOT exact ! Due to transitions sendAnswer_0, sendAnswer_1, sendAnswer_2, sendAnswer_3, sendAnswer_4, sendAnswer_5, sendAnswer_6, sendAnswer_7, sendAnswer_8, sendAnswer_9, sendAnswer_10, sendAnswer_11, sendAnswer_12, sendAnswer_13, sendAnswer_14, sendAnswer_15, Client0.prepareRequest_0, Client0.loseRequest_0, Client1.prepareRequest_1, Client1.loseRequest_1, Client2.prepareRequest_2, Client2.loseRequest_2, Client3.prepareRequest_3, Client3.loseRequest_3, Client4.prepareRequest_4, Client4.loseRequest_4, Client5.prepareRequest_5, Client5.loseRequest_5, Client6.prepareRequest_6, Client6.loseRequest_6, Client7.prepareRequest_7, Client7.loseRequest_7, Client8.prepareRequest_8, Client8.loseRequest_8, Client9.prepareRequest_9, Client9.loseRequest_9, Client10.prepareRequest_10, Client10.loseRequest_10, Client11.prepareRequest_11, Client11.loseRequest_11, Client12.prepareRequest_12, Client12.loseRequest_12, Client13.prepareRequest_13, Client13.loseRequest_13, Client14.prepareRequest_14, Client14.loseRequest_14, Client15.prepareRequest_15, Client15.loseRequest_15, Intersection with reachable at each step enabled. (destroyed/reverse/intersect/total) :0/2/48/50
Computing Next relation with stutter on 1 deadlock states

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
+ [[ LTLFireability = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLFireability -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ /home/mcc/BenchKit//itstools/its-tools -data /home/mcc/execution/workspace -pnfolder /home/mcc/execution -examination LTLFireability -z3path /home/mcc/BenchKit//z3/bin/z3 -yices2path /home/mcc/BenchKit//yices/bin/yices -its -ltsminpath /home/mcc/BenchKit//lts_install_dir/ -greatspnpath /home/mcc/BenchKit//greatspn/ -order META -manyOrder -smt -vmargs -Dosgi.locking=none -Declipse.stateSaveDelayInterval=-1 -Dosgi.configuration.area=/tmp/.eclipse -Xss8m -Xms40m -Xmx8192m -Dfile.encoding=UTF-8 -Dosgi.requiredJavaVersion=1.6
Mar 25, 2019 9:47:17 PM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -greatspnpath, /home/mcc/BenchKit//greatspn/, -order, META, -manyOrder, -smt]
Mar 25, 2019 9:47:17 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 25, 2019 9:47:17 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Load time of PNML (colored model parsed with PNMLFW) : 915 ms
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Transformed 6 places.
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Computed order using colors.
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: sort/places :Server->serverWaiting,
Computation->serverAnwering,
Dot->requestBufferSlots,
Client->clientSending,requestBuffer,clientWaiting,

Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Transformed 5 transitions.
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Computed order based on color domains.
Mar 25, 2019 9:47:18 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 5 ms
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 69 ms
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 46 ms
Mar 25, 2019 9:47:18 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was not deterministic with 50 transitions. Expanding to a total of 210 deterministic transitions.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Determinization took 14 ms.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 117 places.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 176 transitions.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was not deterministic with 50 transitions. Expanding to a total of 210 deterministic transitions.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Determinization took 2 ms.
Mar 25, 2019 9:47:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 3 ms
Mar 25, 2019 9:47:19 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 9 ms
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 20 place invariants in 52 ms
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 117 variables to be positive in 436 ms
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 176 transitions.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/176 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 17 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 176 transitions.
Mar 25, 2019 9:47:19 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 11 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 25, 2019 9:47:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 176 transitions.
Mar 25, 2019 9:47:27 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(0/176) took 49 ms. Total solver calls (SAT/UNSAT): 20(19/1)
Mar 25, 2019 9:47:30 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of co-enabling matrix(84/176) took 3049 ms. Total solver calls (SAT/UNSAT): 1884(824/1060)
Mar 25, 2019 9:47:32 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 4897 ms. Total solver calls (SAT/UNSAT): 2504(920/1584)
Mar 25, 2019 9:47:32 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 176 transitions.
Mar 25, 2019 9:48:11 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 39706 ms. Total solver calls (SAT/UNSAT): 2480(0/2480)
Mar 25, 2019 9:48:11 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 52915ms conformant to PINS in folder :/home/mcc/execution
pins2lts-mc, 0.000: Registering PINS so language module
pins2lts-mc( 2/ 8), 0.000: library has no initializer
pins2lts-mc( 2/ 8), 0.000: loading model GAL
pins2lts-mc( 2/ 8), 0.002: completed loading model GAL
pins2lts-mc( 2/ 8), 0.002: LTL layer: formula: X(X(X([]((LTLAP0==true)))))
pins2lts-mc( 2/ 8), 0.002: "X(X(X([]((LTLAP0==true)))))" is not a file, parsing as formula...
pins2lts-mc( 2/ 8), 0.002: Using Spin LTL semantics
pins2lts-mc( 0/ 8), 0.006: Loading model from ./gal.so
pins2lts-mc( 1/ 8), 0.006: library has no initializer
pins2lts-mc( 0/ 8), 0.006: library has no initializer
pins2lts-mc( 1/ 8), 0.006: loading model GAL
pins2lts-mc( 0/ 8), 0.006: loading model GAL
pins2lts-mc( 1/ 8), 0.007: completed loading model GAL
pins2lts-mc( 5/ 8), 0.007: library has no initializer
pins2lts-mc( 5/ 8), 0.007: loading model GAL
pins2lts-mc( 0/ 8), 0.007: completed loading model GAL
pins2lts-mc( 3/ 8), 0.007: library has no initializer
pins2lts-mc( 3/ 8), 0.007: loading model GAL
pins2lts-mc( 5/ 8), 0.008: completed loading model GAL
pins2lts-mc( 7/ 8), 0.007: library has no initializer
pins2lts-mc( 7/ 8), 0.007: loading model GAL
pins2lts-mc( 4/ 8), 0.008: library has no initializer
pins2lts-mc( 4/ 8), 0.008: loading model GAL
pins2lts-mc( 6/ 8), 0.008: library has no initializer
pins2lts-mc( 4/ 8), 0.008: completed loading model GAL
pins2lts-mc( 3/ 8), 0.009: completed loading model GAL
pins2lts-mc( 6/ 8), 0.008: loading model GAL
pins2lts-mc( 7/ 8), 0.008: completed loading model GAL
pins2lts-mc( 6/ 8), 0.009: completed loading model GAL
pins2lts-mc( 0/ 8), 0.016: Weak Buchi automaton detected, adding non-accepting as progress label.
pins2lts-mc( 0/ 8), 0.183: DFS-FIFO for weak LTL, using special progress label 182
pins2lts-mc( 0/ 8), 0.183: There are 183 state labels and 1 edge labels
pins2lts-mc( 0/ 8), 0.183: State length is 118, there are 182 groups
pins2lts-mc( 0/ 8), 0.183: Running dfsfifo using 8 cores
pins2lts-mc( 0/ 8), 0.183: Using a tree table with 2^27 elements
pins2lts-mc( 0/ 8), 0.183: Successor permutation: rr
pins2lts-mc( 0/ 8), 0.183: Global bits: 2, count bits: 0, local bits: 0
pins2lts-mc( 5/ 8), 0.321: ~1 levels ~960 states ~16232 transitions
pins2lts-mc( 5/ 8), 0.439: ~1 levels ~1920 states ~33184 transitions
pins2lts-mc( 5/ 8), 0.586: ~1 levels ~3840 states ~68400 transitions
pins2lts-mc( 4/ 8), 0.868: ~1 levels ~7680 states ~141744 transitions
pins2lts-mc( 5/ 8), 1.280: ~1 levels ~15360 states ~280504 transitions
pins2lts-mc( 5/ 8), 2.012: ~1 levels ~30720 states ~580544 transitions
pins2lts-mc( 3/ 8), 3.290: ~1 levels ~61440 states ~1184784 transitions
pins2lts-mc( 5/ 8), 5.161: ~1 levels ~122880 states ~2414440 transitions
pins2lts-mc( 5/ 8), 8.049: ~1 levels ~245760 states ~4919184 transitions
pins2lts-mc( 5/ 8), 13.864: ~1 levels ~491520 states ~9997352 transitions
pins2lts-mc( 5/ 8), 25.960: ~1 levels ~983040 states ~20277616 transitions
pins2lts-mc( 5/ 8), 49.871: ~1 levels ~1966080 states ~41354816 transitions
pins2lts-mc( 5/ 8), 99.650: ~1 levels ~3932160 states ~83271504 transitions
pins2lts-mc( 2/ 8), 204.749: ~1 levels ~7864320 states ~171243040 transitions
pins2lts-mc( 0/ 8), 402.044: Error: tree leafs table full! Change -s/--ratio.
pins2lts-mc( 0/ 8), 402.228:
pins2lts-mc( 0/ 8), 402.228: mean standard work distribution: 1.9% (states) 0.9% (transitions)
pins2lts-mc( 0/ 8), 402.228:
pins2lts-mc( 0/ 8), 402.228: Explored 14674151 states 323566901 transitions, fanout: 22.050
pins2lts-mc( 0/ 8), 402.228: Total exploration time 402.020 sec (401.850 sec minimum, 401.941 sec on average)
pins2lts-mc( 0/ 8), 402.228: States per second: 36501, Transitions per second: 804853
pins2lts-mc( 0/ 8), 402.228:
pins2lts-mc( 0/ 8), 402.228: Progress states detected: 58063731
pins2lts-mc( 0/ 8), 402.228: Redundant explorations: -74.7276
pins2lts-mc( 0/ 8), 402.228:
pins2lts-mc( 0/ 8), 402.228: Queue width: 8B, total height: 66928163, memory: 510.62MB
pins2lts-mc( 0/ 8), 402.228: Tree memory: 699.0MB, 12.6 B/state, compr.: 2.7%
pins2lts-mc( 0/ 8), 402.228: Tree fill ratio (roots/leafs): 43.0%/99.0%
pins2lts-mc( 0/ 8), 402.228: Stored 176 string chucks using 0MB
pins2lts-mc( 0/ 8), 402.228: Total memory used for chunk indexing: 0MB
pins2lts-mc( 0/ 8), 402.228: Est. total memory use: 1209.6MB (~1534.6MB 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, --when, --ltl, X(X(X([]((LTLAP0==true))))), --buchi-type=spotba], 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:98)
at java.lang.Thread.run(Thread.java:748)
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 48 ms
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 21 ms
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Decomposing Gal with order
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting arrays to variables to allow decomposition.
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.Instantiator fuseIsomorphicEffects
INFO: Removed a total of 120 redundant transitions.
Mar 25, 2019 10:07:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 92 ms
Mar 25, 2019 10:07:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 5 ms
Mar 25, 2019 10:07:19 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 0 ms
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 18 ms
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 18 ms
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Decomposing Gal with order
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting arrays to variables to allow decomposition.
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,sendAnswers_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,readRequests_1_0,
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,sendAnswers_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,readRequests_3_0,
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,sendAnswers_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,readRequests_0_0,
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.Instantiator dropEvents
INFO: Dropping 30 events :sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,sendAnswers_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,readRequests_2_0,
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.Instantiator fuseIsomorphicEffects
INFO: Removed a total of 120 redundant transitions.
Mar 25, 2019 10:27:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 58 ms
Mar 25, 2019 10:27:20 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 3 ms
Mar 25, 2019 10:27:20 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 0 ms

Sequence of Actions to be Executed by the VM

This is useful if one wants to reexecute the tool in the VM from the submitted image disk.

set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="CSRepetitions-COL-04"
export BK_EXAMINATION="LTLFireability"
export BK_TOOL="itstoolsm"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3957"
echo " Executing tool itstoolsm"
echo " Input is CSRepetitions-COL-04, examination is LTLFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r190-smll-155225126500025"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/CSRepetitions-COL-04.tgz
mv CSRepetitions-COL-04 execution
cd execution
if [ "LTLFireability" = "GlobalProperties" ] ; then
rm -f GenericPropertiesVerdict.xml
fi
if [ "LTLFireability" = "UpperBounds" ] ; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "LTLFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "LTLFireability" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "LTLFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property LTLFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "LTLFireability.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '' LTLFireability.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
fi
echo
echo "=== Now, execution of the tool begins"
echo
echo -n "BK_START "
date -u +%s%3N
echo
timeout -s 9 $BK_TIME_CONFINEMENT bash -c "/home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n \"BK_STOP \" ; date -u +%s%3N"
if [ $? -eq 137 ] ; then
echo
echo "BK_TIME_CONFINEMENT_REACHED"
fi
echo
echo "--------------------"
echo "content from stderr:"
echo
cat STDERR ;