fond
Model Checking Contest 2019
9th edition, Prague, Czech Republic, April 7, 2019 (TOOLympics)
Execution of r190-smll-155225126700186
Last Updated
Apr 15, 2019

About the Execution of ITS-Tools.M for CircularTrains-PT-048

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
4692.630 3600000.00 3983400.00 11526.80 TFFTFFTTFF?????? normal

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-155225126700186.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 CircularTrains-PT-048, examination is LTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r190-smll-155225126700186
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 200K
-rw-r--r-- 1 mcc users 3.5K Feb 9 08:34 CTLCardinality.txt
-rw-r--r-- 1 mcc users 19K Feb 9 08:34 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Feb 5 07:18 CTLFireability.txt
-rw-r--r-- 1 mcc users 19K Feb 5 07:18 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 108 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 346 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.5K Feb 4 23:06 LTLCardinality.txt
-rw-r--r-- 1 mcc users 11K Feb 4 23:06 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.0K Feb 4 22:32 LTLFireability.txt
-rw-r--r-- 1 mcc users 8.6K Feb 4 22:32 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.0K Feb 2 01:44 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 14K Feb 2 01:44 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Jan 29 15:23 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 16K Jan 29 15:23 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Feb 4 22:18 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Feb 4 22:18 UpperBounds.xml

-rw-r--r-- 1 mcc users 6 Jan 29 09:34 equiv_col
-rw-r--r-- 1 mcc users 4 Jan 29 09:34 instance
-rw-r--r-- 1 mcc users 6 Jan 29 09:34 iscolored
-rw-r--r-- 1 mcc users 37K 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 CircularTrains-PT-048-LTLCardinality-00
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-01
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-02
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-03
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-04
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-05
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-06
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-07
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-08
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-09
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-10
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-11
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-12
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-13
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-14
FORMULA_NAME CircularTrains-PT-048-LTLCardinality-15

=== Now, execution of the tool begins

