fond
Model Checking Contest 2020
10th edition, Paris, France, June 23, 2020
Execution of r111-csrt-158961257300242
Last Updated
Jun 28, 2020

About the Execution of ITS-Tools for NeoElection-COL-5

Execution Summary
Max Memory
Used (MB)
Time wait (ms) CPU Usage (ms) I/O Wait (ms) Computed Result Execution
Status
0.000 3600000.00 0.00 0.00 ?FFT?T?TF?TFFFFF normal

Execution Chart

Sorry, for this execution, no execution chart could be reported.

Trace from the execution

Formatting '/local/x2003239/mcc2020-input.r111-csrt-158961257300242.qcow2', fmt=qcow2 size=4294967296 backing_file=/local/x2003239/mcc2020-input.qcow2 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
.........................................................................................................................................................................................................................................................
=====================================================================
Generated by BenchKit 2-4028
Executing tool itstools
Input is NeoElection-COL-5, examination is LTLFireability
Time confinement is 3600 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r111-csrt-158961257300242
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 272K
-rw-r--r-- 1 mcc users 4.3K Apr 30 13:04 CTLCardinality.txt
-rw-r--r-- 1 mcc users 22K Apr 30 13:04 CTLCardinality.xml
-rw-r--r-- 1 mcc users 3.0K Apr 30 13:04 CTLFireability.txt
-rw-r--r-- 1 mcc users 17K Apr 30 13:04 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.0K Apr 30 13:04 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 6.1K Apr 30 13:04 GenericPropertiesVerdict.xml
-rw-r--r-- 1 mcc users 3.7K Apr 30 13:04 LTLCardinality.txt
-rw-r--r-- 1 mcc users 21K Apr 30 13:04 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.6K Apr 30 13:04 LTLFireability.txt
-rw-r--r-- 1 mcc users 17K Apr 30 13:04 LTLFireability.xml
-rw-r--r-- 1 mcc users 3.4K Apr 30 13:04 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 14K Apr 30 13:04 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 3.3K Apr 30 13:04 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 16K Apr 30 13:04 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K Apr 30 13:04 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.8K Apr 30 13:04 UpperBounds.xml
-rw-r--r-- 1 mcc users 5 Apr 30 13:04 equiv_pt
-rw-r--r-- 1 mcc users 2 Apr 30 13:04 instance
-rw-r--r-- 1 mcc users 5 Apr 30 13:04 iscolored
-rw-r--r-- 1 mcc users 89K Apr 30 13:04 model.pnml

--------------------
content from stdout:

=== Data for post analysis generated by BenchKit (invocation template)

The expected result is a vector of booleans
BOOL_VECTOR

here is the order used to build the result vector(from text file)
FORMULA_NAME NeoElection-COL-5-00
FORMULA_NAME NeoElection-COL-5-01
FORMULA_NAME NeoElection-COL-5-02
FORMULA_NAME NeoElection-COL-5-03
FORMULA_NAME NeoElection-COL-5-04
FORMULA_NAME NeoElection-COL-5-05
FORMULA_NAME NeoElection-COL-5-06
FORMULA_NAME NeoElection-COL-5-07
FORMULA_NAME NeoElection-COL-5-08
FORMULA_NAME NeoElection-COL-5-09
FORMULA_NAME NeoElection-COL-5-10
FORMULA_NAME NeoElection-COL-5-11
FORMULA_NAME NeoElection-COL-5-12
FORMULA_NAME NeoElection-COL-5-13
FORMULA_NAME NeoElection-COL-5-14
FORMULA_NAME NeoElection-COL-5-15

=== Now, execution of the tool begins

BK_START 1589844870933

[2020-05-18 23:34:33] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, LTLFireability, -z3path, /home/mcc/BenchKit//z3/bin/z3, -yices2path, /home/mcc/BenchKit//yices/bin/yices, -its, -ltsminpath, /home/mcc/BenchKit//lts_install_dir/, -greatspnpath, /home/mcc/BenchKit//greatspn/, -order, META, -manyOrder, -smt, -timeout, 3600]
[2020-05-18 23:34:34] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2020-05-18 23:34:34] [INFO ] Detected file is not PT type :http://www.pnml.org/version-2009/grammar/symmetricnet
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
[2020-05-18 23:34:35] [INFO ] Load time of PNML (colored model parsed with PNMLFW) : 1306 ms
[2020-05-18 23:34:35] [INFO ] sort/places :
M * STAGE->P-stage,
M * POS->P-sendAnnPs__broadcasting,P-startNeg__broadcasting,
M * M * MT * M->P-network,P-poll__networl,
M * POS * M->P-masterList,
M * BOOL * M->P-masterState,
M * M * NEGSTEP->P-negotiation,
M->P-crashed,dead,P-electedPrimary,P-electedSecondary,P-electionFailed,P-electionInit,P-poll__handlingMessage,P-poll__pollEnd,P-poll__waitingMessage,P-polling,

