Execution Chart

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

Trace from the execution

Waiting for the VM to be ready (probing ssh)
......
=====================================================================
Generated by BenchKit 2-3254
Executing tool marcie
Input is S_ParamProductionCell-PT-0, examination is CTLCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 1
Run identifier is r111-blw7-149441637100309
=====================================================================

--------------------
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 ParamProductionCell-PT-0-CTLCardinality-0
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-1
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-10
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-11
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-12
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-13
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-14
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-15
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-2
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-3
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-4
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-5
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-6
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-7
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-8
FORMULA_NAME ParamProductionCell-PT-0-CTLCardinality-9

=== Now, execution of the tool begins

BK_START 1494786441038

timeout --kill-after=10s --signal=SIGINT 1m for testing only

Marcie rev. 8852M (built: crohr on 2017-05-03)
A model checker for Generalized Stochastic Petri nets

authors: Alex Tovchigrechko (IDD package and CTL model checking)

Martin Schwarick (Symbolic numerical analysis and CSL model checking)

Christian Rohr (Simulative and approximative numerical model checking)

marcie@informatik.tu-cottbus.de

called as: marcie --net-file=model.pnml --mcc-file=CTLCardinality.xml --memory=6

parse successfull
net created successfully

Net: ParamProductionCell_PT_0
(NrP: 198 NrTr: 176 NrArc: 730)

parse formulas
formulas created successfully
place and transition orderings generation:0m 0.005sec

net check time: 0m 0.000sec

init dd package: 0m 1.148sec


RS generation: 0m 0.472sec


-> reachability set: #nodes 1272 (1.3e+03) #states 2,776,936 (6)



starting MCC model checker
--------------------------

checking: ~ [AG [AF [1<=forge_run]]]
normalized: E [true U EG [~ [1<=forge_run]]]

abstracting: (1<=forge_run)
states: 234,272 (5)
....................................................................................................................................................................................................................................................................................
EG iterations: 276
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-10 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 3.885sec

checking: AF [AF [2<=A1L_out]]
normalized: ~ [EG [EG [~ [2<=A1L_out]]]]

abstracting: (2<=A1L_out)
states: 0

EG iterations: 0

EG iterations: 0
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-15 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.000sec

checking: AF [[AX [2<=arm1_retract_ext] & AX [1<=forge_rs]]]
normalized: ~ [EG [~ [[~ [EX [~ [1<=forge_rs]]] & ~ [EX [~ [2<=arm1_retract_ext]]]]]]]

abstracting: (2<=arm1_retract_ext)
states: 0
.abstracting: (1<=forge_rs)
states: 117,136 (5)
.
EG iterations: 0
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-7 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.032sec

checking: AG [A2U_rotated<=A2U_ext_rs]
normalized: ~ [E [true U ~ [A2U_rotated<=A2U_ext_rs]]]

abstracting: (A2U_rotated<=A2U_ext_rs)
states: 2,747,648 (6)
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-14 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.353sec

checking: [AG [EF [1<=A1U_rot3_in]] & [~ [EX [1<=table_upward]] & ~ [2<=FB_trans_run]]]
normalized: [[~ [2<=FB_trans_run] & ~ [EX [1<=table_upward]]] & ~ [E [true U ~ [E [true U 1<=A1U_rot3_in]]]]]

abstracting: (1<=A1U_rot3_in)
states: 6,596 (3)
abstracting: (1<=table_upward)
states: 634,944 (5)
.abstracting: (2<=FB_trans_run)
states: 0
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-0 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.279sec

checking: [EF [AX [table_bottom_pos<=press_down]] & AF [~ [~ [3<=arm1_store_free]]]]
normalized: [~ [EG [~ [3<=arm1_store_free]]] & E [true U ~ [EX [~ [table_bottom_pos<=press_down]]]]]

abstracting: (table_bottom_pos<=press_down)
states: 1,547,760 (6)
.abstracting: (3<=arm1_store_free)
states: 0

EG iterations: 0
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-2 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.363sec

checking: ~ [A [~ [3<=TU_in] U [1<=TL_rot_run & 2<=ch_TA1_full]]]
normalized: ~ [[~ [EG [~ [[1<=TL_rot_run & 2<=ch_TA1_full]]]] & ~ [E [~ [[1<=TL_rot_run & 2<=ch_TA1_full]] U [~ [[1<=TL_rot_run & 2<=ch_TA1_full]] & 3<=TU_in]]]]]

