Execution Chart

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

Trace from the execution

Formatting '/data/fkordon/mcc2024-input.r387-smll-171683819400099.qcow2', fmt=qcow2 size=4294967296 backing_file=/data/fkordon/mcc2024-input.qcow2 backing_fmt=qcow2 cluster_size=65536 lazy_refcounts=off refcount_bits=16
Waiting for the VM to be ready (probing ssh)
...................
=====================================================================
Generated by BenchKit 2-5568
Executing tool itstools
Input is SimpleLoadBal-PT-05, examination is Liveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r387-smll-171683819400099
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 760K
-rw-r--r-- 1 mcc users 8.8K May 14 13:22 CTLCardinality.txt
-rw-r--r-- 1 mcc users 77K May 14 13:22 CTLCardinality.xml
-rw-r--r-- 1 mcc users 8.0K May 14 13:22 CTLFireability.txt
-rw-r--r-- 1 mcc users 57K May 14 13:22 CTLFireability.xml
-rw-r--r-- 1 mcc users 4.2K May 18 16:43 GenericPropertiesDefinition.xml
-rw-r--r-- 1 mcc users 5.7K Apr 23 07:56 LTLCardinality.txt
-rw-r--r-- 1 mcc users 32K Apr 23 07:56 LTLCardinality.xml
-rw-r--r-- 1 mcc users 3.3K Apr 23 07:56 LTLFireability.txt
-rw-r--r-- 1 mcc users 22K Apr 23 07:56 LTLFireability.xml
-rw-r--r-- 1 mcc users 23K Apr 13 12:09 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 196K Apr 13 12:09 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 17K Apr 13 12:08 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 107K Apr 13 12:08 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.8K Apr 23 07:56 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K Apr 23 07:56 UpperBounds.xml
-rw-r--r-- 1 mcc users 6 May 18 16:43 equiv_col
-rw-r--r-- 1 mcc users 3 May 18 16:43 instance
-rw-r--r-- 1 mcc users 6 May 18 16:43 iscolored
-rw-r--r-- 1 mcc users 155K May 18 16:43 model.pnml

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

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

The expected result is a vector of booleans
BOOL_VECTOR

FORMULA_NAME Liveness

=== Now, execution of the tool begins

BK_START 1716893804241

