fond
Model Checking Contest @ Petri Nets 2015
Bruxelles, Belgium, June 23, 2015
Execution of r159st-ebro-143319436500568
Last Updated
August 19, 2015

About the Execution of ITS-Tools for S_LamportFastMutEx-COL-4

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
687.550 19078.00 59051.00 206.60 ???FT???T?F???F? normal

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-2265
Executing tool itstools
Input is S_LamportFastMutEx-COL-4, examination is ReachabilityCardinality
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r159st-ebro-143319436500568
=====================================================================


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

=== Now, execution of the tool begins

BK_START 1433272984854

FORMULA LamportFastMutEx-COL-4-ReachabilityCardinality-12 TRUE TECHNIQUES TOPOLOGICAL
FORMULA LamportFastMutEx-COL-4-ReachabilityCardinality-11 FALSE TECHNIQUES TOPOLOGICAL
FORMULA LamportFastMutEx-COL-4-ReachabilityCardinality-8 FALSE TECHNIQUES TOPOLOGICAL
FORMULA LamportFastMutEx-COL-4-ReachabilityCardinality-4 FALSE TECHNIQUES TOPOLOGICAL
FORMULA LamportFastMutEx-COL-4-ReachabilityCardinality-2 TRUE TECHNIQUES TOPOLOGICAL
work folder: /home/mcc/execution
unsat
unsat
unsat
unsat
unsat
unsat
unsat
unsat
unsat
unsat
unsat
work folder: /home/mcc/execution
work folder: /home/mcc/execution
work folder: /home/mcc/execution
work folder: /home/mcc/execution

BK_STOP 1433273003932

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