abstracting: (3<=TU_in)
states: 0
abstracting: (2<=ch_TA1_full)
states: 0
abstracting: (1<=TL_rot_run)
states: 211,648 (5)
abstracting: (2<=ch_TA1_full)
states: 0
abstracting: (1<=TL_rot_run)
states: 211,648 (5)
abstracting: (2<=ch_TA1_full)
states: 0
abstracting: (1<=TL_rot_run)
states: 211,648 (5)

EG iterations: 0
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-3 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.001sec

checking: AX [EF [[c_p2<=press_at_middle_pos & 3<=arm2_having_swivel_1]]]
normalized: ~ [EX [~ [E [true U [c_p2<=press_at_middle_pos & 3<=arm2_having_swivel_1]]]]]

abstracting: (3<=arm2_having_swivel_1)
states: 0
abstracting: (c_p2<=press_at_middle_pos)
states: 1,971,488 (6)
.-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-11 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.003sec

checking: ~ [EG [[A1U_rot3_run<=A2U_ext_rs & ~ [1<=arm2_release_ext]]]]
normalized: ~ [EG [[~ [1<=arm2_release_ext] & A1U_rot3_run<=A2U_ext_rs]]]

abstracting: (A1U_rot3_run<=A2U_ext_rs)
states: 2,763,744 (6)
abstracting: (1<=arm2_release_ext)
states: 146,440 (5)
............................................................................................................................................................................................................
after gc: zbdd nodes used:17119, unused:18732881............................................................................................................
EG iterations: 312
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-13 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 5.386sec

checking: E [EF [1<=A2U_rot1_in] U ~ [[A1U_rot3_run<=arm2_stop | 1<=PU_lower_rs]]]
normalized: E [E [true U 1<=A2U_rot1_in] U ~ [[A1U_rot3_run<=arm2_stop | 1<=PU_lower_rs]]]

abstracting: (1<=PU_lower_rs)
states: 117,136 (5)
abstracting: (A1U_rot3_run<=arm2_stop)
states: 2,776,936 (6)
abstracting: (1<=A2U_rot1_in)
states: 14,744 (4)
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-1 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.311sec

checking: [A [3<=FB_out U [2<=A2U_in | 1<=A1L_ret_run]] | ~ [~ [EG [arm2_waiting_for_swivel_2<=table_unload_angle]]]]
normalized: [EG [arm2_waiting_for_swivel_2<=table_unload_angle] | [~ [EG [~ [[2<=A2U_in | 1<=A1L_ret_run]]]] & ~ [E [~ [[2<=A2U_in | 1<=A1L_ret_run]] U [~ [3<=FB_out] & ~ [[2<=A2U_in | 1<=A1L_ret_run]]]]]]]

abstracting: (1<=A1L_ret_run)
states: 21,280 (4)
abstracting: (2<=A2U_in)
states: 0
abstracting: (3<=FB_out)
states: 0
abstracting: (1<=A1L_ret_run)
states: 21,280 (4)
abstracting: (2<=A2U_in)
states: 0
abstracting: (1<=A1L_ret_run)
states: 21,280 (4)
abstracting: (2<=A2U_in)
states: 0
...............................................................................................................................................................................................................................................................
EG iterations: 255
abstracting: (arm2_waiting_for_swivel_2<=table_unload_angle)
states: 2,737,080 (6)
.
EG iterations: 1
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-6 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 3.885sec

checking: ~ [[[[A1L_ret_run<=A2U_rotated | 3<=TL_lower_rs] & [1<=ch_A1P_full | [2<=TL_out & 2<=arm1_pick_up_angle]]] | ~ [EF [arm2_retract_ext<=A1U_rot2_run]]]]
normalized: ~ [[[[[2<=TL_out & 2<=arm1_pick_up_angle] | 1<=ch_A1P_full] & [A1L_ret_run<=A2U_rotated | 3<=TL_lower_rs]] | ~ [E [true U arm2_retract_ext<=A1U_rot2_run]]]]

