Execution Chart

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

Trace from the execution

Formatting '/mnt/tpsp/fkordon/mcc2020-input.r176-tajo-158987871800393.qcow2', fmt=qcow2 size=4294967296 backing_file='/mnt/tpsp/fkordon/mcc2020-input.qcow2' encryption=off cluster_size=65536 lazy_refcounts=off
Waiting for the VM to be ready (probing ssh)
................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itslola
Input is PolyORBLF-COL-S06J06T06, examination is LTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r176-tajo-158987871800393
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 348K
-rw-r--r-- 1 mcc users 3.6K Apr 12 05:56 CTLCardinality.txt
-rw-r--r-- 1 mcc users 17K Apr 12 05:55 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Apr 11 05:36 CTLFireability.txt
-rw-r--r-- 1 mcc users 19K Apr 11 05:35 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Mar 24 05:37 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 5.9K Mar 24 05:37 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 4.1K Apr 14 12:46 LTLCardinality.txt
-rw-r--r-- 1 mcc users 25K Apr 28 14:02 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.2K Apr 14 12:46 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Apr 28 14:02 LTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K Apr 10 12:52 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 19K Apr 10 12:51 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.2K Apr 9 18:27 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 18K Apr 9 18:26 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Apr 10 22:23 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K Apr 10 22:23 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 equiv_pt
-rw-r--r-- 1 mcc users 10 Mar 24 05:37 instance
-rw-r--r-- 1 mcc users 5 Mar 24 05:37 iscolored
-rw-r--r-- 1 mcc users 154K Mar 24 05:37 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 PolyORBLF-COL-S06J06T06-00
FORMULA_NAME PolyORBLF-COL-S06J06T06-01
FORMULA_NAME PolyORBLF-COL-S06J06T06-02
FORMULA_NAME PolyORBLF-COL-S06J06T06-03
FORMULA_NAME PolyORBLF-COL-S06J06T06-04
FORMULA_NAME PolyORBLF-COL-S06J06T06-05
FORMULA_NAME PolyORBLF-COL-S06J06T06-06
FORMULA_NAME PolyORBLF-COL-S06J06T06-07
FORMULA_NAME PolyORBLF-COL-S06J06T06-08
FORMULA_NAME PolyORBLF-COL-S06J06T06-09
FORMULA_NAME PolyORBLF-COL-S06J06T06-10
FORMULA_NAME PolyORBLF-COL-S06J06T06-11
FORMULA_NAME PolyORBLF-COL-S06J06T06-12
FORMULA_NAME PolyORBLF-COL-S06J06T06-13
FORMULA_NAME PolyORBLF-COL-S06J06T06-14
FORMULA_NAME PolyORBLF-COL-S06J06T06-15

=== Now, execution of the tool begins

BK_START 1591149483980

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
[2020-06-03 01:58:05] [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, -timeout, 3600, -rebuildPNML]
[2020-06-03 01:58:05] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-06-03 01:58:05] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2020-06-03 01:58:06] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 667 ms
[2020-06-03 01:58:06] [INFO ] sort/places :
D4->DisablePollingE,DisablePollingB,Insert_Source_B,P_1119,P_2579,
Threads->AwakeTasks,IdleTasks,NotifyEventJobQueuedE,QueueJobE,P_2321,TryAllocateOneTaskE,TryAllocateOneTaskB,P_2318,EnablePollingE,EnablePollingB,FetchJobB,ScheduleTaskE_Check,ScheduleTaskB,Abort_Check_Sources_E,Abort_Check_Sources_B,NotifyEventSourceAddedB,Insert_Source_E,NotifyEventSourceAddedE,P_1113,ProcessingEvt,P_1155,nyo,P_1158,P_1159,P_1160,NotifyEventEndOfCheckSourcesB,NotifyEventEndOfCheckSourcesE,Check_Sources_B,Check_Sources_E,Idle,NotifyEventJobCompletedE,NotifyEventJobCompletedB,RunE,RunB,Perform_Work_E,Try_Check_Sources_B,Try_Check_Sources_E,P_1617,ScheduleTaskE_Idle,
D6->CreatedJobs,
Jobs->P_1725,P_1724,P_1712,AvailableJobId,
Dot->cJobCnt,JobCnt,cBlockedTasks,PollingAbort,cPollingAbort,BlockedTasks,MarkerWrite,P_1727,P_1726,MarkerRead,P_1717,P_1716,CanInjectEvent,SigAbort,NoSigAbort,P_1093,P_1095,P_1097,P_1099,cSources,cIsMonitoring,IsMonitoring,cIdleTasks,ORB_Lock,
Sources->DataOnSrc,PlaceSources,ModifiedSrc,AbourtToModifySrc,
D1->NotifyEventJobQueuedB,QueueJobB,FetchJobE,ScheduleTaskE_Work,