Java HotSpot(TM) 64-Bit Server VM warning: ignoring option MaxPermSize=512m; support was removed in 8.0
Jun 02, 2015 7:23:08 PM fr.lip6.move.gal.application.Application transformPNML
INFO: Parsing pnml file : /home/mcc/execution/model.pnml
Jun 02, 2015 7:23:08 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Load time of PNML (colored model parsed with PNMLFW) : 1943 ms
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Transformed 18 places.
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: read order :VarOrder [vars=[P_start_1[0], P_start_1[1], P_start_1[2], P_start_1[3], P_start_1[4], x[0], x[1], x[2], x[3], x[4], y[0], y[1], y[2], y[3], y[4], b[0], b[1], b[2], b[3], b[4], b[5], b[6], b[7], b[8], b[9], P_setx_3[0], P_setx_3[1], P_setx_3[2], P_setx_3[3], P_setx_3[4], P_setbi_5[0], P_setbi_5[1], P_setbi_5[2], P_setbi_5[3], P_setbi_5[4], P_ify0_4[0], P_ify0_4[1], P_ify0_4[2], P_ify0_4[3], P_ify0_4[4], P_sety_9[0], P_sety_9[1], P_sety_9[2], P_sety_9[3], P_sety_9[4], P_ifxi_10[0], P_ifxi_10[1], P_ifxi_10[2], P_ifxi_10[3], P_ifxi_10[4], P_setbi_11[0], P_setbi_11[1], P_setbi_11[2], P_setbi_11[3], P_setbi_11[4], P_fordo_12[0], P_fordo_12[1], P_fordo_12[2], P_fordo_12[3], P_fordo_12[4], wait[0], wait[1], wait[2], wait[3], wait[4], wait[5], wait[6], wait[7], wait[8], wait[9], wait[10], wait[11], wait[12], wait[13], wait[14], wait[15], wait[16], wait[17], wait[18], wait[19], wait[20], wait[21], wait[22], wait[23], wait[24], P_await_13[0], P_await_13[1], P_await_13[2], P_await_13[3], P_await_13[4], done[0], done[1], done[2], done[3], done[4], done[5], done[6], done[7], done[8], done[9], done[10], done[11], done[12], done[13], done[14], done[15], done[16], done[17], done[18], done[19], done[20], done[21], done[22], done[23], done[24], P_ifyi_15[0], P_ifyi_15[1], P_ifyi_15[2], P_ifyi_15[3], P_ifyi_15[4], P_awaity[0], P_awaity[1], P_awaity[2], P_awaity[3], P_awaity[4], P_CS_21[0], P_CS_21[1], P_CS_21[2], P_CS_21[3], P_CS_21[4], P_setbi_24[0], P_setbi_24[1], P_setbi_24[2], P_setbi_24[3], P_setbi_24[4]]]
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: sort/places :pid * pid->wait,done,
pid * bool->b,
pid->P-start_1,x,y,P-setx_3,P-setbi_5,P-ify0_4,P-sety_9,P-ifxi_10,P-setbi_11,P-fordo_12,P-await_13,P-ifyi_15,P-awaity,P-CS_21,P-setbi_24,

Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.pnml.togal.HLGALTransformer handlePage
INFO: Transformed 17 transitions.
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.pnml.togal.PnmlToGalTransformer transform
INFO: Computed order based on color domains : CompositeGalOrder [children=[VarOrder [vars=[wait[0], done[0]]], VarOrder [vars=[wait[1], done[1]]], VarOrder [vars=[wait[2], done[2]]], VarOrder [vars=[wait[3], done[3]]], VarOrder [vars=[wait[4], done[4]]], VarOrder [vars=[wait[5], done[5]]], VarOrder [vars=[wait[6], done[6]]], VarOrder [vars=[wait[7], done[7]]], VarOrder [vars=[wait[8], done[8]]], VarOrder [vars=[wait[9], done[9]]], VarOrder [vars=[wait[10], done[10]]], VarOrder [vars=[wait[11], done[11]]], VarOrder [vars=[wait[12], done[12]]], VarOrder [vars=[wait[13], done[13]]], VarOrder [vars=[wait[14], done[14]]], VarOrder [vars=[wait[15], done[15]]], VarOrder [vars=[wait[16], done[16]]], VarOrder [vars=[wait[17], done[17]]], VarOrder [vars=[wait[18], done[18]]], VarOrder [vars=[wait[19], done[19]]], VarOrder [vars=[wait[20], done[20]]], VarOrder [vars=[wait[21], done[21]]], VarOrder [vars=[wait[22], done[22]]], VarOrder [vars=[wait[23], done[23]]], VarOrder [vars=[wait[24], done[24]]], VarOrder [vars=[b[0]]], VarOrder [vars=[b[1]]], VarOrder [vars=[b[2]]], VarOrder [vars=[b[3]]], VarOrder [vars=[b[4]]], VarOrder [vars=[b[5]]], VarOrder [vars=[b[6]]], VarOrder [vars=[b[7]]], VarOrder [vars=[b[8]]], VarOrder [vars=[b[9]]], VarOrder [vars=[P_start_1[0], x[0], y[0], P_setx_3[0], P_setbi_5[0], P_ify0_4[0], P_sety_9[0], P_ifxi_10[0], P_setbi_11[0], P_fordo_12[0], P_await_13[0], P_ifyi_15[0], P_awaity[0], P_CS_21[0], P_setbi_24[0]]], VarOrder [vars=[P_start_1[1], x[1], y[1], P_setx_3[1], P_setbi_5[1], P_ify0_4[1], P_sety_9[1], P_ifxi_10[1], P_setbi_11[1], P_fordo_12[1], P_await_13[1], P_ifyi_15[1], P_awaity[1], P_CS_21[1], P_setbi_24[1]]], VarOrder [vars=[P_start_1[2], x[2], y[2], P_setx_3[2], P_setbi_5[2], P_ify0_4[2], P_sety_9[2], P_ifxi_10[2], P_setbi_11[2], P_fordo_12[2], P_await_13[2], P_ifyi_15[2], P_awaity[2], P_CS_21[2], P_setbi_24[2]]], VarOrder [vars=[P_start_1[3], x[3], y[3], P_setx_3[3], P_setbi_5[3], P_ify0_4[3], P_sety_9[3], P_ifxi_10[3], P_setbi_11[3], P_fordo_12[3], P_await_13[3], P_ifyi_15[3], P_awaity[3], P_CS_21[3], P_setbi_24[3]]], VarOrder [vars=[P_start_1[4], x[4], y[4], P_setx_3[4], P_setbi_5[4], P_ify0_4[4], P_sety_9[4], P_ifxi_10[4], P_setbi_11[4], P_fordo_12[4], P_await_13[4], P_ifyi_15[4], P_awaity[4], P_CS_21[4], P_setbi_24[4]]]]]
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.instantiate.Instantiator separateParameters
INFO: Fused parameters : $i and $y
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.instantiate.Instantiator separateParameters
INFO: Fused parameters : $i and $x
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.instantiate.Instantiator fuseIsomorphicEffects
INFO: Removed a total of 1 redundant transitions.
Jun 02, 2015 7:23:10 PM fr.lip6.move.gal.instantiate.Instantiator instantiateParameters
INFO: On-the-fly reduction of False transitions avoided exploring 11 instantiations of transitions. Total transitions built is 243
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property LamportFastMutEx-COL-4-ReachabilityCardinality-2 is trivially true : it is verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Invariant property LamportFastMutEx-COL-4-ReachabilityCardinality-4 is trivially false : it is not verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Invariant property LamportFastMutEx-COL-4-ReachabilityCardinality-8 is trivially false : it is not verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Invariant property LamportFastMutEx-COL-4-ReachabilityCardinality-11 is trivially false : it is not verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property LamportFastMutEx-COL-4-ReachabilityCardinality-12 is trivially true : it is verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property LamportFastMutEx-COL-4-ReachabilityCardinality-2 is trivially true : it is verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Invariant property LamportFastMutEx-COL-4-ReachabilityCardinality-4 is trivially false : it is not verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Invariant property LamportFastMutEx-COL-4-ReachabilityCardinality-8 is trivially false : it is not verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Invariant property LamportFastMutEx-COL-4-ReachabilityCardinality-11 is trivially false : it is not verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.PropertySimplifier rewriteWithInitialState
INFO: Reachable property LamportFastMutEx-COL-4-ReachabilityCardinality-12 is trivially true : it is verified in initial state.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 332 ms
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.application.Application applyOrder
INFO: Applying decomposition
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Decomposing Gal with order
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 347 ms
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 426 ms
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 478 ms
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder decomposeWithOrder
INFO: Partition obtained :[wait[0], done[0], ],[wait[1], done[1], ],[wait[2], done[2], ],[wait[3], done[3], ],[wait[4], done[4], ],[wait[5], done[5], ],[wait[6], done[6], ],[wait[7], done[7], ],[wait[8], done[8], ],[wait[9], done[9], ],[wait[10], done[10], ],[wait[11], done[11], ],[wait[12], done[12], ],[wait[13], done[13], ],[wait[14], done[14], ],[wait[15], done[15], ],[wait[16], done[16], ],[wait[17], done[17], ],[wait[18], done[18], ],[wait[19], done[19], ],[wait[20], done[20], ],[wait[21], done[21], ],[wait[22], done[22], ],[wait[23], done[23], ],[wait[24], done[24], ],[b[0], ],[b[1], ],[b[2], ],[b[3], ],[b[4], ],[b[5], ],[b[6], ],[b[7], ],[b[8], ],[b[9], ],[P_start_1[0], x[0], y[0], P_setx_3[0], P_setbi_5[0], P_ify0_4[0], P_sety_9[0], P_ifxi_10[0], P_setbi_11[0], P_fordo_12[0], P_await_13[0], P_ifyi_15[0], P_awaity[0], P_CS_21[0], P_setbi_24[0], ],[P_start_1[1], x[1], y[1], P_setx_3[1], P_setbi_5[1], P_ify0_4[1], P_sety_9[1], P_ifxi_10[1], P_setbi_11[1], P_fordo_12[1], P_await_13[1], P_ifyi_15[1], P_awaity[1], P_CS_21[1], P_setbi_24[1], ],[P_start_1[2], x[2], y[2], P_setx_3[2], P_setbi_5[2], P_ify0_4[2], P_sety_9[2], P_ifxi_10[2], P_setbi_11[2], P_fordo_12[2], P_await_13[2], P_ifyi_15[2], P_awaity[2], P_CS_21[2], P_setbi_24[2], ],[P_start_1[3], x[3], y[3], P_setx_3[3], P_setbi_5[3], P_ify0_4[3], P_sety_9[3], P_ifxi_10[3], P_setbi_11[3], P_fordo_12[3], P_await_13[3], P_ifyi_15[3], P_awaity[3], P_CS_21[3], P_setbi_24[3], ],[P_start_1[4], x[4], y[4], P_setx_3[4], P_setbi_5[4], P_ify0_4[4], P_sety_9[4], P_ifxi_10[4], P_setbi_11[4], P_fordo_12[4], P_await_13[4], P_ifyi_15[4], P_awaity[4], P_CS_21[4], P_setbi_24[4], ],

Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_start_1 to variables to allow decomposition.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array x to variables to allow decomposition.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array y to variables to allow decomposition.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array b to variables to allow decomposition.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_setx_3 to variables to allow decomposition.
Jun 02, 2015 7:23:11 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_setbi_5 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_ify0_4 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_sety_9 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_ifxi_10 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_setbi_11 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_fordo_12 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array wait to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_await_13 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array done to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_ifyi_15 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_awaity to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_CS_21 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.CompositeBuilder rewriteArraysToAllowPartition
INFO: Rewriting array P_setbi_24 to variables to allow decomposition.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.cegar.support.SupportManager computeSupport
INFO: For property LamportFastMutEx-COL-4-ReachabilityCardinality-0:[invariant] : ((((((((((((((((((((((((((wait_0+wait_1)+wait_2)+wait_3)+wait_4)+wait_5)+wait_6)+wait_7)+wait_8)+wait_9)+wait_10)+wait_11)+wait_12)+wait_13)+wait_14)+wait_15)+wait_16)+wait_17)+wait_18)+wait_19)+wait_20)+wait_21)+wait_22)+wait_23)+wait_24)<=((((P_setbi_5_0+P_setbi_5_1)+P_setbi_5_2)+P_setbi_5_3)+P_setbi_5_4))||(!((((((P_setbi_11_0+P_setbi_11_1)+P_setbi_11_2)+P_setbi_11_3)+P_setbi_11_4)<=((((P_await_13_0+P_await_13_1)+P_await_13_2)+P_await_13_3)+P_await_13_4))||(((((P_ifxi_10_0+P_ifxi_10_1)+P_ifxi_10_2)+P_ifxi_10_3)+P_ifxi_10_4)>=3)))) found Support [wait_0, wait_1, wait_2, wait_3, wait_4, wait_5, wait_6, wait_7, wait_8, wait_9, wait_10, wait_11, wait_12, wait_13, wait_14, wait_15, wait_16, wait_17, wait_18, wait_19, wait_20, wait_21, wait_22, wait_23, wait_24, P_setbi_5_0, P_setbi_5_1, P_setbi_5_2, P_setbi_5_3, P_setbi_5_4, P_setbi_11_0, P_setbi_11_1, P_setbi_11_2, P_setbi_11_3, P_setbi_11_4, P_await_13_0, P_await_13_1, P_await_13_2, P_await_13_3, P_await_13_4, P_ifxi_10_0, P_ifxi_10_1, P_ifxi_10_2, P_ifxi_10_3, P_ifxi_10_4]
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.cegar.support.SupportManager computeSupport
INFO: Computing abstraction support, depth 0, found support 45
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 90 / 135 variable(s)
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.Instantiator fuseIsomorphicEffects
INFO: Removed a total of 149 redundant transitions.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(refined 0 times)...
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:12 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/ReachabilityCardinality.gal : 31 ms
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(UNSAT) depth K=1 took 1153 ms
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 75 uncalled transitions.
Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 5 fixed domain variables (out of 45 variables)