[2020-05-18 23:34:35] [INFO ] Detected 4 constant HL places corresponding to 198 PT places.
[2020-05-18 23:34:35] [INFO ] Imported 18 HL places and 22 HL transitions for a total of 3090 PT places and 7716.0 transition bindings in 81 ms.
[2020-05-18 23:34:35] [INFO ] Computed order based on color domains.
[2020-05-18 23:34:35] [INFO ] Unfolded HLPN to a Petri net with 3090 places and 4426 transitions in 222 ms.
[2020-05-18 23:34:35] [INFO ] Unfolded HLPN properties in 2 ms.
Deduced a syphon composed of 2866 places in 18 ms
Reduce places removed 2886 places and 4190 transitions.
Parsed 16 properties from file /home/mcc/execution/LTLFireability.xml in 310 ms.
Working with output stream class java.io.PrintStream
Finished random walk after 119 steps, including 0 resets, run visited all 8 properties in 5 ms. (steps per millisecond=23 )
[2020-05-18 23:34:36] [INFO ] Found a total of 11 fixed domain variables (out of 204 variables) in GAL type petri
[2020-05-18 23:34:36] [INFO ] Found a total of 11 constant array cells/variables (out of 204 variables) in type petri
[2020-05-18 23:34:36] [INFO ] P_stage_15,P_stage_9,P_negotiation_44,P_negotiation_65,P_stage_3,P_negotiation_86,P_masterState_66,P_stage_12,P_stage_6,P_negotiation_23,P_negotiation_107,
[2020-05-18 23:34:36] [INFO ] Removed 11 constant variables :P_stage_15=1, P_stage_9=1, P_negotiation_44=1, P_negotiation_65=1, P_stage_3=1, P_negotiation_86=1, P_masterState_66=1, P_stage_12=1, P_stage_6=1, P_negotiation_23=1, P_negotiation_107=1
[2020-05-18 23:34:36] [INFO ] Simplified 8 expressions due to constant valuations.
[2020-05-18 23:34:36] [INFO ] Initial state reduction rules for CTL removed 11 formulas.
[2020-05-18 23:34:36] [INFO ] Flatten gal took : 92 ms
FORMULA NeoElection-COL-5-15 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-14 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-13 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-12 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-11 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-10 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-07 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-05 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-03 TRUE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-02 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
FORMULA NeoElection-COL-5-01 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
[2020-05-18 23:34:36] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
[2020-05-18 23:34:36] [INFO ] Flatten gal took : 34 ms
[2020-05-18 23:34:36] [INFO ] Initial state reduction rules for CTL removed 1 formulas.
FORMULA NeoElection-COL-5-08 FALSE TECHNIQUES TOPOLOGICAL INITIAL_STATE
Using solver Z3 to compute partial order matrices.
Built C files in :
/home/mcc/execution
[2020-05-18 23:34:36] [INFO ] Applying decomposition
[2020-05-18 23:34:36] [INFO ] Flatten gal took : 44 ms
Converted graph to binary with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/convert-linux64, -i, /tmp/graph8929032201977881968.txt, -o, /tmp/graph8929032201977881968.bin, -w, /tmp/graph8929032201977881968.weights], workingDir=null]
Built communities with : CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.louvain.binaries_1.0.0.202005100927/bin/louvain-linux64, /tmp/graph8929032201977881968.bin, -l, -1, -v, -w, /tmp/graph8929032201977881968.weights, -q, 0, -e, 0.001], workingDir=null]
[2020-05-18 23:34:36] [INFO ] Decomposing Gal with order
[2020-05-18 23:34:36] [INFO ] Input system was already deterministic with 236 transitions.
[2020-05-18 23:34:36] [INFO ] Rewriting arrays to variables to allow decomposition.
[2020-05-18 23:34:36] [INFO ] Removed a total of 19 redundant transitions.
[2020-05-18 23:34:36] [INFO ] Flatten gal took : 81 ms
[2020-05-18 23:34:36] [INFO ] Fuse similar labels procedure discarded/fused a total of 26 labels/synchronizations in 6 ms.
[2020-05-18 23:34:36] [INFO ] Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 7 ms
[2020-05-18 23:34:36] [INFO ] Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 4 LTL properties
Checking formula 0 : !((!(F(X(F(G("(((((i7.u9.P_poll__pollEnd_2>=1)||(u8.P_poll__pollEnd_3>=1))||(u10.P_poll__pollEnd_4>=1))||(i2.u11.P_poll__pollEnd_5>=1))||(i5.u7.P_poll__pollEnd_1>=1))")))))))
Formula 0 simplified : FXFG"(((((i7.u9.P_poll__pollEnd_2>=1)||(u8.P_poll__pollEnd_3>=1))||(u10.P_poll__pollEnd_4>=1))||(i2.u11.P_poll__pollEnd_5>=1))||(i5.u7.P_poll__pollEnd_1>=1))"
built 14 ordering constraints for composite.
built 14 ordering constraints for composite.
built 21 ordering constraints for composite.
built 20 ordering constraints for composite.
Presburger conditions satisfied. Using coverability to approximate state space in K-Induction.
Normalized transition count is 220 out of 236 initially.
// Phase 1: matrix 220 rows 193 cols
[2020-05-18 23:34:37] [INFO ] Computed 54 place invariants in 16 ms
inv : 4*P_electionInit_1 + P_negotiation_26 + P_negotiation_29 + P_negotiation_32 + P_negotiation_35 + P_network_294 + P_network_306 + P_network_330 + P_network_342 + P_network_366 + P_network_378 + P_network_402 + P_network_414 + P_network_468 + P_network_480 + P_network_684 + P_network_696 + P_network_900 + P_network_912 + P_network_1116 + P_network_1128 + 4*P_startNeg__broadcasting_5 + 3*P_startNeg__broadcasting_6 + 2*P_startNeg__broadcasting_7 + P_startNeg__broadcasting_8 = 4
inv : P_masterState_48 + P_masterState_54 = 1
inv : -P_electionInit_3 + P_negotiation_66 - P_startNeg__broadcasting_15 - P_startNeg__broadcasting_16 - P_startNeg__broadcasting_17 = 0
inv : -P_electionInit_4 + P_negotiation_81 - P_startNeg__broadcasting_20 - P_startNeg__broadcasting_21 - P_startNeg__broadcasting_22 = 0
inv : P_electionInit_4 + P_negotiation_76 + P_negotiation_77 + P_startNeg__broadcasting_20 = 1
inv : P_electionInit_1 + P_poll__handlingMessage_1 + P_poll__pollEnd_1 + P_polling_1 + P_startNeg__broadcasting_5 + P_startNeg__broadcasting_6 + P_startNeg__broadcasting_7 + P_startNeg__broadcasting_8 + P_startNeg__broadcasting_9 = 1
inv : P_electionInit_4 + P_negotiation_79 + P_negotiation_80 + P_startNeg__broadcasting_20 + P_startNeg__broadcasting_21 = 1
inv : -P_electionInit_5 + P_negotiation_102 - P_startNeg__broadcasting_25 - P_startNeg__broadcasting_26 - P_startNeg__broadcasting_27 - P_startNeg__broadcasting_28 = 0
inv : P_electionInit_1 + P_negotiation_31 + P_negotiation_32 + P_startNeg__broadcasting_5 + P_startNeg__broadcasting_6 + P_startNeg__broadcasting_7 = 1
inv : 4*P_electionInit_4 + P_negotiation_77 + P_negotiation_80 + P_negotiation_83 + P_negotiation_89 + P_network_360 + P_network_372 + P_network_576 + P_network_588 + P_network_792 + P_network_804 + P_network_906 + P_network_918 + P_network_942 + P_network_954 + P_network_978 + P_network_990 + P_network_1050 + P_network_1062 + P_network_1224 + P_network_1236 + 4*P_startNeg__broadcasting_20 + 3*P_startNeg__broadcasting_21 + 2*P_startNeg__broadcasting_22 + P_startNeg__broadcasting_23 = 4
inv : P_electionInit_5 + P_negotiation_103 + P_negotiation_104 + P_startNeg__broadcasting_25 + P_startNeg__broadcasting_26 + P_startNeg__broadcasting_27 + P_startNeg__broadcasting_28 = 1
inv : -P_electionInit_1 + P_negotiation_27 - P_startNeg__broadcasting_5 - P_startNeg__broadcasting_6 = 0
inv : -P_electionInit_2 + P_negotiation_45 - P_startNeg__broadcasting_10 - P_startNeg__broadcasting_11 = 0
inv : P_electionInit_3 + P_poll__handlingMessage_3 + P_poll__pollEnd_3 + P_polling_3 + P_startNeg__broadcasting_15 + P_startNeg__broadcasting_16 + P_startNeg__broadcasting_17 + P_startNeg__broadcasting_18 + P_startNeg__broadcasting_19 = 1
inv : -P_electionInit_3 + P_negotiation_57 - P_startNeg__broadcasting_15 = 0
inv : -P_electionInit_1 + P_negotiation_24 - P_startNeg__broadcasting_5 = 0
inv : P_electionInit_4 + P_negotiation_88 + P_negotiation_89 + P_startNeg__broadcasting_20 + P_startNeg__broadcasting_21 + P_startNeg__broadcasting_22 + P_startNeg__broadcasting_23 = 1
inv : -P_electionInit_1 + P_negotiation_30 - P_startNeg__broadcasting_5 - P_startNeg__broadcasting_6 - P_startNeg__broadcasting_7 = 0
inv : -P_electionInit_2 + P_negotiation_48 - P_startNeg__broadcasting_10 - P_startNeg__broadcasting_11 - P_startNeg__broadcasting_12 = 0
inv : P_electionInit_5 + P_poll__handlingMessage_5 + P_poll__pollEnd_5 + P_polling_5 + P_startNeg__broadcasting_25 + P_startNeg__broadcasting_26 + P_startNeg__broadcasting_27 + P_startNeg__broadcasting_28 + P_startNeg__broadcasting_29 = 1
inv : P_electionInit_3 + P_negotiation_61 + P_negotiation_62 + P_startNeg__broadcasting_15 + P_startNeg__broadcasting_16 = 1
inv : P_electionInit_1 + P_negotiation_25 + P_negotiation_26 + P_startNeg__broadcasting_5 = 1
inv : P_electionInit_3 + P_negotiation_67 + P_negotiation_68 + P_startNeg__broadcasting_15 + P_startNeg__broadcasting_16 + P_startNeg__broadcasting_17 = 1
inv : 4*P_electionInit_2 + P_negotiation_41 + P_negotiation_47 + P_negotiation_50 + P_negotiation_53 + P_network_288 + P_network_300 + P_network_474 + P_network_486 + P_network_546 + P_network_558 + P_network_582 + P_network_594 + P_network_618 + P_network_630 + P_network_720 + P_network_732 + P_network_936 + P_network_948 + P_network_1152 + P_network_1164 + 4*P_startNeg__broadcasting_10 + 3*P_startNeg__broadcasting_11 + 2*P_startNeg__broadcasting_12 + P_startNeg__broadcasting_13 = 4
inv : -P_electionInit_2 + P_negotiation_39 - P_startNeg__broadcasting_10 = 0
inv : P_masterState_12 + P_masterState_18 = 1
inv : 4*P_electionInit_3 + P_negotiation_59 + P_negotiation_62 + P_negotiation_68 + P_negotiation_71 + P_network_324 + P_network_336 + P_network_540 + P_network_552 + P_network_690 + P_network_702 + P_network_726 + P_network_738 + P_network_798 + P_network_810 + P_network_834 + P_network_846 + P_network_972 + P_network_984 + P_network_1188 + P_network_1200 + 4*P_startNeg__broadcasting_15 + 3*P_startNeg__broadcasting_16 + 2*P_startNeg__broadcasting_17 + P_startNeg__broadcasting_18 = 4
inv : 4*P_electionInit_5 + P_negotiation_95 + P_negotiation_98 + P_negotiation_101 + P_negotiation_104 + P_network_396 + P_network_408 + P_network_612 + P_network_624 + P_network_828 + P_network_840 + P_network_1044 + P_network_1056 + P_network_1122 + P_network_1134 + P_network_1158 + P_network_1170 + P_network_1194 + P_network_1206 + P_network_1230 + P_network_1242 + 4*P_startNeg__broadcasting_25 + 3*P_startNeg__broadcasting_26 + 2*P_startNeg__broadcasting_27 + P_startNeg__broadcasting_28 = 4
inv : P_electionInit_2 + P_poll__handlingMessage_2 + P_poll__pollEnd_2 + P_polling_2 + P_startNeg__broadcasting_10 + P_startNeg__broadcasting_11 + P_startNeg__broadcasting_12 + P_startNeg__broadcasting_13 + P_startNeg__broadcasting_14 = 1
inv : -P_electionInit_2 + P_negotiation_51 - P_startNeg__broadcasting_10 - P_startNeg__broadcasting_11 - P_startNeg__broadcasting_12 - P_startNeg__broadcasting_13 = 0
inv : -P_electionInit_1 + P_negotiation_33 - P_startNeg__broadcasting_5 - P_startNeg__broadcasting_6 - P_startNeg__broadcasting_7 - P_startNeg__broadcasting_8 = 0
inv : P_electionInit_5 + P_negotiation_94 + P_negotiation_95 + P_startNeg__broadcasting_25 = 1
inv : -P_electionInit_4 + P_negotiation_75 - P_startNeg__broadcasting_20 = 0
inv : P_electionInit_3 + P_negotiation_70 + P_negotiation_71 + P_startNeg__broadcasting_15 + P_startNeg__broadcasting_16 + P_startNeg__broadcasting_17 + P_startNeg__broadcasting_18 = 1
inv : -P_electionInit_3 + P_negotiation_69 - P_startNeg__broadcasting_15 - P_startNeg__broadcasting_16 - P_startNeg__broadcasting_17 - P_startNeg__broadcasting_18 = 0
inv : P_masterState_24 + P_masterState_30 = 1
inv : P_electionInit_1 + P_negotiation_28 + P_negotiation_29 + P_startNeg__broadcasting_5 + P_startNeg__broadcasting_6 = 1
inv : P_electionInit_2 + P_negotiation_40 + P_negotiation_41 + P_startNeg__broadcasting_10 = 1
inv : P_electionInit_4 + P_negotiation_82 + P_negotiation_83 + P_startNeg__broadcasting_20 + P_startNeg__broadcasting_21 + P_startNeg__broadcasting_22 = 1
inv : P_electionInit_5 + P_negotiation_100 + P_negotiation_101 + P_startNeg__broadcasting_25 + P_startNeg__broadcasting_26 + P_startNeg__broadcasting_27 = 1
inv : -P_electionInit_4 + P_negotiation_78 - P_startNeg__broadcasting_20 - P_startNeg__broadcasting_21 = 0
inv : -P_electionInit_3 + P_negotiation_60 - P_startNeg__broadcasting_15 - P_startNeg__broadcasting_16 = 0
inv : -P_electionInit_4 + P_negotiation_87 - P_startNeg__broadcasting_20 - P_startNeg__broadcasting_21 - P_startNeg__broadcasting_22 - P_startNeg__broadcasting_23 = 0
inv : P_electionInit_2 + P_negotiation_49 + P_negotiation_50 + P_startNeg__broadcasting_10 + P_startNeg__broadcasting_11 + P_startNeg__broadcasting_12 = 1
inv : P_electionInit_2 + P_negotiation_46 + P_negotiation_47 + P_startNeg__broadcasting_10 + P_startNeg__broadcasting_11 = 1
inv : -P_electionInit_5 + P_negotiation_96 - P_startNeg__broadcasting_25 - P_startNeg__broadcasting_26 = 0
inv : P_electionInit_5 + P_negotiation_97 + P_negotiation_98 + P_startNeg__broadcasting_25 + P_startNeg__broadcasting_26 = 1
inv : P_masterState_36 + P_masterState_42 = 1
inv : -P_electionInit_5 + P_negotiation_99 - P_startNeg__broadcasting_25 - P_startNeg__broadcasting_26 - P_startNeg__broadcasting_27 = 0
inv : P_electionInit_2 + P_negotiation_52 + P_negotiation_53 + P_startNeg__broadcasting_10 + P_startNeg__broadcasting_11 + P_startNeg__broadcasting_12 + P_startNeg__broadcasting_13 = 1
inv : P_electionInit_3 + P_negotiation_58 + P_negotiation_59 + P_startNeg__broadcasting_15 = 1
inv : -P_electionInit_5 + P_negotiation_93 - P_startNeg__broadcasting_25 = 0
inv : P_electionInit_1 + P_negotiation_34 + P_negotiation_35 + P_startNeg__broadcasting_5 + P_startNeg__broadcasting_6 + P_startNeg__broadcasting_7 + P_startNeg__broadcasting_8 = 1
inv : P_electionInit_4 + P_poll__handlingMessage_4 + P_poll__pollEnd_4 + P_polling_4 + P_startNeg__broadcasting_20 + P_startNeg__broadcasting_21 + P_startNeg__broadcasting_22 + P_startNeg__broadcasting_23 + P_startNeg__broadcasting_24 = 1
Total of 54 invariants.
[2020-05-18 23:34:37] [INFO ] Computed 54 place invariants in 18 ms
[2020-05-18 23:34:37] [INFO ] Proved 193 variables to be positive in 547 ms
[2020-05-18 23:34:37] [INFO ] Computing symmetric may disable matrix : 236 transitions.
[2020-05-18 23:34:37] [INFO ] Computation of disable matrix completed :0/236 took 0 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-18 23:34:37] [INFO ] Computation of Complete disable matrix. took 49 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-18 23:34:37] [INFO ] Computing symmetric may enable matrix : 236 transitions.
[2020-05-18 23:34:37] [INFO ] Computation of Complete enable matrix. took 24 ms. Total solver calls (SAT/UNSAT): 0(0/0)
[2020-05-18 23:34:42] [INFO ] Computing symmetric co enabling matrix : 236 transitions.
[2020-05-18 23:34:42] [INFO ] Computation of co-enabling matrix(0/236) took 43 ms. Total solver calls (SAT/UNSAT): 55(0/55)
[2020-05-18 23:34:45] [INFO ] Computation of co-enabling matrix(13/236) took 3253 ms. Total solver calls (SAT/UNSAT): 696(402/294)
[2020-05-18 23:34:48] [INFO ] Computation of co-enabling matrix(19/236) took 6366 ms. Total solver calls (SAT/UNSAT): 989(653/336)
[2020-05-18 23:34:52] [INFO ] Computation of co-enabling matrix(25/236) took 9992 ms. Total solver calls (SAT/UNSAT): 1264(886/378)
[2020-05-18 23:34:55] [INFO ] Computation of co-enabling matrix(32/236) took 13709 ms. Total solver calls (SAT/UNSAT): 1560(1133/427)
[2020-05-18 23:34:58] [INFO ] Computation of co-enabling matrix(40/236) took 16908 ms. Total solver calls (SAT/UNSAT): 1904(1421/483)
[2020-05-18 23:35:01] [INFO ] Computation of co-enabling matrix(48/236) took 19923 ms. Total solver calls (SAT/UNSAT): 2300(1701/599)
[2020-05-18 23:35:04] [INFO ] Computation of co-enabling matrix(56/236) took 22961 ms. Total solver calls (SAT/UNSAT): 2736(1957/779)
[2020-05-18 23:35:08] [INFO ] Computation of co-enabling matrix(62/236) took 26204 ms. Total solver calls (SAT/UNSAT): 3063(2142/921)
[2020-05-18 23:35:11] [INFO ] Computation of co-enabling matrix(70/236) took 29821 ms. Total solver calls (SAT/UNSAT): 3481(2368/1113)
[2020-05-18 23:35:14] [INFO ] Computation of co-enabling matrix(78/236) took 32832 ms. Total solver calls (SAT/UNSAT): 3877(2572/1305)
[2020-05-18 23:35:17] [INFO ] Computation of co-enabling matrix(92/236) took 35920 ms. Total solver calls (SAT/UNSAT): 4490(2971/1519)
[2020-05-18 23:35:21] [INFO ] Computation of co-enabling matrix(101/236) took 39099 ms. Total solver calls (SAT/UNSAT): 4870(3252/1618)
[2020-05-18 23:35:24] [INFO ] Computation of co-enabling matrix(114/236) took 42113 ms. Total solver calls (SAT/UNSAT): 5373(3612/1761)
[2020-05-18 23:35:27] [INFO ] Computation of co-enabling matrix(125/236) took 45219 ms. Total solver calls (SAT/UNSAT): 5756(3878/1878)
[2020-05-18 23:35:30] [INFO ] Computation of co-enabling matrix(155/236) took 48278 ms. Total solver calls (SAT/UNSAT): 6662(4508/2154)
[2020-05-18 23:35:33] [INFO ] Computation of co-enabling matrix(185/236) took 51346 ms. Total solver calls (SAT/UNSAT): 7323(4879/2444)
[2020-05-18 23:35:36] [INFO ] Computation of co-enabling matrix(231/236) took 54355 ms. Total solver calls (SAT/UNSAT): 7644(4960/2684)
[2020-05-18 23:35:36] [INFO ] Computation of Finished co-enabling matrix. took 54403 ms. Total solver calls (SAT/UNSAT): 7644(4960/2684)
[2020-05-18 23:35:36] [INFO ] Computing Do-Not-Accords matrix : 236 transitions.
[2020-05-18 23:35:45] [INFO ] Computation of Completed DNA matrix. took 8637 ms. Total solver calls (SAT/UNSAT): 202(0/202)
[2020-05-18 23:35:45] [INFO ] Built C files in 68583ms conformant to PINS in folder :/home/mcc/execution
Running compilation step : CommandLine [args=[gcc, -c, -I/home/mcc/BenchKit//lts_install_dir//include, -I., -std=c99, -fPIC, -O2, model.c], workingDir=/home/mcc/execution]
Compilation finished in 3909 ms.
Running link step : CommandLine [args=[gcc, -shared, -o, gal.so, model.o], workingDir=/home/mcc/execution]
Link finished in 81 ms.
Running LTSmin : CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, !( <>(X(<>([]((LTLAP0==true)))))) , --buchi-type=spotba], workingDir=/home/mcc/execution]
/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc: error while loading shared libraries: libltdl.so.7: cannot open shared object file: No such file or directory
WARNING : LTS min runner thread failed on error :java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, !( <>(X(<>([]((LTLAP0==true)))))) , --buchi-type=spotba], workingDir=/home/mcc/execution]
127
java.lang.RuntimeException: Unexpected exception when executing ltsmin :CommandLine [args=[/home/mcc/BenchKit//lts_install_dir//bin/pins2lts-mc, ./gal.so, --threads=8, --when, --ltl, !( <>(X(<>([]((LTLAP0==true)))))) , --buchi-type=spotba], workingDir=/home/mcc/execution]
127
at fr.lip6.move.gal.application.LTSminRunner.checkProperty(LTSminRunner.java:170)
at fr.lip6.move.gal.application.LTSminRunner.access$10(LTSminRunner.java:124)
at fr.lip6.move.gal.application.LTSminRunner$1.run(LTSminRunner.java:93)
at java.base/java.lang.Thread.run(Thread.java:834)
Detected timeout of ITS tools.
[2020-05-18 23:54:37] [INFO ] Applying decomposition
[2020-05-18 23:54:37] [INFO ] Flatten gal took : 60 ms
[2020-05-18 23:54:37] [INFO ] Decomposing Gal with order
[2020-05-18 23:54:37] [INFO ] Rewriting arrays to variables to allow decomposition.
[2020-05-18 23:54:37] [INFO ] Removed a total of 659 redundant transitions.
[2020-05-18 23:54:37] [INFO ] Flatten gal took : 71 ms
[2020-05-18 23:54:37] [INFO ] Fuse similar labels procedure discarded/fused a total of 0 labels/synchronizations in 5 ms.
[2020-05-18 23:54:37] [INFO ] Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 11 ms
[2020-05-18 23:54:37] [INFO ] Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 14 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock
Read 4 LTL properties
Checking formula 0 : !((!(F(X(F(G("(((((M2.P_poll__pollEnd_2>=1)||(M3.P_poll__pollEnd_3>=1))||(M4.P_poll__pollEnd_4>=1))||(M5.P_poll__pollEnd_5>=1))||(M1.P_poll__pollEnd_1>=1))")))))))
Formula 0 simplified : FXFG"(((((M2.P_poll__pollEnd_2>=1)||(M3.P_poll__pollEnd_3>=1))||(M4.P_poll__pollEnd_4>=1))||(M5.P_poll__pollEnd_5>=1))||(M1.P_poll__pollEnd_1>=1))"
built 226 ordering constraints for composite.
Reverse transition relation is NOT exact ! Due to transitions T_poll__handleAI1r1s1m2, T_poll__handleAI1r1s1m3, T_poll__handleAI1r1s1m4, T_poll__handleAI1r1s1m5, T_poll__handleAI1r1s2m3, T_poll__handleAI1r1s2m4, T_poll__handleAI1r1s2m5, T_poll__handleAI1r1s3m4, T_poll__handleAI1r1s3m5, T_poll__handleAI1r1s4m5, T_poll__handleAI1r2s1m3, T_poll__handleAI1r2s1m4, T_poll__handleAI1r2s1m5, T_poll__handleAI1r2s2m3, T_poll__handleAI1r2s2m4, T_poll__handleAI1r2s2m5, T_poll__handleAI1r2s3m4, T_poll__handleAI1r2s3m5, T_poll__handleAI1r2s4m5, T_poll__handleAI1r3s1m2, T_poll__handleAI1r3s1m4, T_poll__handleAI1r3s1m5, T_poll__handleAI1r3s2m4, T_poll__handleAI1r3s2m5, T_poll__handleAI1r3s3m4, T_poll__handleAI1r3s3m5, T_poll__handleAI1r3s4m5, T_poll__handleAI1r4s1m2, T_poll__handleAI1r4s1m3, T_poll__handleAI1r4s1m5, T_poll__handleAI1r4s2m3, T_poll__handleAI1r4s2m5, T_poll__handleAI1r4s3m5, T_poll__handleAI1r4s4m5, T_poll__handleAI1r5s1m2, T_poll__handleAI1r5s1m3, T_poll__handleAI1r5s1m4, T_poll__handleAI1r5s2m3, T_poll__handleAI1r5s2m4, T_poll__handleAI1r5s3m4, T_poll__handleAI2iam0pm0r1s3m2, T_poll__handleAI2iam0pm0r1s4m2, T_poll__handleAI2iam0pm0r1s4m3, T_poll__handleAI2iam0pm0r1s5m2, T_poll__handleAI2iam0pm0r1s5m3, T_poll__handleAI2iam0pm0r2s2m1, T_poll__handleAI2iam0pm0r2s3m1, T_poll__handleAI2iam0pm0r2s4m1, T_poll__handleAI2iam0pm0r2s4m3, T_poll__handleAI2iam0pm0r2s5m1, T_poll__handleAI2iam0pm0r2s5m3, T_poll__handleAI2iam0pm0r3s2m1, T_poll__handleAI2iam0pm0r3s3m1, T_poll__handleAI2iam0pm0r3s3m2, T_poll__handleAI2iam0pm0r3s4m1, T_poll__handleAI2iam0pm0r3s4m2, T_poll__handleAI2iam0pm0r3s5m1, T_poll__handleAI2iam0pm0r3s5m2, T_poll__handleAI2iam0pm0r4s2m1, T_poll__handleAI2iam0pm0r4s3m1, T_poll__handleAI2iam0pm0r4s3m2, T_poll__handleAI2iam0pm0r4s4m1, T_poll__handleAI2iam0pm0r4s4m2, T_poll__handleAI2iam0pm0r4s4m3, T_poll__handleAI2iam0pm0r4s5m1, T_poll__handleAI2iam0pm0r4s5m2, T_poll__handleAI2iam0pm0r4s5m3, T_poll__handleAI2iam0pm0r5s2m1, T_poll__handleAI2iam0pm0r5s3m1, T_poll__handleAI2iam0pm0r5s3m2, T_poll__handleAI2iam0pm0r5s4m1, T_poll__handleAI2iam0pm0r5s4m2, T_poll__handleAI2iam0pm0r5s4m3, T_poll__handleAI2iam0pm0r5s5m1, T_poll__handleAI2iam0pm0r5s5m2, T_poll__handleAI2iam0pm0r5s5m3, T_poll__handleAI2iam1pm0r1s3m2, T_poll__handleAI2iam1pm0r1s4m2, T_poll__handleAI2iam1pm0r1s4m3, T_poll__handleAI2iam1pm0r1s5m2, T_poll__handleAI2iam1pm0r1s5m3, T_poll__handleAI2iam1pm0r2s2m1, T_poll__handleAI2iam1pm0r2s3m1, T_poll__handleAI2iam1pm0r2s4m1, T_poll__handleAI2iam1pm0r2s4m3, T_poll__handleAI2iam1pm0r2s5m1, T_poll__handleAI2iam1pm0r2s5m3, T_poll__handleAI2iam1pm0r3s2m1, T_poll__handleAI2iam1pm0r3s3m1, T_poll__handleAI2iam1pm0r3s3m2, T_poll__handleAI2iam1pm0r3s4m1, T_poll__handleAI2iam1pm0r3s4m2, T_poll__handleAI2iam1pm0r3s5m1, T_poll__handleAI2iam1pm0r3s5m2, T_poll__handleAI2iam1pm0r4s2m1, T_poll__handleAI2iam1pm0r4s3m1, T_poll__handleAI2iam1pm0r4s3m2, T_poll__handleAI2iam1pm0r4s4m1, T_poll__handleAI2iam1pm0r4s4m2, T_poll__handleAI2iam1pm0r4s4m3, T_poll__handleAI2iam1pm0r4s5m1, T_poll__handleAI2iam1pm0r4s5m2, T_poll__handleAI2iam1pm0r4s5m3, T_poll__handleAI2iam1pm0r5s2m1, T_poll__handleAI2iam1pm0r5s3m1, T_poll__handleAI2iam1pm0r5s3m2, T_poll__handleAI2iam1pm0r5s4m1, T_poll__handleAI2iam1pm0r5s4m2, T_poll__handleAI2iam1pm0r5s4m3, T_poll__handleAI2iam1pm0r5s5m1, T_poll__handleAI2iam1pm0r5s5m2, T_poll__handleAI2iam1pm0r5s5m3, T_startNeg__endm1, T_startNeg__endm2, T_startNeg__endm3, T_startNeg__endm4, T_startNeg__endm5, M1.T_poll__endm1, M2.T_poll__endm2, M3.T_poll__endm3, M4.T_poll__endm4, M5.T_poll__endm5, Intersection with reachable at each step enabled. (destroyed/reverse/intersect/total) :4/110/122/236
Computing Next relation with stutter on 1 deadlock states
Detected timeout of ITS tools.
[2020-05-19 00:14:37] [INFO ] Flatten gal took : 35 ms
[2020-05-19 00:14:38] [INFO ] Input system was already deterministic with 236 transitions.
[2020-05-19 00:14:38] [INFO ] Transformed 193 places.
[2020-05-19 00:14:38] [INFO ] Transformed 236 transitions.
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/pinvar, /home/mcc/execution/gspn], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Running greatSPN : CommandLine [args=[/home/mcc/BenchKit//greatspn//bin/RGMEDD2, /home/mcc/execution/gspn, -META, -varord-only], workingDir=/home/mcc/execution]
Run of greatSPN captured in /home/mcc/execution/outPut.txt
Using order generated by GreatSPN with heuristic : META
[2020-05-19 00:14:38] [INFO ] Time to serialize gal into /home/mcc/execution/LTLFireability.pnml.gal : 4 ms
[2020-05-19 00:14:38] [INFO ] Time to serialize properties into /home/mcc/execution/LTLFireability.ltl : 1 ms
Invoking ITS tools like this :CommandLine [args=[/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64, --gc-threshold, 2000000, -i, /home/mcc/execution/LTLFireability.pnml.gal, -t, CGAL, -LTL, /home/mcc/execution/LTLFireability.ltl, -c, -stutter-deadlock, --load-order, /home/mcc/execution/model.ord, --gen-order, FOLLOW], workingDir=/home/mcc/execution]

its-ltl command run as :

/home/mcc/BenchKit/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202005100927/bin/its-ltl-linux64 --gc-threshold 2000000 -i /home/mcc/execution/LTLFireability.pnml.gal -t CGAL -LTL /home/mcc/execution/LTLFireability.ltl -c -stutter-deadlock --load-order /home/mcc/execution/model.ord --gen-order FOLLOW
Read 4 LTL properties
Successfully loaded order from file /home/mcc/execution/model.ord
Checking formula 0 : !((!(F(X(F(G("(((((P_poll__pollEnd_2>=1)||(P_poll__pollEnd_3>=1))||(P_poll__pollEnd_4>=1))||(P_poll__pollEnd_5>=1))||(P_poll__pollEnd_1>=1))")))))))
Formula 0 simplified : FXFG"(((((P_poll__pollEnd_2>=1)||(P_poll__pollEnd_3>=1))||(P_poll__pollEnd_4>=1))||(P_poll__pollEnd_5>=1))||(P_poll__pollEnd_1>=1))"

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="NeoElection-COL-5"
export BK_EXAMINATION="LTLFireability"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="3600"
export BK_MEMORY_CONFINEMENT="16384"

# this is specific to your benchmark or test

export BIN_DIR="$HOME/BenchKit/bin"

# remove the execution directoty if it exists (to avoid increse of .vmdk images)
if [ -d execution ] ; then
rm -rf execution
fi

# this is for BenchKit: explicit launching of the test
echo "====================================================================="
echo " Generated by BenchKit 2-4028"
echo " Executing tool itstools"
echo " Input is NeoElection-COL-5, examination is LTLFireability"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r111-csrt-158961257300242"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/NeoElection-COL-5.tgz
mv NeoElection-COL-5 execution
cd execution
if [ "LTLFireability" = "ReachabilityDeadlock" ] || [ "LTLFireability" = "UpperBounds" ] || [ "LTLFireability" = "QuasiLiveness" ] || [ "LTLFireability" = "StableMarking" ] || [ "LTLFireability" = "Liveness" ] || [ "LTLFireability" = "OneSafe" ] || [ "LTLFireability" = "StateSpace" ]; then
rm -f GenericPropertiesVerdict.xml
fi
pwd
ls -lh

echo
echo "--------------------"
echo "content from stdout:"
echo
echo "=== Data for post analysis generated by BenchKit (invocation template)"
echo
if [ "LTLFireability" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "LTLFireability" != "StateSpace" ] ; then
echo "The expected result is a vector of booleans"
echo BOOL_VECTOR
else
echo "no data necessary for post analysis"
fi
echo
if [ -f "LTLFireability.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property LTLFireability.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "LTLFireability.xml" ] ; then # for cunf (txt files deleted;-)
echo echo "here is the order used to build the result vector(from xml file)"
for x in $(grep '' LTLFireability.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "LTLFireability" = "ReachabilityDeadlock" ] || [ "LTLFireability" = "QuasiLiveness" ] || [ "LTLFireability" = "StableMarking" ] || [ "LTLFireability" = "Liveness" ] || [ "LTLFireability" = "OneSafe" ] ; then
echo "FORMULA_NAME LTLFireability"
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 ;