[2020-06-03 01:58:06] [INFO ] ms2 symmetric to ms1 in transition T_1124
[2020-06-03 01:58:06] [INFO ] ms3 symmetric to ms2 in transition T_1125
[2020-06-03 01:58:06] [INFO ] ms2 symmetric to ms1 in transition T_1125
[2020-06-03 01:58:06] [INFO ] ms3 symmetric to ms2 in transition T_1126
[2020-06-03 01:58:06] [INFO ] ms2 symmetric to ms1 in transition T_1126
[2020-06-03 01:58:06] [INFO ] ms1 symmetric to ms4 in transition T_1126
[2020-06-03 01:58:06] [INFO ] Imported 81 HL places and 65 HL transitions for a total of 700 PT places and 10800.0 transition bindings in 25 ms.
[2020-06-03 01:58:06] [INFO ] Computed order based on color domains.
[2020-06-03 01:58:06] [INFO ] Unfolded HLPN to a Petri net with 700 places and 2670 transitions in 51 ms.
[2020-06-03 01:58:06] [INFO ] Unfolded HLPN properties in 0 ms.
Parsed 16 properties from file /home/mcc/execution/LTLCardinality.xml in 117 ms.
Working with output stream class java.io.PrintStream
Incomplete random walk after 100000 steps, including 588 resets, run finished after 668 ms. (steps per millisecond=149 ) properties seen :[1, 1, 1, 0, 1, 1, 0, 0, 1, 1, 0, 1, 0, 1, 1, 0, 1, 1, 1, 0, 0, 1, 1, 1, 1, 1, 0, 1, 1, 1, 1, 0, 0, 0, 0, 1, 1, 1, 0, 1, 0, 0, 1]
[2020-06-03 01:58:07] [INFO ] Flow matrix only has 2634 transitions (discarded 36 similar events)
// Phase 1: matrix 2634 rows 700 cols
[2020-06-03 01:58:07] [INFO ] Computed 58 place invariants in 264 ms
[2020-06-03 01:58:07] [INFO ] [Real]Absence check using 24 positive place invariants in 42 ms returned unsat
[2020-06-03 01:58:07] [INFO ] [Real]Absence check using 24 positive place invariants in 47 ms returned sat
[2020-06-03 01:58:07] [INFO ] [Real]Absence check using 24 positive and 34 generalized place invariants in 58 ms returned sat
[2020-06-03 01:58:07] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2020-06-03 01:58:11] [INFO ] [Real]Absence check using state equation in 3255 ms returned sat
[2020-06-03 01:58:11] [INFO ] Solution in real domain found non-integer solution.
[2020-06-03 01:58:11] [INFO ] [Nat]Absence check using 24 positive place invariants in 30 ms returned sat
[2020-06-03 01:58:11] [INFO ] [Nat]Absence check using 24 positive and 34 generalized place invariants in 44 ms returned sat
[2020-06-03 01:58:11] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2020-06-03 01:58:15] [INFO ] [Nat]Absence check using state equation in 3557 ms returned sat
[2020-06-03 01:58:15] [INFO ] State equation strengthened by 174 read => feed constraints.
[2020-06-03 01:58:16] [INFO ] [Nat]Added 174 Read/Feed constraints in 1750 ms returned sat
[2020-06-03 01:58:17] [INFO ] Deduced a trap composed of 103 places in 1077 ms
[2020-06-03 01:58:20] [INFO ] Deduced a trap composed of 94 places in 184 ms
[2020-06-03 01:58:22] [INFO ] Deduced a trap composed of 94 places in 142 ms
[2020-06-03 01:58:22] [INFO ] Trap strengthening (SAT) tested/added 4/3 trap constraints in 5694 ms
[2020-06-03 01:58:22] [INFO ] Computed and/alt/rep : 2664/49032/2628 causal constraints in 418 ms.
[2020-06-03 01:58:31] [INFO ] Added : 140 causal constraints over 28 iterations in 8844 ms. Result :unknown
[2020-06-03 01:58:31] [INFO ] [Real]Absence check using 24 positive place invariants in 46 ms returned unsat
[2020-06-03 01:58:31] [INFO ] [Real]Absence check using 24 positive place invariants in 18 ms returned unsat
[2020-06-03 01:58:31] [INFO ] [Real]Absence check using 24 positive place invariants in 29 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 20 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 11 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 32 ms returned sat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive and 34 generalized place invariants in 19 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 15 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 71 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 17 ms returned unsat
[2020-06-03 01:58:32] [INFO ] [Real]Absence check using 24 positive place invariants in 52 ms returned unsat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive place invariants in 34 ms returned sat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive and 34 generalized place invariants in 26 ms returned unsat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive place invariants in 29 ms returned unsat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive place invariants in 31 ms returned sat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive and 34 generalized place invariants in 46 ms returned unsat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive place invariants in 33 ms returned sat
[2020-06-03 01:58:33] [INFO ] [Real]Absence check using 24 positive and 34 generalized place invariants in 46 ms returned unsat
Successfully simplified 15 atomic propositions for a total of 18 simplifications.
[2020-06-03 01:58:34] [INFO ] Initial state reduction rules for CTL removed 8 formulas.
[2020-06-03 01:58:34] [INFO ] Flatten gal took : 525 ms
FORMULA PolyORBLF-COL-S06J06T06-14 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-13 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-12 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-08 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-07 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-04 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-01 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-00 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2020-06-03 01:58:34] [INFO ] Applying decomposition
[2020-06-03 01:58:34] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
[2020-06-03 01:58:34] [INFO ] Flatten gal took : 303 ms
[2020-06-03 01:58:34] [INFO ] Decomposing Gal with order
[2020-06-03 01:58:35] [INFO ] Rewriting arrays to variables to allow decomposition.
[2020-06-03 01:58:35] [INFO ] Removed a total of 13647 redundant transitions.
[2020-06-03 01:58:35] [INFO ] Initial state reduction rules for CTL removed 2 formulas.
[2020-06-03 01:58:35] [INFO ] Flatten gal took : 693 ms
[2020-06-03 01:58:36] [INFO ] Fuse similar labels procedure discarded/fused a total of 60 labels/synchronizations in 142 ms.
[2020-06-03 01:58:36] [INFO ] Initial state reduction rules for CTL removed 2 formulas.
FORMULA PolyORBLF-COL-S06J06T06-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA PolyORBLF-COL-S06J06T06-03 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2020-06-03 01:58:36] [INFO ] Export to MCC properties in file /home/mcc/execution/LTLCardinality.sr.xml took 6 ms.
[2020-06-03 01:58:36] [INFO ] Export to PNML in file /home/mcc/execution/model.sr.pnml took 26 ms.
info: Time: 3600 - MCC
vrfy: Checking LTLCardinality @ PolyORBLF-COL-S06J06T06 @ 3570 seconds
check_solution: Variable C2 = -0.533766269684 is below its lower bound 0
check_solution: Variable C420 = -0.266504764557 is below its lower bound 0
check_solution: Variable C838 = -0.016514569521 is below its lower bound 0
check_solution: Variable C1256 = -0.49605345726 is below its lower bound 0
check_solution: Constraint R1 = 6.9506147261e-310 is above its equality of -10
check_solution: Constraint R10 = 2.95381814224e-311 is above its equality of -1
check_solution: Constraint R57 = 8.61530291305e-311 is above its equality of -9
check_solution: Constraint R133 = 8.08904795674e-311 is above its equality of -1
check_solution: Constraint R192 = 8.44766524433e-311 is above its equality of -1
check_solution: Constraint R220 = 7.80470052064e-311 is above its equality of -1