Jun 02, 2015 7:23:12 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 42 ms
Jun 02, 2015 7:23:12 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:12 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: No display to refresh.
Jun 02, 2015 7:23:12 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: No display to refresh.
Jun 02, 2015 7:23:13 PM fr.lip6.move.serialization.SerializationUtil serializePropertiesForITSTools
INFO: Time to serialize properties into /home/mcc/execution/ReachabilityCardinality.prop : 20 ms
Jun 02, 2015 7:23:13 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(UNSAT) depth K=1 took 481 ms
Jun 02, 2015 7:23:13 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-3(UNSAT) depth K=1 took 476 ms
Jun 02, 2015 7:23:14 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-5(UNSAT) depth K=1 took 542 ms
Jun 02, 2015 7:23:14 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-6(UNSAT) depth K=1 took 489 ms
Jun 02, 2015 7:23:14 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 2153 ms
Jun 02, 2015 7:23:14 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_fordo_12_0]
Jun 02, 2015 7:23:14 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_fordo_12_0] on the original GAL...
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 59 ms
Jun 02, 2015 7:23:15 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 9 ms
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 560 ms
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_fordo_12_0 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_fordo_12_0 to refine the abstraction...
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 89 / 135 variable(s)
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(refined 1 times)...
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 75 uncalled transitions.
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 5 fixed domain variables (out of 46 variables)

Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 78 ms
Jun 02, 2015 7:23:15 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:15 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-7(UNSAT) depth K=1 took 890 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-9(UNSAT) depth K=1 took 467 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-10(UNSAT) depth K=1 took 472 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 1204 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_fordo_12_1]
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_fordo_12_1] on the original GAL...
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 72 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 6 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 154 ms
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_fordo_12_1 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_fordo_12_1 to refine the abstraction...
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 88 / 135 variable(s)
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(refined 2 times)...
Jun 02, 2015 7:23:16 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 75 uncalled transitions.
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 5 fixed domain variables (out of 47 variables)

Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 41 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-13(UNSAT) depth K=1 took 477 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 460 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_fordo_12_2]
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_fordo_12_2] on the original GAL...
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 64 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 11 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-14(UNSAT) depth K=1 took 464 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 168 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_fordo_12_2 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_fordo_12_2 to refine the abstraction...
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 87 / 135 variable(s)
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(refined 3 times)...
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 75 uncalled transitions.
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 5 fixed domain variables (out of 48 variables)

Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 29 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 188 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_fordo_12_3]
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_fordo_12_3] on the original GAL...
Jun 02, 2015 7:23:17 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 43 ms
Jun 02, 2015 7:23:17 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 127 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_fordo_12_3 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_fordo_12_3 to refine the abstraction...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 86 / 135 variable(s)
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(refined 4 times)...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 75 uncalled transitions.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 5 fixed domain variables (out of 49 variables)

Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 39 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 1 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.gal2smt.Gal2SMTFrontEnd checkProperties
INFO: SMT solution for property LamportFastMutEx-COL-4-ReachabilityCardinality-15(UNSAT) depth K=1 took 514 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 132 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_fordo_12_4]
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_fordo_12_4] on the original GAL...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 40 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 123 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_fordo_12_4 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_fordo_12_4 to refine the abstraction...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 85 / 135 variable(s)
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-0(refined 5 times)...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 75 uncalled transitions.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 5 fixed domain variables (out of 50 variables)

Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 68 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 1 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 155 ms
java.lang.NullPointerException
at fr.lip6.move.gal.cegar.checkers.CEGARChecker.check(CEGARChecker.java:48)
at fr.lip6.move.gal.cegar.frontend.CegarFrontEnd.processGal(CegarFrontEnd.java:24)
at fr.lip6.move.gal.application.Application$3.run(Application.java:354)
at java.lang.Thread.run(Thread.java:745)
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.application.Application$3 run
WARNING: Aborting CEGAR check of property LamportFastMutEx-COL-4-ReachabilityCardinality-0 due to an exception when running procedure.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.support.SupportManager computeSupport
INFO: For property LamportFastMutEx-COL-4-ReachabilityCardinality-1:[reachable] : ((((((P_ifyi_15_0+P_ifyi_15_1)+P_ifyi_15_2)+P_ifyi_15_3)+P_ifyi_15_4)>=2)&&(((((((P_ify0_4_0+P_ify0_4_1)+P_ify0_4_2)+P_ify0_4_3)+P_ify0_4_4)>=1)||(((((P_ify0_4_0+P_ify0_4_1)+P_ify0_4_2)+P_ify0_4_3)+P_ify0_4_4)>=2))||(!(((((P_ify0_4_0+P_ify0_4_1)+P_ify0_4_2)+P_ify0_4_3)+P_ify0_4_4)>=3)))) found Support [P_ifyi_15_0, P_ifyi_15_1, P_ifyi_15_2, P_ifyi_15_3, P_ifyi_15_4, P_ify0_4_0, P_ify0_4_1, P_ify0_4_2, P_ify0_4_3, P_ify0_4_4]
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.support.SupportManager computeSupport
INFO: Computing abstraction support, depth 0, found support 10
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 125 / 135 variable(s)
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(refined 0 times)...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 30 uncalled transitions.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 15 uncalled transitions.
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 16 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 1 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 364 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_forod_13_0, T_forod_13_0]
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_forod_13_0, T_forod_13_0] on the original GAL...
Jun 02, 2015 7:23:18 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 50 ms
Jun 02, 2015 7:23:18 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 125 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_forod_13_0 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_forod_13_0 to refine the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 120 / 135 variable(s)
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(refined 1 times)...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 35 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 15 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 11 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 1 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 119 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_forod_13_1, T_forod_13_1]
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_forod_13_1, T_forod_13_1] on the original GAL...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 34 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 3 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 114 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_forod_13_1 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_forod_13_1 to refine the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 115 / 135 variable(s)
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(refined 2 times)...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 40 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 15 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 13 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 1 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 81 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_forod_13_2, T_forod_13_2]
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_forod_13_2, T_forod_13_2] on the original GAL...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 41 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 3 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 113 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_forod_13_2 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_forod_13_2 to refine the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 110 / 135 variable(s)
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(refined 3 times)...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 45 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 15 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 15 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 86 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_forod_13_3, T_forod_13_3]
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_forod_13_3, T_forod_13_3] on the original GAL...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 36 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 109 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_forod_13_3 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_forod_13_3 to refine the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 105 / 135 variable(s)
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(refined 4 times)...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 50 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 15 uncalled transitions.
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 15 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 70 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Found trace: [T_forod_13_4, T_forod_13_4]
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -trace [T_forod_13_4, T_forod_13_4] on the original GAL...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 32 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 104 ms
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Transition T_forod_13_4 couldn't be replayed on the original GAL
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.SupportBasedAbstractor refine
INFO: Using failed transition T_forod_13_4 to refine the abstraction...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 100 / 135 variable(s)
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-1(refined 5 times)...
Jun 02, 2015 7:23:19 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 55 uncalled transitions.
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 15 uncalled transitions.
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 17 ms
Jun 02, 2015 7:23:20 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 2 ms
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.checkers.ITSLauncher run
INFO: Run of its-reach took 62 ms
java.lang.NullPointerException
at fr.lip6.move.gal.cegar.checkers.CEGARChecker.check(CEGARChecker.java:48)
at fr.lip6.move.gal.cegar.frontend.CegarFrontEnd.processGal(CegarFrontEnd.java:24)
at fr.lip6.move.gal.application.Application$3.run(Application.java:354)
at java.lang.Thread.run(Thread.java:745)
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.application.Application$3 run
WARNING: Aborting CEGAR check of property LamportFastMutEx-COL-4-ReachabilityCardinality-1 due to an exception when running procedure.
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.support.SupportManager computeSupport
INFO: For property LamportFastMutEx-COL-4-ReachabilityCardinality-3:[reachable] : (((!(((((P_start_1_0+P_start_1_1)+P_start_1_2)+P_start_1_3)+P_start_1_4)<=((((P_fordo_12_0+P_fordo_12_1)+P_fordo_12_2)+P_fordo_12_3)+P_fordo_12_4)))&&(!((((((((((b_0+b_1)+b_2)+b_3)+b_4)+b_5)+b_6)+b_7)+b_8)+b_9)>=3)))||((((((((((((b_0+b_1)+b_2)+b_3)+b_4)+b_5)+b_6)+b_7)+b_8)+b_9)>=2)&&(((((P_setbi_24_0+P_setbi_24_1)+P_setbi_24_2)+P_setbi_24_3)+P_setbi_24_4)>=3))&&((((((P_fordo_12_0+P_fordo_12_1)+P_fordo_12_2)+P_fordo_12_3)+P_fordo_12_4)<=((((P_await_13_0+P_await_13_1)+P_await_13_2)+P_await_13_3)+P_await_13_4))||(((((P_setx_3_0+P_setx_3_1)+P_setx_3_2)+P_setx_3_3)+P_setx_3_4)<=((((y_0+y_1)+y_2)+y_3)+y_4))))) found Support [P_start_1_0, P_start_1_1, P_start_1_2, P_start_1_3, P_start_1_4, P_fordo_12_0, P_fordo_12_1, P_fordo_12_2, P_fordo_12_3, P_fordo_12_4, b_0, b_1, b_2, b_3, b_4, b_5, b_6, b_7, b_8, b_9, P_setbi_24_0, P_setbi_24_1, P_setbi_24_2, P_setbi_24_3, P_setbi_24_4, P_await_13_0, P_await_13_1, P_await_13_2, P_await_13_3, P_await_13_4, P_setx_3_0, P_setx_3_1, P_setx_3_2, P_setx_3_3, P_setx_3_4, y_0, y_1, y_2, y_3, y_4]
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.support.SupportManager computeSupport
INFO: Computing abstraction support, depth 0, found support 40
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.abstractor.BoundComputer compute
INFO: Bounding GAL to K = 1
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.abstractor.VariablesAbstractor abstractUsingSupport
INFO: Abstracting GAL, removed 95 / 135 variable(s)
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Checking abstraction for property LamportFastMutEx-COL-4-ReachabilityCardinality-3(refined 0 times)...
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.cegar.checkers.CEGARChecker check
INFO: Running its-reach -reachable on the abstraction...
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 99 uncalled transitions.
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.Simplifier removeUncalledTransitions
INFO: Removed 45 uncalled transitions.
Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.DomainAnalyzer computeVariableDomains
INFO: Found a total of 15 fixed domain variables (out of 40 variables)