BK_START 1553633881595

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]
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
// Phase 1: matrix 48 rows 96 cols
invariant :F6 + -1'Section_5 + Section_7 + -1'F5 = -1
invariant :Section_48 + F47 + Section_47 = 2
invariant :Section_21 + Section_20 + F20 = 2
invariant :F44 + Section_45 + Section_44 = 2
invariant :Section_39 + F39 + Section_40 = 1
invariant :F48 + -1'F47 + -1'Section_47 + Section_1 = -1
invariant :Section_41 + F40 + Section_40 = 1
invariant :Section_18 + Section_17 + F17 = 2
invariant :Section_32 + F31 + Section_31 = 1
invariant :Section_25 + Section_24 + F24 = 1
invariant :Section_14 + F13 + Section_13 = 1
invariant :F12 + Section_10 + F10 + -1'F11 + Section_13 = 0
invariant :Section_38 + -1'F39 + -1'Section_40 + F38 = 1
invariant :Section_23 + F22 + Section_22 = 1
invariant :F33 + -1'F34 + Section_33 + -1'Section_35 = 0
invariant :Section_28 + -1'Section_26 + F27 + -1'F26 = -1
invariant :Section_9 + F8 + Section_8 = 2
invariant :F19 + Section_19 + Section_20 = 1
invariant :Section_27 + Section_26 + F26 = 2
invariant :F3 + Section_3 + -1'Section_5 + -1'F4 = 0
invariant :F30 + -1'F29 + Section_31 + -1'Section_29 = -1
invariant :F21 + -1'Section_20 + Section_22 + -1'F20 = -1
invariant :F23 + Section_24 + -1'F22 + -1'Section_22 = 1
invariant :Section_34 + F34 + Section_35 = 1
invariant :F18 + -1'Section_17 + Section_19 + -1'F17 = -1
invariant :Section_2 + F1 + Section_1 = 1
invariant :F45 + Section_45 + Section_46 = 1
invariant :F16 + -1'Section_15 + Section_17 + -1'F15 = 0
invariant :Section_6 + Section_5 + F5 = 2
invariant :F42 + F34 + F40 + -1'Section_33 + F29 + F1 + -1'Section_45 + F15 + -1'Section_3 + -1'Section_26 + -1'Section_10 + F47 + F8 + F31 + F24 + F27 + Section_5 + F13 + -1'Section_19 + F36 + -1'Section_44 + F22 + -1'Section_7 + F5 + F11 + F4 + F20 + F17 + F38 + -1'Section_46 = 12
invariant :F37 + F39 + Section_40 + -1'F36 + Section_35 + -1'F38 + F35 = 1
invariant :Section_11 + Section_10 + F10 = 1
invariant :Section_36 + Section_35 + F35 = 2
invariant :F2 + -1'F1 + Section_3 + -1'Section_1 = 1
invariant :Section_42 + -1'F40 + -1'Section_40 + F41 = 1
invariant :Section_16 + Section_15 + F15 = 1
invariant :F25 + -1'Section_24 + Section_26 + -1'F24 = 0
invariant :Section_37 + F36 + -1'Section_35 + -1'F35 = -1
invariant :F43 + F34 + -1'Section_33 + F29 + F1 + -1'Section_45 + F15 + -1'Section_3 + -1'Section_26 + -1'Section_10 + F47 + F8 + F31 + F24 + F27 + Section_5 + F13 + -1'Section_19 + -1'Section_40 + F36 + F22 + -1'Section_7 + F5 + F11 + F4 + F41 + F20 + F17 + F38 + -1'Section_46 = 13
invariant :Section_4 + Section_5 + F4 = 1
invariant :Section_30 + F29 + Section_29 = 2
invariant :F32 + Section_33 + -1'F31 + -1'Section_31 = 1
invariant :F28 + Section_26 + -1'F27 + F26 + Section_29 = 2
invariant :F14 + Section_15 + -1'F13 + -1'Section_13 = 1
invariant :Section_43 + -1'F34 + Section_33 + -1'F29 + -1'F1 + Section_45 + -1'F15 + Section_3 + Section_26 + Section_10 + -1'F47 + -1'F8 + -1'F31 + -1'F24 + -1'F27 + -1'Section_5 + -1'F13 + Section_19 + Section_40 + -1'F36 + Section_44 + -1'F22 + Section_7 + -1'F5 + -1'F11 + -1'F4 + -1'F41 + -1'F20 + -1'F17 + -1'F38 + Section_46 = -12
invariant :F9 + Section_10 + -1'F8 + -1'Section_8 = -1
invariant :F7 + Section_8 + Section_7 = 1
invariant :Section_12 + -1'Section_10 + -1'F10 + F11 = 1
invariant :F46 + Section_47 + Section_46 = 1
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 1391 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 51 ms.
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 266 ms.
FORMULA CircularTrains-PT-048-LTLCardinality-00 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([](<>((LTLAP1==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
P-invariant computation with GreatSPN timed out. Skipping.
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/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.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/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.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 : !((X(X(X(F("(Section_39<=F41)"))))))
Formula 0 simplified : !XXXF"(Section_39<=F41)"
Reverse transition relation is exact ! Faster fixpoint algorithm enabled.
4 unique states visited
0 strongly connected components in search stack
3 transitions explored
4 items max in DFS search stack
109 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.11102,43400,1,0,8,190730,20,0,2098,46059,15
no accepting run found
Formula 0 is TRUE no accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-00 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 1 : !((X(G(F("(F17<=F21)")))))
Formula 1 simplified : !XGF"(F17<=F21)"
4 unique states visited
4 strongly connected components in search stack
5 transitions explored
4 items max in DFS search stack
42 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,1.54305,52488,1,0,10,237694,33,0,2197,75164,34
an accepting run exists (use option '-e' to print it)
Formula 1 is FALSE accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-01 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 2 : !(((F("(Section_43<=Section_46)"))U(X("(Section_6>=3)"))))
Formula 2 simplified : !(F"(Section_43<=Section_46)" U X"(Section_6>=3)")
4 unique states visited
2 strongly connected components in search stack
4 transitions explored
4 items max in DFS search stack
3729 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,38.8367,816544,1,0,894,4.87995e+06,47,208,2205,5.32674e+06,2656
an accepting run exists (use option '-e' to print it)
Formula 2 is FALSE accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-02 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 3 : !((F("(Section_41<=Section_45)")))
Formula 3 simplified : !F"(Section_41<=Section_45)"
1 unique states visited
0 strongly connected components in search stack
0 transitions explored
1 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,38.8377,816808,1,0,894,4.87995e+06,56,208,2208,5.32675e+06,2660
no accepting run found
Formula 3 is TRUE no accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-03 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 4 : !((X("(F47<=F35)")))
Formula 4 simplified : !X"(F47<=F35)"
4 unique states visited
4 strongly connected components in search stack
4 transitions explored
4 items max in DFS search stack
23 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,39.0581,821292,1,0,896,4.90541e+06,61,208,2213,5.3557e+06,2669
an accepting run exists (use option '-e' to print it)
Formula 4 is FALSE accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-04 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 5 : !((false))
Formula 5 simplified : 1
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,39.0587,821292,1,0,896,4.90543e+06,61,208,2213,5.35572e+06,2671
an accepting run exists (use option '-e' to print it)
Formula 5 is FALSE accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-05 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 6 : !((F("(F30>=1)")))
Formula 6 simplified : !F"(F30>=1)"
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([](<>((LTLAP1==true)))), --buchi-type=spotba], workingDir=/home/mcc/execution]
255
1 unique states visited
0 strongly connected components in search stack
0 transitions explored
1 items max in DFS search stack
773 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,46.7946,993684,1,0,1818,5.92391e+06,70,395,2214,6.44027e+06,4529
no accepting run found
Formula 6 is TRUE no accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-06 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 7 : !((F("(Section_48<=F1)")))
Formula 7 simplified : !F"(Section_48<=F1)"
1 unique states visited
0 strongly connected components in search stack
0 transitions explored
1 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,46.7955,993684,1,0,1818,5.92391e+06,79,395,2217,6.44027e+06,4533
no accepting run found
Formula 7 is TRUE no accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-07 TRUE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 8 : !((("(F26<=F17)")U(("(Section_5>=3)")U("(Section_31>=3)"))))
Formula 8 simplified : !("(F26<=F17)" U ("(Section_5>=3)" U "(Section_31>=3)"))
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
2587 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,72.656,1453176,1,0,2282,8.25156e+06,100,602,2237,1.01868e+07,5590
an accepting run exists (use option '-e' to print it)
Formula 8 is FALSE accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-08 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 9 : !((false))
Formula 9 simplified : 1
2 unique states visited
2 strongly connected components in search stack
2 transitions explored
2 items max in DFS search stack
0 ticks for the emptiness check
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
STATS,0,72.6564,1453176,1,0,2282,8.25156e+06,100,602,2237,1.01868e+07,5590
an accepting run exists (use option '-e' to print it)
Formula 9 is FALSE accepting run found.
FORMULA CircularTrains-PT-048-LTLCardinality-09 FALSE TECHNIQUES DECISION_DIAGRAMS TOPOLOGICAL
Checking formula 10 : !((X((F("(F12>=1)"))U("(Section_29>=1)"))))
Formula 10 simplified : !X(F"(F12>=1)" U "(Section_29>=1)")
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/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.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/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.ltl -c -stutter-deadlock
Read 6 LTL properties
Checking formula 0 : !((X((F("(F12>=1)"))U("(Section_29>=1)"))))
Formula 0 simplified : !X(F"(F12>=1)" U "(Section_29>=1)")
Reverse transition relation is exact ! Faster fixpoint algorithm enabled.
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/LTLCardinality.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLCardinality.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/LTLCardinality.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLCardinality.ltl -c -stutter-deadlock
Read 6 LTL properties
Checking formula 0 : !((X((F("(F12>=1)"))U("(Section_29>=1)"))))
Formula 0 simplified : !X(F"(F12>=1)" U "(Section_29>=1)")
Reverse transition relation is exact ! Faster fixpoint algorithm enabled.

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
+ [[ LTLCardinality = StateSpace ]]
+ /home/mcc/BenchKit//runeclipse.sh /home/mcc/execution LTLCardinality -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 LTLCardinality -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 8:58:03 PM fr.lip6.move.gal.application.Application start
INFO: Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLCardinality, -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 8:58:03 PM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 26, 2019 8:58:03 PM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 50 ms
Mar 26, 2019 8:58:03 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 96 places.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 48 transitions.
Mar 26, 2019 8:58:04 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/model.pnml.img.gal : 11 ms
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 69 ms
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 23 ms
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 48 transitions.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 96 places.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 48 transitions.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 48 transitions.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver computeAndDeclareInvariants
INFO: Computed 49 place invariants in 31 ms
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.KInductionSolver init
INFO: Proved 96 variables to be positive in 214 ms
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may disable matrix : 48 transitions.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of disable matrix completed :0/48 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete disable matrix. took 2 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeAblingMatrix
INFO: Computing symmetric may enable matrix : 48 transitions.
Mar 26, 2019 8:58:04 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Complete enable matrix. took 2 ms. Total solver calls (SAT/UNSAT): 0(0/0)
Mar 26, 2019 8:58:05 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeCoEnablingMatrix
INFO: Computing symmetric co enabling matrix : 48 transitions.
Mar 26, 2019 8:58:06 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Finished co-enabling matrix. took 1545 ms. Total solver calls (SAT/UNSAT): 403(351/52)
Mar 26, 2019 8:58:06 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver computeDoNotAccord
INFO: Computing Do-Not-Accords matrix : 48 transitions.
Mar 26, 2019 8:58:07 PM fr.lip6.move.gal.gal2smt.bmc.NecessaryEnablingsolver printStats
INFO: Computation of Completed DNA matrix. took 399 ms. Total solver calls (SAT/UNSAT): 44(0/44)
Mar 26, 2019 8:58:07 PM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Built C files in 2952ms conformant to PINS in folder :/home/mcc/execution
Mar 26, 2019 8:58:34 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 5 ms
Mar 26, 2019 8:58:34 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 1 ms
pins2lts-mc, 0.000: Registering PINS so language module
pins2lts-mc( 2/ 8), 0.001: library has no initializer
pins2lts-mc( 2/ 8), 0.001: loading model GAL
pins2lts-mc( 1/ 8), 0.001: library has no initializer
pins2lts-mc( 1/ 8), 0.001: loading model GAL
pins2lts-mc( 3/ 8), 0.001: library has no initializer
pins2lts-mc( 3/ 8), 0.001: loading model GAL
pins2lts-mc( 3/ 8), 0.006: completed loading model GAL
pins2lts-mc( 2/ 8), 0.006: completed loading model GAL
pins2lts-mc( 2/ 8), 0.006: LTL layer: formula: X([](<>((LTLAP1==true))))
pins2lts-mc( 5/ 8), 0.006: library has no initializer
pins2lts-mc( 5/ 8), 0.006: loading model GAL
pins2lts-mc( 1/ 8), 0.006: completed loading model GAL
pins2lts-mc( 2/ 8), 0.006: "X([](<>((LTLAP1==true))))" is not a file, parsing as formula...
pins2lts-mc( 0/ 8), 0.007: Loading model from ./gal.so
pins2lts-mc( 0/ 8), 0.007: library has no initializer
pins2lts-mc( 0/ 8), 0.007: loading model GAL
pins2lts-mc( 4/ 8), 0.006: library has no initializer
pins2lts-mc( 4/ 8), 0.006: loading model GAL
pins2lts-mc( 0/ 8), 0.007: completed loading model GAL
pins2lts-mc( 5/ 8), 0.006: completed loading model GAL
pins2lts-mc( 4/ 8), 0.007: completed loading model GAL
pins2lts-mc( 6/ 8), 0.006: library has no initializer
pins2lts-mc( 2/ 8), 0.007: Using Spin LTL semantics
pins2lts-mc( 7/ 8), 0.006: library has no initializer
pins2lts-mc( 6/ 8), 0.006: loading model GAL
pins2lts-mc( 6/ 8), 0.010: completed loading model GAL
pins2lts-mc( 7/ 8), 0.009: loading model GAL
pins2lts-mc( 7/ 8), 0.010: completed loading model GAL
pins2lts-mc( 0/ 8), 0.018: Weak Buchi automaton detected, adding non-accepting as progress label.
pins2lts-mc( 0/ 8), 0.225: DFS-FIFO for weak LTL, using special progress label 69
pins2lts-mc( 0/ 8), 0.225: There are 70 state labels and 1 edge labels
pins2lts-mc( 0/ 8), 0.225: State length is 97, there are 51 groups
pins2lts-mc( 0/ 8), 0.225: Running dfsfifo using 8 cores
pins2lts-mc( 0/ 8), 0.225: Using a tree table with 2^27 elements
pins2lts-mc( 0/ 8), 0.225: Successor permutation: rr
pins2lts-mc( 0/ 8), 0.225: Global bits: 2, count bits: 0, local bits: 0
pins2lts-mc( 1/ 8), 0.416: ~97 levels ~960 states ~8184 transitions
pins2lts-mc( 1/ 8), 0.495: ~168 levels ~1920 states ~11704 transitions
pins2lts-mc( 1/ 8), 0.515: ~168 levels ~3840 states ~14696 transitions
pins2lts-mc( 1/ 8), 0.563: ~168 levels ~7680 states ~21608 transitions
pins2lts-mc( 0/ 8), 0.653: ~160 levels ~15360 states ~34992 transitions
pins2lts-mc( 1/ 8), 0.820: ~168 levels ~30720 states ~70216 transitions
pins2lts-mc( 1/ 8), 1.177: ~168 levels ~61440 states ~136816 transitions
pins2lts-mc( 5/ 8), 1.707: ~161 levels ~122880 states ~258376 transitions
pins2lts-mc( 5/ 8), 2.570: ~161 levels ~245760 states ~517896 transitions
pins2lts-mc( 5/ 8), 3.962: ~161 levels ~491520 states ~1084360 transitions
pins2lts-mc( 5/ 8), 6.121: ~161 levels ~983040 states ~2339736 transitions
pins2lts-mc( 4/ 8), 9.628: ~202 levels ~1966080 states ~4810544 transitions
pins2lts-mc( 0/ 8), 16.581: ~160 levels ~3932160 states ~9742472 transitions
pins2lts-mc( 0/ 8), 31.554: ~160 levels ~7864320 states ~20335048 transitions
pins2lts-mc( 4/ 8), 63.475: ~202 levels ~15728640 states ~42695872 transitions
pins2lts-mc( 2/ 8), 119.824: Error: tree leafs table full! Change -s/--ratio.
pins2lts-mc( 0/ 8), 119.961:
pins2lts-mc( 0/ 8), 119.961: mean standard work distribution: 4.5% (states) 4.6% (transitions)
pins2lts-mc( 0/ 8), 119.961:
pins2lts-mc( 0/ 8), 119.961: Explored 27004442 states 79604912 transitions, fanout: 2.948
pins2lts-mc( 0/ 8), 119.961: Total exploration time 119.710 sec (119.600 sec minimum, 119.634 sec on average)
pins2lts-mc( 0/ 8), 119.961: States per second: 225582, Transitions per second: 664981
pins2lts-mc( 0/ 8), 119.961:
pins2lts-mc( 0/ 8), 119.961: Progress states detected: 5
pins2lts-mc( 0/ 8), 119.961: Redundant explorations: -0.0224
pins2lts-mc( 0/ 8), 119.961:
pins2lts-mc( 0/ 8), 119.961: Queue width: 8B, total height: 1439, memory: 0.01MB
pins2lts-mc( 0/ 8), 119.961: Tree memory: 462.1MB, 17.9 B/state, compr.: 4.6%
pins2lts-mc( 0/ 8), 119.961: Tree fill ratio (roots/leafs): 20.0%/99.0%
pins2lts-mc( 0/ 8), 119.961: Stored 49 string chucks using 0MB
pins2lts-mc( 0/ 8), 119.961: Total memory used for chunk indexing: 0MB
pins2lts-mc( 0/ 8), 119.961: Est. total memory use: 462.1MB (~1024.0MB 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([](<>((LTLAP1==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:91)
at java.lang.Thread.run(Thread.java:748)
Mar 26, 2019 9:18:34 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 17 ms
Mar 26, 2019 9:18:34 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 2 ms
Mar 26, 2019 9:18:34 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 0 ms
Mar 26, 2019 9:38:34 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 14 ms
Mar 26, 2019 9:38:34 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLCardinality.pnml.gal : 2 ms
Mar 26, 2019 9:38:34 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLCardinality.ltl : 1 ms

Sequence of Actions to be Executed by the VM

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

set -x
# this is for BenchKit: configuration of major elements for the test
export BK_INPUT="CircularTrains-PT-048"
export BK_EXAMINATION="LTLCardinality"
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 CircularTrains-PT-048, examination is LTLCardinality"
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-155225126700186"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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