Invoking MCC driver with
BK_TOOL=itstools
BK_EXAMINATION=Liveness
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=SimpleLoadBal-PT-05
BK_MEMORY_CONFINEMENT=16384
Not applying reductions.
Model is PT
Liveness PT
Running Version 202405141337
[2024-05-28 10:56:46] [INFO ] Running its-tools with arguments : [-pnfolder, /home/mcc/execution, -examination, Liveness, -its, -ltsmin, -greatspnpath, /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/, -order, META, -manyOrder, -smt, -timeout, 1800]
[2024-05-28 10:56:46] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2024-05-28 10:56:47] [INFO ] Load time of PNML (sax parser for PT used): 163 ms
[2024-05-28 10:56:47] [INFO ] Transformed 59 places.
[2024-05-28 10:56:47] [INFO ] Transformed 180 transitions.
[2024-05-28 10:56:47] [INFO ] Found NUPN structural information;
[2024-05-28 10:56:47] [INFO ] Completing missing partition info from NUPN : creating a component with [P_client_idle_1, P_client_idle_2, P_client_idle_3, P_client_idle_4, P_client_idle_5, P_client_waiting_1, P_client_waiting_2, P_client_waiting_3, P_client_waiting_4, P_client_waiting_5, P_client_request_1, P_client_request_2, P_client_request_3, P_client_request_4, P_client_request_5, P_client_ack_1, P_client_ack_2, P_client_ack_3, P_client_ack_4, P_client_ack_5, P_server_idle_1, P_server_idle_2, P_server_waiting_1, P_server_waiting_2, P_server_processed_1, P_server_processed_2, P_server_notification_1, P_server_notification_2, P_server_notification_ack_1, P_server_notification_ack_2, P_server_request_1_1, P_server_request_1_2, P_server_request_2_1, P_server_request_2_2, P_server_request_3_1, P_server_request_3_2, P_server_request_4_1, P_server_request_4_2, P_server_request_5_1, P_server_request_5_2, P_lb_idle_1, P_lb_routing_1_1, P_lb_routing_1_2, P_lb_routing_1_3, P_lb_routing_1_4, P_lb_routing_1_5, P_lb_balancing_1, P_lb_load_1_0, P_lb_load_1_1, P_lb_load_1_2, P_lb_load_1_3, P_lb_load_1_4, P_lb_load_1_5, P_lb_load_2_0, P_lb_load_2_1, P_lb_load_2_2, P_lb_load_2_3, P_lb_load_2_4, P_lb_load_2_5]
[2024-05-28 10:56:47] [INFO ] Parsed PT model containing 59 places and 180 transitions and 1158 arcs in 514 ms.
Built sparse matrix representations for Structural reductions in 9 ms.18425KB memory used
Starting structural reductions in DEADLOCK mode, iteration 0 : 59/59 places, 180/180 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 0 rules in 50 ms. Remains 59 /59 variables (removed 0) and now considering 180/180 (removed 0) transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 77 ms. Remains : 59/59 places, 180/180 transitions.
Starting structural reductions in DEADLOCK mode, iteration 0 : 59/59 places, 180/180 transitions.
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 0 rules in 38 ms. Remains 59 /59 variables (removed 0) and now considering 180/180 (removed 0) transitions.
[2024-05-28 10:56:47] [INFO ] Flow matrix only has 140 transitions (discarded 40 similar events)
// Phase 1: matrix 140 rows 59 cols
[2024-05-28 10:56:47] [INFO ] Computed 19 invariants in 20 ms
[2024-05-28 10:56:47] [INFO ] Implicit Places using invariants in 329 ms returned []
[2024-05-28 10:56:47] [INFO ] Flow matrix only has 140 transitions (discarded 40 similar events)
[2024-05-28 10:56:47] [INFO ] Invariant cache hit.
[2024-05-28 10:56:48] [INFO ] State equation strengthened by 55 read => feed constraints.
[2024-05-28 10:56:48] [INFO ] Implicit Places using invariants and state equation in 279 ms returned []
Implicit Place search using SMT with State Equation took 668 ms to find 0 implicit places.
[2024-05-28 10:56:48] [INFO ] Redundant transitions in 11 ms returned []
Running 175 sub problems to find dead transitions.
[2024-05-28 10:56:48] [INFO ] Flow matrix only has 140 transitions (discarded 40 similar events)
[2024-05-28 10:56:48] [INFO ] Invariant cache hit.
[2024-05-28 10:56:48] [INFO ] State equation strengthened by 55 read => feed constraints.
At refinement iteration 0 (INCLUDED_ONLY) 0/54 variables, 54/54 constraints. Problems are: Problem set: 0 solved, 175 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/54 variables, 7/61 constraints. Problems are: Problem set: 0 solved, 175 unsolved
At refinement iteration 2 (INCLUDED_ONLY) 0/54 variables, 1/62 constraints. Problems are: Problem set: 0 solved, 175 unsolved
[2024-05-28 10:56:50] [INFO ] Deduced a trap composed of 16 places in 80 ms of which 11 ms to minimize.
Problem TDEAD129 is UNSAT
At refinement iteration 3 (INCLUDED_ONLY) 0/54 variables, 1/63 constraints. Problems are: Problem set: 1 solved, 174 unsolved
At refinement iteration 4 (INCLUDED_ONLY) 0/54 variables, 0/63 constraints. Problems are: Problem set: 1 solved, 174 unsolved
At refinement iteration 5 (OVERLAPS) 5/59 variables, 9/72 constraints. Problems are: Problem set: 1 solved, 174 unsolved
At refinement iteration 6 (INCLUDED_ONLY) 0/59 variables, 5/77 constraints. Problems are: Problem set: 1 solved, 174 unsolved
Problem TDEAD36 is UNSAT
Problem TDEAD37 is UNSAT
Problem TDEAD38 is UNSAT
Problem TDEAD46 is UNSAT
Problem TDEAD47 is UNSAT
Problem TDEAD48 is UNSAT
Problem TDEAD56 is UNSAT
Problem TDEAD57 is UNSAT
Problem TDEAD58 is UNSAT
Problem TDEAD66 is UNSAT
Problem TDEAD67 is UNSAT
Problem TDEAD68 is UNSAT
Problem TDEAD76 is UNSAT
Problem TDEAD77 is UNSAT
Problem TDEAD78 is UNSAT
Problem TDEAD82 is UNSAT
Problem TDEAD83 is UNSAT
Problem TDEAD87 is UNSAT
Problem TDEAD88 is UNSAT
Problem TDEAD92 is UNSAT
Problem TDEAD93 is UNSAT
Problem TDEAD97 is UNSAT
Problem TDEAD98 is UNSAT
Problem TDEAD102 is UNSAT
Problem TDEAD103 is UNSAT
Problem TDEAD126 is UNSAT
Problem TDEAD127 is UNSAT
Problem TDEAD128 is UNSAT
Problem TDEAD145 is UNSAT
Problem TDEAD146 is UNSAT
Problem TDEAD147 is UNSAT
Problem TDEAD148 is UNSAT
Problem TDEAD149 is UNSAT
Problem TDEAD165 is UNSAT
Problem TDEAD166 is UNSAT
Problem TDEAD167 is UNSAT
Problem TDEAD168 is UNSAT
Problem TDEAD169 is UNSAT
At refinement iteration 7 (INCLUDED_ONLY) 0/59 variables, 2/79 constraints. Problems are: Problem set: 39 solved, 136 unsolved
[2024-05-28 10:56:52] [INFO ] Deduced a trap composed of 9 places in 73 ms of which 2 ms to minimize.
[2024-05-28 10:56:52] [INFO ] Deduced a trap composed of 8 places in 69 ms of which 3 ms to minimize.
Problem TDEAD108 is UNSAT
[2024-05-28 10:56:52] [INFO ] Deduced a trap composed of 28 places in 58 ms of which 1 ms to minimize.
[2024-05-28 10:56:53] [INFO ] Deduced a trap composed of 8 places in 74 ms of which 1 ms to minimize.
Problem TDEAD113 is UNSAT
Problem TDEAD124 is UNSAT
[2024-05-28 10:56:53] [INFO ] Deduced a trap composed of 27 places in 61 ms of which 1 ms to minimize.
Problem TDEAD125 is UNSAT
[2024-05-28 10:56:53] [INFO ] Deduced a trap composed of 29 places in 58 ms of which 2 ms to minimize.
Problem TDEAD112 is UNSAT
At refinement iteration 8 (INCLUDED_ONLY) 0/59 variables, 6/85 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 9 (INCLUDED_ONLY) 0/59 variables, 0/85 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 10 (OVERLAPS) 140/199 variables, 59/144 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 11 (INCLUDED_ONLY) 0/199 variables, 55/199 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 12 (INCLUDED_ONLY) 0/199 variables, 0/199 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 13 (OVERLAPS) 0/199 variables, 0/199 constraints. Problems are: Problem set: 44 solved, 131 unsolved
No progress, stopping.
After SMT solving in domain Real declared 199/199 variables, and 199 constraints, problems are : Problem set: 44 solved, 131 unsolved in 8319 ms.
Refiners :[Domain max(s): 59/59 constraints, Positive P Invariants (semi-flows): 16/16 constraints, Generalized P Invariants (flows): 3/3 constraints, State Equation: 59/59 constraints, ReadFeed: 55/55 constraints, PredecessorRefiner: 175/175 constraints, Known Traps: 7/7 constraints]
Escalating to Integer solving :Problem set: 44 solved, 131 unsolved
At refinement iteration 0 (INCLUDED_ONLY) 0/54 variables, 54/54 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 1 (INCLUDED_ONLY) 0/54 variables, 7/61 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 2 (INCLUDED_ONLY) 0/54 variables, 1/62 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 3 (INCLUDED_ONLY) 0/54 variables, 4/66 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 4 (INCLUDED_ONLY) 0/54 variables, 0/66 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 5 (OVERLAPS) 5/59 variables, 9/75 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 6 (INCLUDED_ONLY) 0/59 variables, 5/80 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 7 (INCLUDED_ONLY) 0/59 variables, 2/82 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 8 (INCLUDED_ONLY) 0/59 variables, 3/85 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 9 (INCLUDED_ONLY) 0/59 variables, 0/85 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 10 (OVERLAPS) 140/199 variables, 59/144 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 11 (INCLUDED_ONLY) 0/199 variables, 55/199 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 12 (INCLUDED_ONLY) 0/199 variables, 131/330 constraints. Problems are: Problem set: 44 solved, 131 unsolved
[2024-05-28 10:57:01] [INFO ] Deduced a trap composed of 8 places in 93 ms of which 2 ms to minimize.
At refinement iteration 13 (INCLUDED_ONLY) 0/199 variables, 1/331 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 14 (INCLUDED_ONLY) 0/199 variables, 0/331 constraints. Problems are: Problem set: 44 solved, 131 unsolved
At refinement iteration 15 (OVERLAPS) 0/199 variables, 0/331 constraints. Problems are: Problem set: 44 solved, 131 unsolved
No progress, stopping.
After SMT solving in domain Int declared 199/199 variables, and 331 constraints, problems are : Problem set: 44 solved, 131 unsolved in 10705 ms.
Refiners :[Domain max(s): 59/59 constraints, Positive P Invariants (semi-flows): 16/16 constraints, Generalized P Invariants (flows): 3/3 constraints, State Equation: 59/59 constraints, ReadFeed: 55/55 constraints, PredecessorRefiner: 131/175 constraints, Known Traps: 8/8 constraints]
After SMT, in 19836ms problems are : Problem set: 44 solved, 131 unsolved
Search for dead transitions found 44 dead transitions in 19868ms
Found 44 dead transitions using SMT.
Drop transitions (Dead Transitions using SMT only with invariants) removed 44 transitions
Dead transitions reduction (with SMT) removed 44 transitions
Starting structural reductions in DEADLOCK mode, iteration 1 : 59/59 places, 136/180 transitions.
Computed a total of 3 stabilizing places and 8 stable transitions
Reduce places removed 0 places and 2 transitions.
Computed a total of 3 stabilizing places and 6 stable transitions
Graph (complete) has 401 edges and 59 vertex of which 57 are kept as prefixes of interest. Removing 2 places using SCC suffix rule.3 ms
Discarding 2 places :
Also discarding 0 output transitions
Iterating post reduction 0 with 1 rules applied. Total rules applied 1 place count 57 transition count 134
Reduce places removed 0 places and 6 transitions.
Computed a total of 1 stabilizing places and 0 stable transitions
Graph (complete) has 380 edges and 57 vertex of which 56 are kept as prefixes of interest. Removing 1 places using SCC suffix rule.2 ms
Discarding 1 places :
Also discarding 0 output transitions
Iterating post reduction 1 with 1 rules applied. Total rules applied 2 place count 56 transition count 128
Computed a total of 0 stabilizing places and 0 stable transitions
Computed a total of 0 stabilizing places and 0 stable transitions
Applied a total of 2 rules in 36 ms. Remains 56 /59 variables (removed 3) and now considering 128/136 (removed 8) transitions.
[2024-05-28 10:57:08] [INFO ] Flow matrix only has 104 transitions (discarded 24 similar events)
// Phase 1: matrix 104 rows 56 cols
[2024-05-28 10:57:08] [INFO ] Computed 19 invariants in 2 ms
[2024-05-28 10:57:08] [INFO ] Implicit Places using invariants in 86 ms returned []
[2024-05-28 10:57:08] [INFO ] Flow matrix only has 104 transitions (discarded 24 similar events)
[2024-05-28 10:57:08] [INFO ] Invariant cache hit.
[2024-05-28 10:57:08] [INFO ] State equation strengthened by 37 read => feed constraints.
[2024-05-28 10:57:08] [INFO ] Implicit Places using invariants and state equation in 91 ms returned []
Implicit Place search using SMT with State Equation took 197 ms to find 0 implicit places.
Starting structural reductions in DEADLOCK mode, iteration 2 : 56/59 places, 128/180 transitions.
Finished structural reductions in DEADLOCK mode , in 2 iterations and 20847 ms. Remains : 56/59 places, 128/180 transitions.
Random walk for 1250000 steps, including 0 resets, run took 2697 ms (no deadlock found). (steps per millisecond=463 )
Random directed walk for 1250002 steps, including 0 resets, run took 1919 ms (no deadlock found). (steps per millisecond=651 )
[2024-05-28 10:57:12] [INFO ] Flow matrix only has 104 transitions (discarded 24 similar events)
[2024-05-28 10:57:12] [INFO ] Invariant cache hit.
[2024-05-28 10:57:13] [INFO ] [Real]Absence check using 17 positive place invariants in 8 ms returned sat
[2024-05-28 10:57:13] [INFO ] [Real]Absence check using 17 positive and 2 generalized place invariants in 2 ms returned sat
[2024-05-28 10:57:13] [INFO ] [Real]Absence check using state equation in 52 ms returned sat
[2024-05-28 10:57:13] [INFO ] Solution in real domain found non-integer solution.
[2024-05-28 10:57:13] [INFO ] [Nat]Absence check using 17 positive place invariants in 6 ms returned sat
[2024-05-28 10:57:13] [INFO ] [Nat]Absence check using 17 positive and 2 generalized place invariants in 2 ms returned sat
[2024-05-28 10:57:13] [INFO ] [Nat]Absence check using state equation in 45 ms returned sat
[2024-05-28 10:57:13] [INFO ] State equation strengthened by 37 read => feed constraints.
[2024-05-28 10:57:13] [INFO ] [Nat]Added 37 Read/Feed constraints in 28 ms returned sat
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 9 places in 49 ms of which 2 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 9 places in 56 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 9 places in 57 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 6 places in 59 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 6 places in 57 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 6 places in 58 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 7 places in 54 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Deduced a trap composed of 7 places in 79 ms of which 1 ms to minimize.
[2024-05-28 10:57:13] [INFO ] Trap strengthening procedure managed to obtain unsat after adding 8 trap constraints in 572 ms
Starting structural reductions in LIVENESS mode, iteration 0 : 59/59 places, 180/180 transitions.
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 2 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 0 with 4 rules applied. Total rules applied 4 place count 57 transition count 178
Performed 5 Post agglomeration using F-continuation condition.Transition count delta: 5
Deduced a syphon composed of 5 places in 2 ms
Reduce places removed 10 places and 0 transitions.
Iterating global reduction 0 with 15 rules applied. Total rules applied 19 place count 47 transition count 173
Performed 5 Post agglomeration using F-continuation condition.Transition count delta: 5
Deduced a syphon composed of 5 places in 1 ms
Reduce places removed 5 places and 0 transitions.
Iterating global reduction 0 with 10 rules applied. Total rules applied 29 place count 42 transition count 168
Applied a total of 29 rules in 25 ms. Remains 42 /59 variables (removed 17) and now considering 168/180 (removed 12) transitions.
[2024-05-28 10:57:13] [INFO ] Flow matrix only has 128 transitions (discarded 40 similar events)
// Phase 1: matrix 128 rows 42 cols
[2024-05-28 10:57:13] [INFO ] Computed 14 invariants in 6 ms
[2024-05-28 10:57:13] [INFO ] Implicit Places using invariants in 148 ms returned [7, 8]
Discarding 2 places :
Implicit Place search using SMT only with invariants took 156 ms to find 2 implicit places.
Starting structural reductions in LIVENESS mode, iteration 1 : 40/59 places, 168/180 transitions.
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 1 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 0 with 4 rules applied. Total rules applied 4 place count 38 transition count 166
Applied a total of 4 rules in 11 ms. Remains 38 /40 variables (removed 2) and now considering 166/168 (removed 2) transitions.
[2024-05-28 10:57:14] [INFO ] Flow matrix only has 126 transitions (discarded 40 similar events)
// Phase 1: matrix 126 rows 38 cols
[2024-05-28 10:57:14] [INFO ] Computed 12 invariants in 3 ms
[2024-05-28 10:57:14] [INFO ] Implicit Places using invariants in 112 ms returned []
[2024-05-28 10:57:14] [INFO ] Flow matrix only has 126 transitions (discarded 40 similar events)
[2024-05-28 10:57:14] [INFO ] Invariant cache hit.
[2024-05-28 10:57:14] [INFO ] State equation strengthened by 55 read => feed constraints.
[2024-05-28 10:57:14] [INFO ] Implicit Places using invariants and state equation in 201 ms returned []
Implicit Place search using SMT with State Equation took 318 ms to find 0 implicit places.
Starting structural reductions in LIVENESS mode, iteration 2 : 38/59 places, 166/180 transitions.
Finished structural reductions in LIVENESS mode , in 2 iterations and 512 ms. Remains : 38/59 places, 166/180 transitions.
Initial state reduction rules removed 5 formulas.
[2024-05-28 10:57:14] [INFO ] Flatten gal took : 151 ms
[2024-05-28 10:57:15] [INFO ] Flatten gal took : 114 ms
[2024-05-28 10:57:15] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality984161814051068082.gal : 53 ms
[2024-05-28 10:57:15] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality10888854250398080614.prop : 39 ms
Invoking ITS tools like this :cd /home/mcc/execution;'/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality984161814051068082.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality10888854250398080614.prop' '--nowitness' '--gen-order' 'FOLLOW'

