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.r022-csrt-155225094500075.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 win2018
Input is AutoFlight-PT-48b, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r022-csrt-155225094500075
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 1.2M
-rw-r--r-- 1 mcc users 4.4K Feb 9 07:22 CTLCardinality.txt
-rw-r--r-- 1 mcc users 26K Feb 9 07:22 CTLCardinality.xml
-rw-r--r-- 1 mcc users 2.8K Feb 5 04:11 CTLFireability.txt
-rw-r--r-- 1 mcc users 20K Feb 5 04:11 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 10 17:31 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.2K Mar 10 17:31 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 104 Feb 24 15:05 GlobalProperties.txt
-rw-r--r-- 1 mcc users 342 Feb 24 15:05 GlobalProperties.xml
-rw-r--r-- 1 mcc users 2.5K Feb 4 22:55 LTLCardinality.txt
-rw-r--r-- 1 mcc users 12K Feb 4 22:55 LTLCardinality.xml
-rw-r--r-- 1 mcc users 1.8K Feb 4 22:32 LTLFireability.txt
-rw-r--r-- 1 mcc users 8.1K Feb 4 22:32 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.6K Feb 2 00:37 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 19K Feb 2 00:37 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Jan 29 11:51 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 9.9K Jan 29 11:51 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.6K Feb 4 22:18 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.7K 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 956K 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 AutoFlight-PT-48b-LTLFireability-00
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-01
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-02
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-03
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-04
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-05
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-06
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-07
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-08
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-09
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-10
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-11
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-12
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-13
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-14
FORMULA_NAME AutoFlight-PT-48b-LTLFireability-15

=== Now, execution of the tool begins

BK_START 1552400073505

info: Time: 3600 - MCC
===========================================================================================
prep: translating AutoFlight-PT-48b Petri net model.pnml into LoLA format
===========================================================================================
prep: translating PT Petri net complete
prep: net is already safe
prep: check for too many tokens
===========================================================================================
prep: translating AutoFlight-PT-48b formula LTLFireability into LoLA format
===========================================================================================
prep: translating PT formula complete
vrfy: Checking LTLFireability @ AutoFlight-PT-48b @ 3570 seconds
lola: LoLA will run for 3570 seconds at most (--timelimit)
lola: NET
lola: reading net from model.pnml.lola
lola: finished parsing
lola: closed net file model.pnml.lola
lola: 7886/65536 symbol table entries, 1706 collisions
lola: preprocessing...
lola: Size of bit vector: 3950
lola: finding significant places
lola: 3950 places, 3936 transitions, 3692 significant places
lola: computing forward-conflicting sets
lola: computing back-conflicting sets
lola: 4350 transition conflict sets
lola: TASK
lola: reading formula from AutoFlight-PT-48b-LTLFireability.task
lola: A (F (X (G (G (X (FIREABLE(t3764))))))) : A (G ((X (F (FIREABLE(t478))) U FIREABLE(t1376)))) : A (FIREABLE(t213)) : A (FIREABLE(t2222)) : A (FIREABLE(t2184)) : A ((FIREABLE(t3381) U FIREABLE(t3139))) : A (G (FIREABLE(t200))) : A (G (F ((F (FIREABLE(t73)) U FIREABLE(t3088))))) : A (X ((F (FIREABLE(t3255)) U F (G (FIREABLE(t300)))))) : A (G (F ((F (FIREABLE(t468)) U G (FIREABLE(t1366)))))) : A (G (F (F (FIREABLE(t1678))))) : A (G (((FIREABLE(t1368) U FIREABLE(t721)) U F (F (FIREABLE(t3189)))))) : A ((F ((FIREABLE(t3562) U FIREABLE(t2208))) U FIREABLE(t2877))) : A (FIREABLE(t1988)) : A (FIREABLE(t3882)) : A (G (G (FIREABLE(t1607))))
lola: rewrite Frontend/Parser/formula_rewrite.k:353
lola: rewrite Frontend/Parser/formula_rewrite.k:353
lola: rewrite Frontend/Parser/formula_rewrite.k:350
lola: rewrite Frontend/Parser/formula_rewrite.k:356
lola: rewrite Frontend/Parser/formula_rewrite.k:356
lola: rewrite Frontend/Parser/formula_rewrite.k:380
lola: rewrite Frontend/Parser/formula_rewrite.k:380
lola: rewrite Frontend/Parser/formula_rewrite.k:437
lola: rewrite Frontend/Parser/formula_rewrite.k:522
lola: rewrite Frontend/Parser/formula_rewrite.k:545
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:434
lola: rewrite Frontend/Parser/formula_rewrite.k:422
lola: rewrite Frontend/Parser/formula_rewrite.k:380
lola: rewrite Frontend/Parser/formula_rewrite.k:434
lola: rewrite Frontend/Parser/formula_rewrite.k:374
lola: rewrite Frontend/Parser/formula_rewrite.k:347
lola: rewrite Frontend/Parser/formula_rewrite.k:347
lola: rewrite Frontend/Parser/formula_rewrite.k:422
lola: rewrite Frontend/Parser/formula_rewrite.k:434
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:151
lola: rewrite Frontend/Parser/formula_rewrite.k:350
lola: computing a collection of formulas
lola: RUNNING
lola: subprocess 0 will run for 223 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FIREABLE(t213)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FIREABLE(t213)
lola: processed formula length: 14
lola: 25 rewrites
lola: closed formula file AutoFlight-PT-48b-LTLFireability.task
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================

