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 '
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 ;