RANDOM walk for 40000 steps (8 resets) in 3106 ms. (12 steps per ms) remains 52/161 properties
its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202405141337/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...328
BEST_FIRST walk for 4004 steps (8 resets) in 68 ms. (58 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 30 ms. (129 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 27 ms. (142 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 32 ms. (121 steps per ms) remains 52/52 properties
Loading property file /tmp/ReachabilityCardinality10888854250398080614.prop.
BEST_FIRST walk for 4004 steps (8 resets) in 46 ms. (85 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 53 ms. (74 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 22 ms. (174 steps per ms) remains 52/52 properties
Reachability property qltransition_146 is true.
Reachability property qltransition_138 is true.
Reachability property qltransition_136 is true.
Reachability property qltransition_15 is true.
Reachability property qltransition_5 is true.
SDD proceeding with computation,156 properties remain. new max is 2
SDD size :1 after 6
Reachability property qltransition_139 is true.
Reachability property qltransition_137 is true.
Reachability property qltransition_81 is true.
Reachability property qltransition_80 is true.
Reachability property qltransition_60 is true.
Reachability property qltransition_55 is true.
Reachability property qltransition_17 is true.
Reachability property qltransition_7 is true.
SDD proceeding with computation,148 properties remain. new max is 2
SDD size :6 after 19
Reachability property qltransition_151 is true.
Reachability property qltransition_147 is true.
Reachability property qltransition_83 is true.
Reachability property qltransition_16 is true.
Reachability property qltransition_6 is true.
SDD proceeding with computation,143 properties remain. new max is 2
SDD size :19 after 28
SDD proceeding with computation,143 properties remain. new max is 4
SDD size :28 after 29
Reachability property qltransition_140 is true.
Reachability property qltransition_84 is true.
Reachability property qltransition_66 is true.
Reachability property qltransition_65 is true.
Reachability property qltransition_61 is true.
Reachability property qltransition_56 is true.
Reachability property qltransition_27 is true.
Reachability property qltransition_26 is true.
Reachability property qltransition_25 is true.
SDD proceeding with computation,134 properties remain. new max is 4
SDD size :29 after 58
Reachability property qltransition_141 is true.
Reachability property qltransition_97 is true.
Reachability property qltransition_96 is true.
Reachability property qltransition_28 is true.
SDD proceeding with computation,130 properties remain. new max is 4
SDD size :58 after 68
BEST_FIRST walk for 4003 steps (8 resets) in 46 ms. (85 steps per ms) remains 52/52 properties
SDD proceeding with computation,130 properties remain. new max is 8
SDD size :68 after 77
Reachability property qltransition_98 is true.
Reachability property qltransition_18 is true.
Reachability property qltransition_8 is true.
SDD proceeding with computation,127 properties remain. new max is 8
SDD size :77 after 96
BEST_FIRST walk for 4003 steps (8 resets) in 19 ms. (200 steps per ms) remains 52/52 properties
Reachability property qltransition_162 is true.
Reachability property qltransition_161 is true.
Reachability property qltransition_157 is true.
Reachability property qltransition_156 is true.
Reachability property qltransition_152 is true.
Reachability property qltransition_118 is true.
Reachability property qltransition_117 is true.
Reachability property qltransition_116 is true.
Reachability property qltransition_85 is true.
Reachability property qltransition_82 is true.
Reachability property qltransition_29 is true.
Reachability property qltransition_19 is true.
Reachability property qltransition_9 is true.
SDD proceeding with computation,114 properties remain. new max is 8
SDD size :96 after 200
Reachability property qltransition_153 is true.
Reachability property qltransition_148 is true.
Reachability property qltransition_123 is true.
Reachability property qltransition_122 is true.
Reachability property qltransition_121 is true.
Reachability property qltransition_86 is true.
SDD proceeding with computation,108 properties remain. new max is 8
SDD size :200 after 222
SDD proceeding with computation,108 properties remain. new max is 16
SDD size :222 after 227
BEST_FIRST walk for 4003 steps (8 resets) in 41 ms. (95 steps per ms) remains 52/52 properties
Reachability property qltransition_143 is true.
Reachability property qltransition_142 is true.
Reachability property qltransition_72 is true.
Reachability property qltransition_71 is true.
Reachability property qltransition_70 is true.
BEST_FIRST walk for 4003 steps (8 resets) in 31 ms. (125 steps per ms) remains 52/52 properties
Reachability property qltransition_39 is true.
Reachability property qltransition_38 is true.
Reachability property qltransition_37 is true.
Reachability property qltransition_36 is true.
Reachability property qltransition_35 is true.
SDD proceeding with computation,98 properties remain. new max is 16
SDD size :227 after 431
Reachability property qltransition_119 is true.
Reachability property qltransition_99 is true.
SDD proceeding with computation,96 properties remain. new max is 16
SDD size :431 after 495
SDD proceeding with computation,96 properties remain. new max is 32
SDD size :495 after 542
BEST_FIRST walk for 4004 steps (8 resets) in 29 ms. (133 steps per ms) remains 52/52 properties
Reachability property qltransition_124 is true.
Reachability property qltransition_67 is true.
Reachability property qltransition_62 is true.
Reachability property qltransition_57 is true.
SDD proceeding with computation,92 properties remain. new max is 32
SDD size :542 after 603
BEST_FIRST walk for 4003 steps (8 resets) in 20 ms. (190 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 21 ms. (182 steps per ms) remains 52/52 properties
Reachability property qltransition_163 is true.
Reachability property qltransition_158 is true.
Reachability property qltransition_87 is true.
BEST_FIRST walk for 4003 steps (8 resets) in 29 ms. (133 steps per ms) remains 52/52 properties
SDD proceeding with computation,89 properties remain. new max is 32
SDD size :603 after 642
BEST_FIRST walk for 4003 steps (8 resets) in 18 ms. (210 steps per ms) remains 52/52 properties
Reachability property qltransition_104 is true.
Reachability property qltransition_103 is true.
Reachability property qltransition_102 is true.
Reachability property qltransition_101 is true.
BEST_FIRST walk for 4002 steps (8 resets) in 23 ms. (166 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 18 ms. (210 steps per ms) remains 52/52 properties
SDD proceeding with computation,85 properties remain. new max is 32
SDD size :642 after 666
Reachability property qltransition_88 is true.
Reachability property qltransition_30 is true.
Reachability property qltransition_20 is true.
Reachability property qltransition_10 is true.
SDD proceeding with computation,81 properties remain. new max is 32
SDD size :666 after 723
BEST_FIRST walk for 4002 steps (8 resets) in 43 ms. (90 steps per ms) remains 52/52 properties
Reachability property qltransition_145 is true.
Reachability property qltransition_144 is true.
Reachability property qltransition_120 is true.
Reachability property qltransition_100 is true.
Reachability property qltransition_77 is true.
Reachability property qltransition_76 is true.
Reachability property qltransition_75 is true.
Reachability property qltransition_51 is true.
Reachability property qltransition_50 is true.
Reachability property qltransition_49 is true.
Reachability property qltransition_48 is true.
Reachability property qltransition_47 is true.
Reachability property qltransition_46 is true.
Reachability property qltransition_45 is true.
Reachability property qltransition_40 is true.
BEST_FIRST walk for 4003 steps (8 resets) in 43 ms. (90 steps per ms) remains 52/52 properties
SDD proceeding with computation,66 properties remain. new max is 32
SDD size :723 after 1297
Reachability property qltransition_125 is true.
SDD proceeding with computation,65 properties remain. new max is 32
SDD size :1297 after 1378
BEST_FIRST walk for 4002 steps (8 resets) in 34 ms. (114 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 26 ms. (148 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 19 ms. (200 steps per ms) remains 52/52 properties
Reachability property qltransition_31 is true.
Reachability property qltransition_21 is true.
Reachability property qltransition_11 is true.
SDD proceeding with computation,62 properties remain. new max is 32
SDD size :1378 after 1494
BEST_FIRST walk for 4003 steps (8 resets) in 26 ms. (148 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4001 steps (8 resets) in 39 ms. (100 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 25 ms. (154 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 23 ms. (166 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 19 ms. (200 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 32 ms. (121 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 30 ms. (129 steps per ms) remains 52/52 properties
Reachability property qltransition_41 is true.
SDD proceeding with computation,61 properties remain. new max is 32
SDD size :1494 after 1589
BEST_FIRST walk for 4002 steps (8 resets) in 42 ms. (93 steps per ms) remains 52/52 properties
SDD proceeding with computation,61 properties remain. new max is 64
SDD size :1589 after 1652
Reachability property qltransition_105 is true.
SDD proceeding with computation,60 properties remain. new max is 64
SDD size :1652 after 1989
BEST_FIRST walk for 4004 steps (8 resets) in 35 ms. (111 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4002 steps (8 resets) in 36 ms. (108 steps per ms) remains 52/52 properties
Reachability property qltransition_154 is true.
BEST_FIRST walk for 4003 steps (8 resets) in 32 ms. (121 steps per ms) remains 52/52 properties
Reachability property qltransition_149 is true.
BEST_FIRST walk for 4004 steps (8 resets) in 16 ms. (235 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 17 ms. (222 steps per ms) remains 52/52 properties
Reachability property qltransition_130 is true.
Reachability property qltransition_129 is true.
Reachability property qltransition_128 is true.
Reachability property qltransition_127 is true.
BEST_FIRST walk for 4002 steps (8 resets) in 33 ms. (117 steps per ms) remains 52/52 properties
Reachability property qltransition_126 is true.
BEST_FIRST walk for 4003 steps (8 resets) in 19 ms. (200 steps per ms) remains 52/52 properties
SDD proceeding with computation,53 properties remain. new max is 64
SDD size :1989 after 2176
BEST_FIRST walk for 4003 steps (8 resets) in 30 ms. (129 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 37 ms. (105 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4002 steps (8 resets) in 25 ms. (153 steps per ms) remains 52/52 properties
Reachability property qltransition_89 is true.
SDD proceeding with computation,52 properties remain. new max is 64
SDD size :2176 after 2255
BEST_FIRST walk for 4002 steps (8 resets) in 40 ms. (97 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 43 ms. (90 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4002 steps (8 resets) in 23 ms. (166 steps per ms) remains 52/52 properties
Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
petri\_inst\_inst,2268,0.543269,11348,2,2409,135,25581,58,0,399,14013,0
Total reachable state count : 2268

Verifying 161 reachability properties.
Reachability property qltransition_5 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_5,1,0.547716,11348,2,39,135,25581,59,0,407,14013,0
Reachability property qltransition_6 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_6,1,0.549636,11608,2,39,135,25581,60,0,410,14013,0
Reachability property qltransition_7 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_7,1,0.550294,11608,2,39,135,25581,61,0,413,14013,0
Reachability property qltransition_8 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_8,1,0.550919,11608,2,39,135,25581,62,0,416,14013,0
Reachability property qltransition_9 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_9,1,0.551454,11608,2,39,135,25581,63,0,418,14013,0
Reachability property qltransition_10 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_10,7,0.552818,11608,2,98,135,25581,64,0,421,14013,0
Reachability property qltransition_11 is true.

Model ,|S| ,Time ,Mem(kb) ,fin. SDD ,fin. DDD ,peak SDD ,peak DDD ,SDD Hom ,SDD cache peak ,DDD Hom ,DDD cachepeak ,SHom cache
qltransition\_11,3,0.553848,11608,2,54,135,25581,65,0,424,14013,0
Reachability property qltransition_12 does not hold.
ITS tools runner thread asked to quit. Dying gracefully.
BEST_FIRST walk for 4004 steps (8 resets) in 66 ms. (59 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 23 ms. (166 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 36 ms. (108 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4003 steps (8 resets) in 21 ms. (181 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 38 ms. (102 steps per ms) remains 52/52 properties
BEST_FIRST walk for 4004 steps (8 resets) in 24 ms. (160 steps per ms) remains 52/52 properties
FORMULA Liveness FALSE TECHNIQUES QUASILIVENESS_TEST
Total runtime 29509 ms.

BK_STOP 1716893836222

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

+ export BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
+ BINDIR=/home/mcc/BenchKit/bin//../itstools/bin//../
++ pwd
+ export MODEL=/home/mcc/execution
+ MODEL=/home/mcc/execution
+ [[ Liveness = StateSpace ]]
+ /home/mcc/BenchKit/bin//../itstools/bin//..//runeclipse.sh /home/mcc/execution Liveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800
+ ulimit -s 65536
+ [[ -z '' ]]
+ export LTSMIN_MEM_SIZE=8589934592
+ LTSMIN_MEM_SIZE=8589934592
+ export PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ PYTHONPATH=/home/mcc/BenchKit/itstools/pylibs
+ export LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
+ LD_LIBRARY_PATH=/home/mcc/BenchKit/itstools/pylibs:
++ sed s/.jar//
++ perl -pe 's/.*\.//g'
++ ls /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/plugins/fr.lip6.move.gal.application.pnmcc_1.0.0.202405141337.jar
+ VERSION=202405141337
+ echo 'Running Version 202405141337'
+ /home/mcc/BenchKit/bin//../itstools/bin//..//itstools/its-tools -pnfolder /home/mcc/execution -examination Liveness -its -ltsmin -greatspnpath /home/mcc/BenchKit/bin//../itstools/bin//..//greatspn/ -order META -manyOrder -smt -timeout 1800

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="SimpleLoadBal-PT-05"
export BK_EXAMINATION="Liveness"
export BK_TOOL="itstools"
export BK_RESULT_DIR="/tmp/BK_RESULTS/OUTPUTS"
export BK_TIME_CONFINEMENT="1800"
export BK_MEMORY_CONFINEMENT="16384"
export BK_BIN_PATH="/home/mcc/BenchKit/bin/"

# 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-5568"
echo " Executing tool itstools"
echo " Input is SimpleLoadBal-PT-05, examination is Liveness"
echo " Time confinement is $BK_TIME_CONFINEMENT seconds"
echo " Memory confinement is 16384 MBytes"
echo " Number of cores is 4"
echo " Run identifier is r387-smll-171683819400099"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/SimpleLoadBal-PT-05.tgz
mv SimpleLoadBal-PT-05 execution
cd execution
if [ "Liveness" = "ReachabilityDeadlock" ] || [ "Liveness" = "UpperBounds" ] || [ "Liveness" = "QuasiLiveness" ] || [ "Liveness" = "StableMarking" ] || [ "Liveness" = "Liveness" ] || [ "Liveness" = "OneSafe" ] || [ "Liveness" = "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 [ "Liveness" = "UpperBounds" ] ; then
echo "The expected result is a vector of positive values"
echo NUM_VECTOR
elif [ "Liveness" != "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 "Liveness.txt" ] ; then
echo "here is the order used to build the result vector(from text file)"
for x in $(grep Property Liveness.txt | cut -d ' ' -f 2 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ -f "Liveness.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 '' Liveness.xml | cut -d '>' -f 2 | cut -d '<' -f 1 | sort -u) ; do
echo "FORMULA_NAME $x"
done
elif [ "Liveness" = "ReachabilityDeadlock" ] || [ "Liveness" = "QuasiLiveness" ] || [ "Liveness" = "StableMarking" ] || [ "Liveness" = "Liveness" ] || [ "Liveness" = "OneSafe" ] ; then
echo "FORMULA_NAME Liveness"
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 ;