FORMULA AutoFlight-PT-48b-LTLFireability-2 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
lola: subprocess 1 will run for 238 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FIREABLE(t2222)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FIREABLE(t2222)
lola: processed formula length: 15
lola: 25 rewrites
lola: closed formula file AutoFlight-PT-48b-LTLFireability.task
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges

FORMULA AutoFlight-PT-48b-LTLFireability-3 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
lola: subprocess 2 will run for 255 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FIREABLE(t2184)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FIREABLE(t2184)
lola: processed formula length: 15
lola: 25 rewrites
lola: closed formula file AutoFlight-PT-48b-LTLFireability.task
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================

FORMULA AutoFlight-PT-48b-LTLFireability-4 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
lola: subprocess 3 will run for 274 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FIREABLE(t1988)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FIREABLE(t1988)
lola: processed formula length: 15
lola: 25 rewrites
lola: closed formula file AutoFlight-PT-48b-LTLFireability.task
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================

FORMULA AutoFlight-PT-48b-LTLFireability-13 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
lola: ========================================
lola: subprocess 4 will run for 297 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: FIREABLE(t3882)
lola: ========================================
lola: SUBTASK
lola: checking initial satisfaction
lola: processed formula: FIREABLE(t3882)
lola: processed formula length: 15
lola: 25 rewrites
lola: closed formula file AutoFlight-PT-48b-LTLFireability.task
lola: processed formula with 0 atomic propositions
lola: RUNNING
lola: SUBRESULT
lola: result: no
lola: produced by: preprocessing
lola: The net violates the given property already in its initial state.
lola: 0 markings, 0 edges
lola: ========================================

