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

About the Execution of ITS-Tools.M for FamilyReunion-PT-L00400M0040C020P020G001

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
15902.710 2390894.00 3634195.00 942.10 [undef] Cannot compute

Execution Chart

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

Trace from the execution

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

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 446M
-rw-r--r-- 1 mcc users 4.2K Mar 24 07:12 CTLCardinality.txt
-rw-r--r-- 1 mcc users 20K Mar 24 07:11 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.8K Mar 24 07:03 CTLFireability.txt
-rw-r--r-- 1 mcc users 18K Mar 24 07:02 CTLFireability.xml
-rw-r--r-- 1 mcc users 3.2K Mar 24 06:54 LTLCardinality.txt
-rw-r--r-- 1 mcc users 14K Mar 24 06:53 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.8K Mar 24 06:50 LTLFireability.txt
-rw-r--r-- 1 mcc users 11K Mar 24 06:49 LTLFireability.xml
-rw-r--r-- 1 mcc users 1 Mar 24 00:18 NewModel
-rw-r--r-- 1 mcc users 4.1K Mar 24 06:46 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 18K Mar 24 06:45 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 131 Mar 24 06:29 ReachabilityDeadlock.txt
-rw-r--r-- 1 mcc users 369 Mar 24 06:28 ReachabilityDeadlock.xml
-rw-r--r-- 1 mcc users 4.2K Mar 24 06:37 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 18K Mar 24 06:37 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 2.1K Mar 24 06:48 UpperBounds.txt
-rw-r--r-- 1 mcc users 4.1K Mar 24 06:47 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 24 00:18 equiv_col

-rw-r--r-- 1 mcc users 24 Mar 24 00:18 instance
-rw-r--r-- 1 mcc users 6 Mar 24 00:18 iscolored
-rw-r--r-- 1 mcc users 446M Mar 24 00:18 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 FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-00
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-01
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-02
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-03
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-04
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-05
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-06
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-07
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-08
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-09
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-10
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-11
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-12
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-13
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-14
FORMULA_NAME FamilyReunion-PT-L00400M0040C020P020G001-LTLFireability-15

=== Now, execution of the tool begins

BK_START 1553843366876

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
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
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 16 LTL properties
Its-tools:
An error has occurred. See the log file
/tmp/.eclipse/1553843367776.log.

BK_STOP 1553845757770