Seriously low accuracy found ||*|| = 10 (rel. error 1)

FORMULA PolyORBLF-COL-S06J06T06-05 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA PolyORBLF-COL-S06J06T06-10 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA PolyORBLF-COL-S06J06T06-06 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA PolyORBLF-COL-S06J06T06-11 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT

FORMULA PolyORBLF-COL-S06J06T06-02 FALSE TECHNIQUES COLLATERAL_PROCESSING EXPLICIT TOPOLOGICAL STATE_COMPRESSION STUBBORN_SETS USE_NUPN UNFOLDING_TO_PT
TIME LIMIT: Killed by timeout after 3600 seconds
MemTotal: 16427456 kB
MemFree: 15317372 kB
After kill :
MemTotal: 16427456 kB
MemFree: 16132684 kB

--------------------
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="PolyORBLF-COL-S06J06T06"
export BK_EXAMINATION="LTLCardinality"
export BK_TOOL="itslola"
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-4028"
echo " Executing tool itslola"
echo " Input is PolyORBLF-COL-S06J06T06, 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 r176-tajo-158987871800393"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/PolyORBLF-COL-S06J06T06.tgz
mv PolyORBLF-COL-S06J06T06 execution
cd execution
if [ "LTLCardinality" = "ReachabilityDeadlock" ] || [ "LTLCardinality" = "UpperBounds" ] || [ "LTLCardinality" = "QuasiLiveness" ] || [ "LTLCardinality" = "StableMarking" ] || [ "LTLCardinality" = "Liveness" ] || [ "LTLCardinality" = "OneSafe" ] || [ "LTLCardinality" = "StateSpace" ]; 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
elif [ "LTLCardinality" = "ReachabilityDeadlock" ] || [ "LTLCardinality" = "QuasiLiveness" ] || [ "LTLCardinality" = "StableMarking" ] || [ "LTLCardinality" = "Liveness" ] || [ "LTLCardinality" = "OneSafe" ] ; then
echo "FORMULA_NAME LTLCardinality"
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 ;