FORMULA AutoFlight-PT-48b-LTLFireability-14 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
lola: subprocess 5 will run for 324 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: (A (G (F (FIREABLE(t1376)))) AND A (G ((X (F (FIREABLE(t478))) OR FIREABLE(t1376)))))
lola: ========================================
lola: SUBTASK
lola: checking a Boolean combination of formulas
lola: RUNNING
lola: subprocess 5 will run for 324 seconds at most (--localtimelimit=0)
lola: ========================================
lola: ...considering subproblem: A (G (F (FIREABLE(t1376))))
lola: ========================================
lola: SUBTASK
lola: checking LTL
lola: transforming LTL-Formula into a Büchi-Automaton
lola: processed formula: A (G (F (FIREABLE(t1376))))
lola: processed formula length: 27
lola: 25 rewrites
lola: closed formula file AutoFlight-PT-48b-LTLFireability.task
lola: the resulting Büchi automaton has 2 states
lola: STORE
lola: using a simple compression encoder (--encoder=simplecompressed)
lola: using a prefix tree store (--store=prefix)
lola: using ltl preserving stubborn set method (--stubborn)
lola: SEARCH
lola: RUNNING
lola: 106201 markings, 106200 edges, 21240 markings/sec, 0 secs
lola: 220421 markings, 220421 edges, 22844 markings/sec, 5 secs
lola: 335099 markings, 335099 edges, 22936 markings/sec, 10 secs
lola: 446440 markings, 446440 edges, 22268 markings/sec, 15 secs
lola: 559268 markings, 559267 edges, 22566 markings/sec, 20 secs
lola: 676063 markings, 676062 edges, 23359 markings/sec, 25 secs
lola: 790573 markings, 790572 edges, 22902 markings/sec, 30 secs
lola: 905146 markings, 905145 edges, 22915 markings/sec, 35 secs
lola: 1019619 markings, 1019619 edges, 22895 markings/sec, 40 secs
lola: 1134480 markings, 1134480 edges, 22972 markings/sec, 45 secs
lola: 1249349 markings, 1249349 edges, 22974 markings/sec, 50 secs
lola: 1364587 markings, 1364587 edges, 23048 markings/sec, 55 secs
lola: 1479601 markings, 1479601 edges, 23003 markings/sec, 60 secs
lola: 1594241 markings, 1594240 edges, 22928 markings/sec, 65 secs
lola: 1708874 markings, 1708873 edges, 22927 markings/sec, 70 secs
lola: 1823594 markings, 1823594 edges, 22944 markings/sec, 75 secs
lola: 1938047 markings, 1938046 edges, 22891 markings/sec, 80 secs
lola: 2052595 markings, 2052595 edges, 22910 markings/sec, 85 secs
lola: 2167368 markings, 2167368 edges, 22955 markings/sec, 90 secs
lola: 2284726 markings, 2284726 edges, 23472 markings/sec, 95 secs
lola: 2402115 markings, 2402114 edges, 23478 markings/sec, 100 secs
lola: 2519363 markings, 2519363 edges, 23450 markings/sec, 105 secs
lola: 2636296 markings, 2636296 edges, 23387 markings/sec, 110 secs
lola: 2753027 markings, 2753026 edges, 23346 markings/sec, 115 secs
lola: 2869850 markings, 2869850 edges, 23365 markings/sec, 120 secs
lola: 2986032 markings, 2986032 edges, 23236 markings/sec, 125 secs
lola: 3100840 markings, 3100839 edges, 22962 markings/sec, 130 secs
lola: 3215088 markings, 3215088 edges, 22850 markings/sec, 135 secs
lola: 3331358 markings, 3331357 edges, 23254 markings/sec, 140 secs
lola: 3447716 markings, 3447716 edges, 23272 markings/sec, 145 secs
lola: 3564419 markings, 3564419 edges, 23341 markings/sec, 150 secs
lola: 3681375 markings, 3681374 edges, 23391 markings/sec, 155 secs
lola: 3798011 markings, 3798010 edges, 23327 markings/sec, 160 secs
lola: 3914342 markings, 3914342 edges, 23266 markings/sec, 165 secs
lola: 4030333 markings, 4030332 edges, 23198 markings/sec, 170 secs
lola: 4143635 markings, 4143634 edges, 22660 markings/sec, 175 secs
lola: 4248659 markings, 4248658 edges, 21005 markings/sec, 180 secs
lola: 4353754 markings, 4353754 edges, 21019 markings/sec, 185 secs
lola: 4460901 markings, 4460901 edges, 21429 markings/sec, 190 secs
lola: 4572304 markings, 4572303 edges, 22281 markings/sec, 195 secs
lola: 4679903 markings, 4679903 edges, 21520 markings/sec, 200 secs
lola: 4784792 markings, 4784791 edges, 20978 markings/sec, 205 secs
lola: 4891753 markings, 4891752 edges, 21392 markings/sec, 210 secs
lola: 5008239 markings, 5008239 edges, 23297 markings/sec, 215 secs
lola: 5124441 markings, 5124440 edges, 23240 markings/sec, 220 secs
lola: 5240999 markings, 5240998 edges, 23312 markings/sec, 225 secs
lola: 5357976 markings, 5357975 edges, 23395 markings/sec, 230 secs
lola: 5474923 markings, 5474923 edges, 23389 markings/sec, 235 secs
lola: 5591576 markings, 5591575 edges, 23331 markings/sec, 240 secs
lola: 5708151 markings, 5708151 edges, 23315 markings/sec, 245 secs
lola: 5824618 markings, 5824618 edges, 23293 markings/sec, 250 secs
lola: 5940856 markings, 5940856 edges, 23248 markings/sec, 255 secs
lola: 6057377 markings, 6057376 edges, 23304 markings/sec, 260 secs
lola: 6173490 markings, 6173490 edges, 23223 markings/sec, 265 secs
lola: 6289929 markings, 6289929 edges, 23288 markings/sec, 270 secs
lola: 6406577 markings, 6406577 edges, 23330 markings/sec, 275 secs
lola: 6520819 markings, 6520818 edges, 22848 markings/sec, 280 secs
lola: 6635489 markings, 6635489 edges, 22934 markings/sec, 285 secs
lola: 6752033 markings, 6752032 edges, 23309 markings/sec, 290 secs
lola: 6868171 markings, 6868170 edges, 23228 markings/sec, 295 secs
lola: 6984280 markings, 6984279 edges, 23222 markings/sec, 300 secs
lola: 7100695 markings, 7100695 edges, 23283 markings/sec, 305 secs
lola: 7216712 markings, 7216711 edges, 23203 markings/sec, 310 secs
lola: 7331789 markings, 7331789 edges, 23015 markings/sec, 315 secs
lola: local time limit reached - aborting
lola:
preliminary result: unknown unknown no no no unknown unknown unknown unknown unknown unknown unknown unknown no no unknown
lola: caught signal User defined signal 1 - aborting LoLA
lola:
preliminary result: unknown unknown no no no unknown unknown unknown unknown unknown unknown unknown unknown no no unknown
lola: local time limit reached - aborting
lola:
preliminary result: unknown unknown no no no unknown unknown unknown unknown unknown unknown unknown unknown no no unknown
lola: memory consumption: 1605840 KB
lola: time consumption: 324 seconds
lola: time limit reached - aborting
lola:
preliminary result: unknown unknown no no no unknown unknown unknown unknown unknown unknown unknown unknown no no unknown
lola:
preliminary result: unknown unknown no no no unknown unknown unknown unknown unknown unknown unknown unknown no no unknown
lola: memory consumption: 1606108 KB
lola: time consumption: 3570 seconds

BK_TIME_CONFINEMENT_REACHED

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

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="AutoFlight-PT-48b"
export BK_EXAMINATION="LTLFireability"
export BK_TOOL="win2018"
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 win2018"
echo " Input is AutoFlight-PT-48b, 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 r022-csrt-155225094500075"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

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