--------------------
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 29, 2019 7:09:29 AM 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 29, 2019 7:09:29 AM fr.lip6.move.gal.application.MccTranslator transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Mar 29, 2019 7:09:49 AM fr.lip6.move.gal.nupn.PTNetReader loadFromXML
INFO: Load time of PNML (sax parser for PT used): 20325 ms
Mar 29, 2019 7:09:53 AM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 537708 places.
Mar 29, 2019 7:10:03 AM fr.lip6.move.gal.pnml.togal.PTGALTransformer handlePage
INFO: Transformed 508489 transitions.
Mar 29, 2019 7:11:06 AM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 106 fixed domain variables (out of 537708 variables) in GAL type FamilyReunion_PT_L00400M0040C020P020G001
Mar 29, 2019 7:11:06 AM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: Found a total of 106 constant array cells/variables (out of 537708 variables) in type FamilyReunion_PT_L00400M0040C020P020G001
Mar 29, 2019 7:11:06 AM fr.lip6.move.gal.instantiate.Simplifier printConstantVars
INFO: m0_11,p0_19,c2_8,m0_34,c2_11,p0_13,m0_1,c2_15,c0_19,c0_18,p0_18,m0_14,p0_1,p0_15,c2_20,m0_10,c0_17,m0_28,m0_40,m0_39,c2_0,m0_37,c2_13,r0_N,p0_7,p0_5,c0_3,m0_3,c2_10,c2_5,c2_1,c0_0,c0_2,m0_31,m0_17,c0_8,m0_6,p0_0,m0_0,c2_18,c0_20,m0_19,p0_17,m0_22,m0_38,c2_7,c2_14,p0_3,m0_12,m0_24,p0_11,p0_8,m0_4,c0_6,m0_16,c0_7,c0_12,p0_20,m0_29,c0_14,p0_10,m0_13,c0_9,p0_9,m0_26,c2_3,m0_27,m0_32,m0_18,c0_15,c2_17,m0_8,c2_12,m0_23,m0_7,c2_2,p0_14,c2_4,p0_4,m0_21,m0_2,m0_35,c0_5,c0_4,m0_25,p0_12,c0_11,p0_2,c2_6,m0_33,c0_16,c0_10,m0_15,m0_20,c2_9,c2_16,r0_Y,p0_16,c2_19,c0_13,p0_6,m0_36,m0_30,c0_1,m0_9,m0_5,
Mar 29, 2019 7:11:10 AM fr.lip6.move.gal.instantiate.Simplifier simplifyConstantVariables
INFO: Removed 106 constant variables :m0_11=1, p0_19=1, c2_8=1, m0_34=1, c2_11=1, p0_13=1, m0_1=1, c2_15=1, c0_19=1, c0_18=1, p0_18=1, m0_14=1, p0_1=1, p0_15=1, c2_20=1, m0_10=1, c0_17=1, m0_28=1, m0_40=1, m0_39=1, c2_0=1, m0_37=1, c2_13=1, r0_N=1, p0_7=1, p0_5=1, c0_3=1, m0_3=1, c2_10=1, c2_5=1, c2_1=1, c0_0=1, c0_2=1, m0_31=1, m0_17=1, c0_8=1, m0_6=1, p0_0=1, m0_0=1, c2_18=1, c0_20=1, m0_19=1, p0_17=1, m0_22=1, m0_38=1, c2_7=1, c2_14=1, p0_3=1, m0_12=1, m0_24=1, p0_11=1, p0_8=1, m0_4=1, c0_6=1, m0_16=1, c0_7=1, c0_12=1, p0_20=1, m0_29=1, c0_14=1, p0_10=1, m0_13=1, c0_9=1, p0_9=1, m0_26=1, c2_3=1, m0_27=1, m0_32=1, m0_18=1, c0_15=1, c2_17=1, m0_8=1, c2_12=1, m0_23=1, m0_7=1, c2_2=1, p0_14=1, c2_4=1, p0_4=1, m0_21=1, m0_2=1, m0_35=1, c0_5=1, c0_4=1, m0_25=1, p0_12=1, c0_11=1, p0_2=1, c2_6=1, m0_33=1, c0_16=1, c0_10=1, m0_15=1, m0_20=1, c2_9=1, c2_16=1, r0_Y=1, p0_16=1, c2_19=1, c0_13=1, p0_6=1, m0_36=1, m0_30=1, c0_1=1, m0_9=1, m0_5=1
Mar 29, 2019 7:11:10 AM fr.lip6.move.gal.instantiate.Simplifier simplifyConstantVariables
INFO: Simplified 50528 expressions due to constant valuations.
Mar 29, 2019 7:11:27 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 82657 ms
Mar 29, 2019 7:12:58 AM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 508489 transitions.
Mar 29, 2019 7:12:58 AM fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext transform
INFO: Too many transitions (508489) to apply POR reductions. Disabling POR matrices.
Exception in thread "Thread-3" java.lang.OutOfMemoryError: Java heap space
at java.util.Arrays.copyOf(Arrays.java:3308)
at java.util.BitSet.ensureCapacity(BitSet.java:337)
at java.util.BitSet.or(BitSet.java:943)
at fr.lip6.move.gal.semantics.SupportVisitor.visit(SupportVisitor.java:38)
at fr.lip6.move.gal.semantics.SupportVisitor.visit(SupportVisitor.java:1)
at fr.lip6.move.gal.semantics.Predicate.accept(Predicate.java:38)
at fr.lip6.move.gal.semantics.NextSupportAnalyzer.computeSupport(NextSupportAnalyzer.java:28)
at fr.lip6.move.gal.semantics.DependencyMatrix.lambda$0(DependencyMatrix.java:32)
at fr.lip6.move.gal.semantics.DependencyMatrix$$Lambda$23/1333863208.accept(Unknown Source)
at java.util.ArrayList.forEach(ArrayList.java:1257)
at fr.lip6.move.gal.semantics.DependencyMatrix.(DependencyMatrix.java:32)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.printDependencyMatrix(Gal2PinsTransformerNext.java:189)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.buildBodyFile(Gal2PinsTransformerNext.java:85)
at fr.lip6.move.gal.gal2pins.Gal2PinsTransformerNext.transform(Gal2PinsTransformerNext.java:830)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:71)
at java.lang.Thread.run(Thread.java:748)
Mar 29, 2019 7:15:49 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 186260 ms
Mar 29, 2019 7:16:25 AM fr.lip6.move.gal.semantics.DeterministicNextBuilder getDeterministicNext
INFO: Input system was already deterministic with 508489 transitions.
Mar 29, 2019 7:16:27 AM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 537602 places.
Mar 29, 2019 7:16:29 AM fr.lip6.move.gal.application.StructuralToGreatSPN handlePage
INFO: Transformed 508489 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 29, 2019 7:16:50 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 1822 ms
Mar 29, 2019 7:16:50 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 5 ms
Mar 29, 2019 7:37:49 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 45437 ms
Mar 29, 2019 7:37:51 AM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 1817 ms
Mar 29, 2019 7:37:51 AM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSLTLTools
INFO: Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 15 ms
ITS-tools command line returned an error code 139
Mar 29, 2019 7:45:12 AM fr.lip6.move.gal.application.MccTranslator applyOrder
INFO: Applying decomposition
Mar 29, 2019 7:45:49 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 37494 ms
Mar 29, 2019 7:46:24 AM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 35277 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="FamilyReunion-PT-L00400M0040C020P020G001"
export BK_EXAMINATION="LTLFireability"
export BK_TOOL="itstoolsm"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

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

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-3954"
echo " Executing tool itstoolsm"
echo " Input is FamilyReunion-PT-L00400M0040C020P020G001, 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 r203-csrt-155344537900232"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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