abstracting: (arm2_retract_ext<=A1U_rot2_run)
states: 228,504 (5)
abstracting: (3<=TL_lower_rs)
states: 0
abstracting: (A1L_ret_run<=A2U_rotated)
states: 2,755,656 (6)
abstracting: (1<=ch_A1P_full)
states: 117,136 (5)
abstracting: (2<=arm1_pick_up_angle)
states: 0
abstracting: (2<=TL_out)
states: 0
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-9 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.367sec

checking: [~ [EF [[2<=A1L_rot2_in & 3<=A2L_rot2_rs]]] & AF [[[table_upward<=arm1_release_ext & press_ready_for_unloading<=robot_left] | [table_bottom_pos<=press_ready_for_unloading & ch_DC_free<=A1U_extendet]]]]
normalized: [~ [EG [~ [[[table_upward<=arm1_release_ext & press_ready_for_unloading<=robot_left] | [table_bottom_pos<=press_ready_for_unloading & ch_DC_free<=A1U_extendet]]]]] & ~ [E [true U [2<=A1L_rot2_in & 3<=A2L_rot2_rs]]]]

abstracting: (3<=A2L_rot2_rs)
states: 0
abstracting: (2<=A1L_rot2_in)
states: 0
abstracting: (ch_DC_free<=A1U_extendet)
states: 1,980,776 (6)
abstracting: (table_bottom_pos<=press_ready_for_unloading)
states: 1,658,000 (6)
abstracting: (press_ready_for_unloading<=robot_left)
states: 2,314,416 (6)
abstracting: (table_upward<=arm1_release_ext)
states: 2,159,272 (6)
............................................................................................................................................................
EG iterations: 156
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-4 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 2.921sec

checking: E [[[3<=A2L_rot1_in | forge_run<=feed_belt_empty] | [FB_trans_run<=A1L_ext_run | 2<=table_ready_for_loading]] U [~ [A1U_out<=A1U_extendet] | ch_A2D_free<=A2L_ext_run]]
normalized: E [[[FB_trans_run<=A1L_ext_run | 2<=table_ready_for_loading] | [3<=A2L_rot1_in | forge_run<=feed_belt_empty]] U [~ [A1U_out<=A1U_extendet] | ch_A2D_free<=A2L_ext_run]]

abstracting: (ch_A2D_free<=A2L_ext_run)
states: 2,518,408 (6)
abstracting: (A1U_out<=A1U_extendet)
states: 2,762,968 (6)
abstracting: (forge_run<=feed_belt_empty)
states: 2,596,336 (6)
abstracting: (3<=A2L_rot1_in)
states: 0
abstracting: (2<=table_ready_for_loading)
states: 0
abstracting: (FB_trans_run<=A1L_ext_run)
states: 2,724,024 (6)
-> the formula is TRUE

FORMULA ParamProductionCell-PT-0-CTLCardinality-5 TRUE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.394sec

checking: AG [[[A2L_rot3_in<=deposit_belt_empty & [3<=press_up & A1_extended<=table_ready_for_unloading]] | [[A2L_rot3_rs<=A1L_rot3_run | 2<=arm2_magnet_off] | [1<=A1U_rot3_in & 3<=DB_out]]]]
normalized: ~ [E [true U ~ [[[[A2L_rot3_rs<=A1L_rot3_run | 2<=arm2_magnet_off] | [1<=A1U_rot3_in & 3<=DB_out]] | [[3<=press_up & A1_extended<=table_ready_for_unloading] & A2L_rot3_in<=deposit_belt_empty]]]]]

abstracting: (A2L_rot3_in<=deposit_belt_empty)
states: 2,765,056 (6)
abstracting: (A1_extended<=table_ready_for_unloading)
states: 2,776,936 (6)
abstracting: (3<=press_up)
states: 0
abstracting: (3<=DB_out)
states: 0
abstracting: (1<=A1U_rot3_in)
states: 6,596 (3)
abstracting: (2<=arm2_magnet_off)
states: 0
abstracting: (A2L_rot3_rs<=A1L_rot3_run)
states: 2,763,472 (6)
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-12 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.395sec