Jun 02, 2015 7:23:20 PM fr.lip6.move.gal.instantiate.GALRewriter flatten
INFO: Flatten gal took : 31 ms
Jun 02, 2015 7:23:20 PM fr.lip6.move.serialization.SerializationUtil systemToFile
INFO: Time to serialize gal into /home/mcc/execution/work/abstract.gal : 1 ms
java.lang.IllegalThreadStateException: process hasn't exited
at java.lang.UNIXProcess.exitValue(UNIXProcess.java:421)
at fr.lip6.move.gal.itstools.ProcessController.execute(ProcessController.java:125)
at fr.lip6.move.gal.cegar.checkers.ITSLauncher.run(ITSLauncher.java:99)
at fr.lip6.move.gal.cegar.checkers.ITSLauncher.run(ITSLauncher.java:56)
at fr.lip6.move.gal.cegar.checkers.ITSPropertyCheckerAdapter.check(ITSPropertyCheckerAdapter.java:72)
at fr.lip6.move.gal.cegar.checkers.CEGARChecker.check(CEGARChecker.java:46)
at fr.lip6.move.gal.cegar.frontend.CegarFrontEnd.processGal(CegarFrontEnd.java:24)
at fr.lip6.move.gal.application.Application$3.run(Application.java:354)
at java.lang.Thread.run(Thread.java:745)
Jun 02, 2015 7:23:23 PM fr.lip6.move.gal.application.Application$3 run
WARNING: Aborting CEGAR check of property LamportFastMutEx-COL-4-ReachabilityCardinality-3 due to an exception when running procedure.
java.lang.RuntimeException: ITS tools raised an exception when treating model property LamportFastMutEx-COL-4-ReachabilityCardinality-5
at fr.lip6.move.gal.cegar.checkers.ITSPropertyCheckerAdapter.check(ITSPropertyCheckerAdapter.java:75)
at fr.lip6.move.gal.cegar.checkers.CEGARChecker.check(CEGARChecker.java:46)
at fr.lip6.move.gal.cegar.frontend.CegarFrontEnd.processGal(CegarFrontEnd.java:24)
at fr.lip6.move.gal.application.Application$3.run(Application.java:354)
at java.lang.Thread.run(Thread.java:745)

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_LamportFastMutEx-COL-4"
export BK_EXAMINATION="ReachabilityCardinality"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/users/gast00/fkordon/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_LamportFastMutEx-COL-4.tgz
mv S_LamportFastMutEx-COL-4 execution

# this is for BenchKit: explicit launching of the test

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