checking: [[[[[3<=A1L_rot1_run & 3<=deposit_belt_idle] & ~ [3<=A1L_out]] | [~ [2<=arm1_pick_up_angle] | [A1U_ret_run<=ch_PA2_free | 3<=TL_lower_rs]]] | E [1<=A1L_rot2_in U 2<=p_p1]] & E [~ [2<=A2L_rotated] U [3<=press_stop | 2<=A2U_rot3_in]]]
normalized: [[[[[3<=A1L_rot1_run & 3<=deposit_belt_idle] & ~ [3<=A1L_out]] | [[A1U_ret_run<=ch_PA2_free | 3<=TL_lower_rs] | ~ [2<=arm1_pick_up_angle]]] | E [1<=A1L_rot2_in U 2<=p_p1]] & E [~ [2<=A2L_rotated] U [3<=press_stop | 2<=A2U_rot3_in]]]

abstracting: (2<=A2U_rot3_in)
states: 0
abstracting: (3<=press_stop)
states: 0
abstracting: (2<=A2L_rotated)
states: 0
abstracting: (2<=p_p1)
states: 0
abstracting: (1<=A1L_rot2_in)
states: 2,128 (3)
abstracting: (2<=arm1_pick_up_angle)
states: 0
abstracting: (3<=TL_lower_rs)
states: 0
abstracting: (A1U_ret_run<=ch_PA2_free)
states: 2,749,000 (6)
abstracting: (3<=A1L_out)
states: 0
abstracting: (3<=deposit_belt_idle)
states: 0
abstracting: (3<=A1L_rot1_run)
states: 0
-> the formula is FALSE

FORMULA ParamProductionCell-PT-0-CTLCardinality-8 FALSE TECHNIQUES SEQUENTIAL_PROCESSING DECISION_DIAGRAMS UNFOLDING_TO_PT

MC time: 0m 0.004sec

totally nodes used: 17643169(1.8e+07)
number of garbage collections: 1
fire ops cache: hits/miss/sum: 11803171 27333305 39136476
used/not used/entry size/cache size: 11507800 55601064 16 1024MB
basic ops cache: hits/miss/sum: 5833774 16851123 22684897
used/not used/entry size/cache size: 10829455 5947761 12 192MB
unary ops cache: hits/miss/sum: 0 496 496
used/not used/entry size/cache size: 0 8388608 8 64MB
abstract ops cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 8388608 12 96MB
state nr cache: hits/miss/sum: 4278 11083 15361
used/not used/entry size/cache size: 7113 2090039 32 64MB
max state cache: hits/miss/sum: 0 0 0
used/not used/entry size/cache size: 0 8388608 32 256MB
uniqueHash elements/entry size/size: 67108864 4 256MB
0 59299486
1 7351466
2 440417
3 17005
4 477
5 13
6 0
7 0
8 0
9 0
>= 10 0

Total processing time: 0m21.471sec


BK_STOP 1494786462541

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

check for maximal unmarked siphon
ok
check for constant places
ok
check if there are places and transitions
ok
check if there are transitions without pre-places
ok
check if at least one transition is enabled in m0
ok
check if there are transitions that can never fire
ok


initing FirstDep: 0m 0.000sec


iterations count:19315 (109), effective:1275 (7)

initing FirstDep: 0m 0.000sec


iterations count:4502 (25), effective:303 (1)

iterations count:5463 (31), effective:364 (2)

iterations count:3804 (21), effective:266 (1)

iterations count:5295 (30), effective:337 (1)

iterations count:176 (1), effective:0 (0)

iterations count:4448 (25), effective:292 (1)

iterations count:2739 (15), effective:170 (0)

iterations count:5530 (31), effective:364 (2)

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="S_ParamProductionCell-PT-0"
export BK_EXAMINATION="CTLCardinality"
export BK_TOOL="marcie"
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

tar xzf /home/mcc/BenchKit/INPUTS/S_ParamProductionCell-PT-0.tgz
mv S_ParamProductionCell-PT-0 execution

# this is for BenchKit: explicit launching of the test

cd execution
echo "====================================================================="
echo " Generated by BenchKit 2-3254"
echo " Executing tool marcie"
echo " Input is S_ParamProductionCell-PT-0, examination is CTLCardinality"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 1"
echo " Run identifier is r111-blw7-149441637100309"
echo "====================================================================="
echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "CTLCardinality" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "CTLCardinality" != "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 "CTLCardinality.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property CTLCardinality.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "CTLCardinality.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 '' CTLCardinality.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 ;