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.r396-smll-171683824700114.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 gold2023
Input is SimpleLoadBal-PT-20, examination is Liveness
Time confinement is 1800 seconds
Memory confinement is 16384 MBytes
Number of cores is 4
Run identifier is r396-smll-171683824700114
=====================================================================

--------------------
preparation of the directory to be used:
/home/mcc/execution
total 2.4M
-rw-r--r-- 1 mcc users 11K May 14 13:22 CTLCardinality.txt
-rw-r--r-- 1 mcc users 93K May 14 13:22 CTLCardinality.xml
-rw-r--r-- 1 mcc users 7.2K May 14 13:22 CTLFireability.txt
-rw-r--r-- 1 mcc users 51K 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 4.7K Apr 23 07:57 LTLCardinality.txt
-rw-r--r-- 1 mcc users 26K Apr 23 07:57 LTLCardinality.xml
-rw-r--r-- 1 mcc users 2.8K May 19 07:33 LTLFireability.txt
-rw-r--r-- 1 mcc users 16K May 19 19:20 LTLFireability.xml
-rw-r--r-- 1 mcc users 12K Apr 13 12:01 ReachabilityCardinality.txt
-rw-r--r-- 1 mcc users 94K Apr 13 12:01 ReachabilityCardinality.xml
-rw-r--r-- 1 mcc users 12K Apr 13 12:00 ReachabilityFireability.txt
-rw-r--r-- 1 mcc users 68K Apr 13 12:00 ReachabilityFireability.xml
-rw-r--r-- 1 mcc users 1.7K May 19 07:16 UpperBounds.txt
-rw-r--r-- 1 mcc users 3.9K May 19 15:31 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 2.0M 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 1716913083859

bash -c /home/mcc/BenchKit/BenchKit_head.sh 2> STDERR ; echo ; echo -n "BK_STOP " ; date -u +%s%3N
Invoking MCC driver with
BK_TOOL=gold2023
BK_EXAMINATION=Liveness
BK_BIN_PATH=/home/mcc/BenchKit/bin/
BK_TIME_CONFINEMENT=1800
BK_INPUT=SimpleLoadBal-PT-20
Not applying reductions.
Model is PT
Liveness PT
Running Version 202304061127
[2024-05-28 16:18:07] [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 16:18:07] [INFO ] Parsing pnml file : /home/mcc/execution/model.pnml
[2024-05-28 16:18:08] [INFO ] Load time of PNML (sax parser for PT used): 310 ms
[2024-05-28 16:18:08] [INFO ] Transformed 194 places.
[2024-05-28 16:18:08] [INFO ] Transformed 2205 transitions.
[2024-05-28 16:18:08] [INFO ] Found NUPN structural information;
[2024-05-28 16:18:08] [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_idle_6, P_client_idle_7, P_client_idle_8, P_client_idle_9, P_client_idle_10, P_client_idle_11, P_client_idle_12, P_client_idle_13, P_client_idle_14, P_client_idle_15, P_client_idle_16, P_client_idle_17, P_client_idle_18, P_client_idle_19, P_client_idle_20, P_client_waiting_1, P_client_waiting_2, P_client_waiting_3, P_client_waiting_4, P_client_waiting_5, P_client_waiting_6, P_client_waiting_7, P_client_waiting_8, P_client_waiting_9, P_client_waiting_10, P_client_waiting_11, P_client_waiting_12, P_client_waiting_13, P_client_waiting_14, P_client_waiting_15, P_client_waiting_16, P_client_waiting_17, P_client_waiting_18, P_client_waiting_19, P_client_waiting_20, P_client_request_1, P_client_request_2, P_client_request_3, P_client_request_4, P_client_request_5, P_client_request_6, P_client_request_7, P_client_request_8, P_client_request_9, P_client_request_10, P_client_request_11, P_client_request_12, P_client_request_13, P_client_request_14, P_client_request_15, P_client_request_16, P_client_request_17, P_client_request_18, P_client_request_19, P_client_request_20, P_client_ack_1, P_client_ack_2, P_client_ack_3, P_client_ack_4, P_client_ack_5, P_client_ack_6, P_client_ack_7, P_client_ack_8, P_client_ack_9, P_client_ack_10, P_client_ack_11, P_client_ack_12, P_client_ack_13, P_client_ack_14, P_client_ack_15, P_client_ack_16, P_client_ack_17, P_client_ack_18, P_client_ack_19, P_client_ack_20, 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_server_request_6_1, P_server_request_6_2, P_server_request_7_1, P_server_request_7_2, P_server_request_8_1, P_server_request_8_2, P_server_request_9_1, P_server_request_9_2, P_server_request_10_1, P_server_request_10_2, P_server_request_11_1, P_server_request_11_2, P_server_request_12_1, P_server_request_12_2, P_server_request_13_1, P_server_request_13_2, P_server_request_14_1, P_server_request_14_2, P_server_request_15_1, P_server_request_15_2, P_server_request_16_1, P_server_request_16_2, P_server_request_17_1, P_server_request_17_2, P_server_request_18_1, P_server_request_18_2, P_server_request_19_1, P_server_request_19_2, P_server_request_20_1, P_server_request_20_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_routing_1_6, P_lb_routing_1_7, P_lb_routing_1_8, P_lb_routing_1_9, P_lb_routing_1_10, P_lb_routing_1_11, P_lb_routing_1_12, P_lb_routing_1_13, P_lb_routing_1_14, P_lb_routing_1_15, P_lb_routing_1_16, P_lb_routing_1_17, P_lb_routing_1_18, P_lb_routing_1_19, P_lb_routing_1_20, 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_1_6, P_lb_load_1_7, P_lb_load_1_8, P_lb_load_1_9, P_lb_load_1_10, P_lb_load_1_11, P_lb_load_1_12, P_lb_load_1_13, P_lb_load_1_14, P_lb_load_1_15, P_lb_load_1_16, P_lb_load_1_17, P_lb_load_1_18, P_lb_load_1_19, P_lb_load_1_20, 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, P_lb_load_2_6, P_lb_load_2_7, P_lb_load_2_8, P_lb_load_2_9, P_lb_load_2_10, P_lb_load_2_11, P_lb_load_2_12, P_lb_load_2_13, P_lb_load_2_14, P_lb_load_2_15, P_lb_load_2_16, P_lb_load_2_17, P_lb_load_2_18, P_lb_load_2_19, P_lb_load_2_20]
[2024-05-28 16:18:08] [INFO ] Parsed PT model containing 194 places and 2205 transitions and 15678 arcs in 476 ms.
Built sparse matrix representations for Structural reductions in 37 ms.20169KB memory used
Starting structural reductions in DEADLOCK mode, iteration 0 : 194/194 places, 2205/2205 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 404 ms. Remains 194 /194 variables (removed 0) and now considering 2205/2205 (removed 0) transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 405 ms. Remains : 194/194 places, 2205/2205 transitions.
Starting structural reductions in DEADLOCK mode, iteration 0 : 194/194 places, 2205/2205 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 172 ms. Remains 194 /194 variables (removed 0) and now considering 2205/2205 (removed 0) transitions.
[2024-05-28 16:18:09] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:18:09] [INFO ] Invariants computation overflowed in 80 ms
[2024-05-28 16:18:09] [INFO ] Implicit Places using invariants in 372 ms returned []
[2024-05-28 16:18:09] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:18:09] [INFO ] Invariants computation overflowed in 15 ms
[2024-05-28 16:18:10] [INFO ] Implicit Places using invariants and state equation in 623 ms returned []
Implicit Place search using SMT with State Equation took 1036 ms to find 0 implicit places.
[2024-05-28 16:18:10] [INFO ] Redundant transitions in 191 ms returned []
[2024-05-28 16:18:10] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:18:10] [INFO ] Invariants computation overflowed in 16 ms
[2024-05-28 16:18:12] [INFO ] Dead Transitions using invariants and state equation in 1489 ms found 0 transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 2897 ms. Remains : 194/194 places, 2205/2205 transitions.
Random walk for 1250000 steps, including 0 resets, run took 13581 ms (no deadlock found). (steps per millisecond=92 )
Random directed walk for 1250002 steps, including 0 resets, run took 13391 ms (no deadlock found). (steps per millisecond=93 )
[2024-05-28 16:18:38] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:18:39] [INFO ] Invariants computation overflowed in 11 ms
[2024-05-28 16:18:39] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2024-05-28 16:18:40] [INFO ] [Real]Absence check using state equation in 771 ms returned sat
[2024-05-28 16:18:40] [INFO ] Solution in real domain found non-integer solution.
[2024-05-28 16:18:41] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2024-05-28 16:18:42] [INFO ] [Nat]Absence check using state equation in 1041 ms returned sat
[2024-05-28 16:18:42] [INFO ] State equation strengthened by 820 read => feed constraints.
[2024-05-28 16:18:42] [INFO ] [Nat]Added 820 Read/Feed constraints in 653 ms returned sat
[2024-05-28 16:18:43] [INFO ] Deduced a trap composed of 24 places in 674 ms of which 7 ms to minimize.
[2024-05-28 16:18:44] [INFO ] Deduced a trap composed of 24 places in 779 ms of which 3 ms to minimize.
[2024-05-28 16:18:45] [INFO ] Deduced a trap composed of 25 places in 753 ms of which 3 ms to minimize.
[2024-05-28 16:18:46] [INFO ] Deduced a trap composed of 25 places in 712 ms of which 4 ms to minimize.
[2024-05-28 16:18:47] [INFO ] Deduced a trap composed of 27 places in 576 ms of which 3 ms to minimize.
[2024-05-28 16:18:47] [INFO ] Deduced a trap composed of 25 places in 539 ms of which 1 ms to minimize.
[2024-05-28 16:18:48] [INFO ] Deduced a trap composed of 29 places in 432 ms of which 1 ms to minimize.
[2024-05-28 16:18:48] [INFO ] Deduced a trap composed of 30 places in 562 ms of which 2 ms to minimize.
[2024-05-28 16:18:49] [INFO ] Deduced a trap composed of 24 places in 579 ms of which 1 ms to minimize.
[2024-05-28 16:18:50] [INFO ] Deduced a trap composed of 27 places in 683 ms of which 1 ms to minimize.
[2024-05-28 16:18:51] [INFO ] Deduced a trap composed of 24 places in 715 ms of which 1 ms to minimize.
[2024-05-28 16:18:52] [INFO ] Deduced a trap composed of 26 places in 694 ms of which 1 ms to minimize.
[2024-05-28 16:18:53] [INFO ] Deduced a trap composed of 28 places in 579 ms of which 1 ms to minimize.
[2024-05-28 16:18:53] [INFO ] Deduced a trap composed of 26 places in 545 ms of which 1 ms to minimize.
[2024-05-28 16:18:54] [INFO ] Deduced a trap composed of 30 places in 634 ms of which 1 ms to minimize.
[2024-05-28 16:18:55] [INFO ] Deduced a trap composed of 28 places in 646 ms of which 1 ms to minimize.
[2024-05-28 16:18:56] [INFO ] Deduced a trap composed of 24 places in 631 ms of which 1 ms to minimize.
[2024-05-28 16:18:57] [INFO ] Deduced a trap composed of 30 places in 622 ms of which 1 ms to minimize.
[2024-05-28 16:18:58] [INFO ] Deduced a trap composed of 30 places in 634 ms of which 1 ms to minimize.
[2024-05-28 16:18:58] [INFO ] Deduced a trap composed of 30 places in 635 ms of which 1 ms to minimize.
[2024-05-28 16:18:59] [INFO ] Deduced a trap composed of 30 places in 627 ms of which 1 ms to minimize.
[2024-05-28 16:19:00] [INFO ] Deduced a trap composed of 30 places in 644 ms of which 1 ms to minimize.
[2024-05-28 16:19:01] [INFO ] Deduced a trap composed of 26 places in 616 ms of which 1 ms to minimize.
[2024-05-28 16:19:02] [INFO ] Deduced a trap composed of 30 places in 623 ms of which 1 ms to minimize.
[2024-05-28 16:19:02] [INFO ] Deduced a trap composed of 30 places in 493 ms of which 1 ms to minimize.
[2024-05-28 16:19:03] [INFO ] Deduced a trap composed of 30 places in 520 ms of which 0 ms to minimize.
[2024-05-28 16:19:04] [INFO ] Deduced a trap composed of 26 places in 551 ms of which 1 ms to minimize.
[2024-05-28 16:19:04] [INFO ] Deduced a trap composed of 30 places in 530 ms of which 1 ms to minimize.
[2024-05-28 16:19:05] [INFO ] Deduced a trap composed of 30 places in 379 ms of which 1 ms to minimize.
[2024-05-28 16:19:05] [INFO ] Deduced a trap composed of 30 places in 487 ms of which 1 ms to minimize.
[2024-05-28 16:19:06] [INFO ] Deduced a trap composed of 26 places in 519 ms of which 1 ms to minimize.
[2024-05-28 16:19:07] [INFO ] Deduced a trap composed of 30 places in 589 ms of which 1 ms to minimize.
[2024-05-28 16:19:08] [INFO ] Deduced a trap composed of 26 places in 537 ms of which 1 ms to minimize.
[2024-05-28 16:19:10] [INFO ] Deduced a trap composed of 27 places in 418 ms of which 2 ms to minimize.
[2024-05-28 16:19:10] [INFO ] Deduced a trap composed of 27 places in 696 ms of which 5 ms to minimize.
[2024-05-28 16:19:13] [INFO ] Trap strengthening (SAT) tested/added 35/35 trap constraints in 30966 ms
Parikh directed walk for 34800 steps, including 1000 resets, run took 335 ms. (steps per millisecond=103 )
Random directed walk for 500002 steps, including 0 resets, run took 5589 ms (no deadlock found). (steps per millisecond=89 )
Random walk for 500000 steps, including 0 resets, run took 4977 ms (no deadlock found). (steps per millisecond=100 )
Random directed walk for 500001 steps, including 0 resets, run took 5375 ms (no deadlock found). (steps per millisecond=93 )
Random walk for 500000 steps, including 0 resets, run took 4924 ms (no deadlock found). (steps per millisecond=101 )
Starting structural reductions in DEADLOCK mode, iteration 0 : 194/194 places, 2205/2205 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 101 ms. Remains 194 /194 variables (removed 0) and now considering 2205/2205 (removed 0) transitions.
[2024-05-28 16:19:35] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:19:35] [INFO ] Invariants computation overflowed in 14 ms
[2024-05-28 16:19:35] [INFO ] Implicit Places using invariants in 69 ms returned []
[2024-05-28 16:19:35] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:19:35] [INFO ] Invariants computation overflowed in 8 ms
[2024-05-28 16:19:35] [INFO ] State equation strengthened by 820 read => feed constraints.
[2024-05-28 16:19:36] [INFO ] Implicit Places using invariants and state equation in 850 ms returned []
Implicit Place search using SMT with State Equation took 921 ms to find 0 implicit places.
[2024-05-28 16:19:36] [INFO ] Redundant transitions in 299 ms returned []
[2024-05-28 16:19:36] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:19:36] [INFO ] Invariants computation overflowed in 15 ms
[2024-05-28 16:19:37] [INFO ] Dead Transitions using invariants and state equation in 1408 ms found 0 transitions.
Finished structural reductions in DEADLOCK mode , in 1 iterations and 2752 ms. Remains : 194/194 places, 2205/2205 transitions.
Random walk for 1250000 steps, including 0 resets, run took 13177 ms (no deadlock found). (steps per millisecond=94 )
Random directed walk for 1250000 steps, including 0 resets, run took 14084 ms (no deadlock found). (steps per millisecond=88 )
[2024-05-28 16:20:05] [INFO ] Flow matrix only has 1745 transitions (discarded 460 similar events)
// Phase 1: matrix 1745 rows 194 cols
[2024-05-28 16:20:05] [INFO ] Invariants computation overflowed in 14 ms
[2024-05-28 16:20:05] [INFO ] [Real]Adding state equation constraints to refine reachable states.
[2024-05-28 16:20:06] [INFO ] [Real]Absence check using state equation in 657 ms returned sat
[2024-05-28 16:20:06] [INFO ] Solution in real domain found non-integer solution.
[2024-05-28 16:20:06] [INFO ] [Nat]Adding state equation constraints to refine reachable states.
[2024-05-28 16:20:07] [INFO ] [Nat]Absence check using state equation in 817 ms returned sat
[2024-05-28 16:20:07] [INFO ] State equation strengthened by 820 read => feed constraints.
[2024-05-28 16:20:08] [INFO ] [Nat]Added 820 Read/Feed constraints in 644 ms returned sat
[2024-05-28 16:20:09] [INFO ] Deduced a trap composed of 24 places in 500 ms of which 2 ms to minimize.
[2024-05-28 16:20:09] [INFO ] Deduced a trap composed of 24 places in 708 ms of which 1 ms to minimize.
[2024-05-28 16:20:10] [INFO ] Deduced a trap composed of 25 places in 720 ms of which 1 ms to minimize.
[2024-05-28 16:20:11] [INFO ] Deduced a trap composed of 25 places in 690 ms of which 1 ms to minimize.
[2024-05-28 16:20:12] [INFO ] Deduced a trap composed of 27 places in 685 ms of which 15 ms to minimize.
[2024-05-28 16:20:13] [INFO ] Deduced a trap composed of 25 places in 726 ms of which 1 ms to minimize.
[2024-05-28 16:20:14] [INFO ] Deduced a trap composed of 29 places in 699 ms of which 0 ms to minimize.
[2024-05-28 16:20:15] [INFO ] Deduced a trap composed of 30 places in 713 ms of which 1 ms to minimize.
[2024-05-28 16:20:15] [INFO ] Deduced a trap composed of 24 places in 696 ms of which 1 ms to minimize.
[2024-05-28 16:20:16] [INFO ] Deduced a trap composed of 27 places in 711 ms of which 1 ms to minimize.
[2024-05-28 16:20:17] [INFO ] Deduced a trap composed of 24 places in 711 ms of which 3 ms to minimize.
[2024-05-28 16:20:18] [INFO ] Deduced a trap composed of 26 places in 697 ms of which 1 ms to minimize.
[2024-05-28 16:20:19] [INFO ] Deduced a trap composed of 28 places in 604 ms of which 1 ms to minimize.
[2024-05-28 16:20:20] [INFO ] Deduced a trap composed of 26 places in 622 ms of which 1 ms to minimize.
[2024-05-28 16:20:21] [INFO ] Deduced a trap composed of 30 places in 622 ms of which 1 ms to minimize.
[2024-05-28 16:20:21] [INFO ] Deduced a trap composed of 28 places in 559 ms of which 1 ms to minimize.
[2024-05-28 16:20:22] [INFO ] Deduced a trap composed of 24 places in 514 ms of which 1 ms to minimize.
[2024-05-28 16:20:23] [INFO ] Deduced a trap composed of 30 places in 630 ms of which 1 ms to minimize.
[2024-05-28 16:20:24] [INFO ] Deduced a trap composed of 30 places in 581 ms of which 1 ms to minimize.
[2024-05-28 16:20:24] [INFO ] Deduced a trap composed of 30 places in 611 ms of which 1 ms to minimize.
[2024-05-28 16:20:25] [INFO ] Deduced a trap composed of 30 places in 623 ms of which 1 ms to minimize.
[2024-05-28 16:20:26] [INFO ] Deduced a trap composed of 30 places in 639 ms of which 2 ms to minimize.
[2024-05-28 16:20:27] [INFO ] Deduced a trap composed of 26 places in 603 ms of which 1 ms to minimize.
[2024-05-28 16:20:28] [INFO ] Deduced a trap composed of 30 places in 617 ms of which 1 ms to minimize.
[2024-05-28 16:20:28] [INFO ] Deduced a trap composed of 30 places in 626 ms of which 1 ms to minimize.
[2024-05-28 16:20:29] [INFO ] Deduced a trap composed of 30 places in 604 ms of which 1 ms to minimize.
[2024-05-28 16:20:30] [INFO ] Deduced a trap composed of 26 places in 621 ms of which 1 ms to minimize.
[2024-05-28 16:20:31] [INFO ] Deduced a trap composed of 30 places in 632 ms of which 1 ms to minimize.
[2024-05-28 16:20:31] [INFO ] Deduced a trap composed of 30 places in 630 ms of which 1 ms to minimize.
[2024-05-28 16:20:32] [INFO ] Deduced a trap composed of 30 places in 582 ms of which 1 ms to minimize.
[2024-05-28 16:20:33] [INFO ] Deduced a trap composed of 26 places in 609 ms of which 1 ms to minimize.
[2024-05-28 16:20:34] [INFO ] Deduced a trap composed of 30 places in 588 ms of which 7 ms to minimize.
[2024-05-28 16:20:35] [INFO ] Deduced a trap composed of 26 places in 473 ms of which 10 ms to minimize.
[2024-05-28 16:20:37] [INFO ] Deduced a trap composed of 27 places in 493 ms of which 2 ms to minimize.
[2024-05-28 16:20:37] [INFO ] Deduced a trap composed of 27 places in 555 ms of which 1 ms to minimize.
[2024-05-28 16:20:40] [INFO ] Trap strengthening (SAT) tested/added 35/35 trap constraints in 32271 ms
Parikh directed walk for 34800 steps, including 1000 resets, run took 361 ms. (steps per millisecond=96 )
Random directed walk for 500000 steps, including 0 resets, run took 6465 ms (no deadlock found). (steps per millisecond=77 )
Random walk for 500000 steps, including 0 resets, run took 5048 ms (no deadlock found). (steps per millisecond=99 )
Random directed walk for 500000 steps, including 0 resets, run took 5695 ms (no deadlock found). (steps per millisecond=87 )
Random walk for 500000 steps, including 0 resets, run took 5284 ms (no deadlock found). (steps per millisecond=94 )
[2024-05-28 16:21:04] [INFO ] Flatten gal took : 559 ms
Starting structural reductions in LIVENESS mode, iteration 0 : 194/194 places, 2205/2205 transitions.
Performed 2 Post agglomeration using F-continuation condition.Transition count delta: 2
Deduced a syphon composed of 2 places in 4 ms
Reduce places removed 2 places and 0 transitions.
Iterating global reduction 0 with 4 rules applied. Total rules applied 4 place count 192 transition count 2203
Performed 20 Post agglomeration using F-continuation condition.Transition count delta: 20
Deduced a syphon composed of 20 places in 9 ms
Reduce places removed 40 places and 0 transitions.
Iterating global reduction 0 with 60 rules applied. Total rules applied 64 place count 152 transition count 2183
Performed 20 Post agglomeration using F-continuation condition.Transition count delta: 20
Deduced a syphon composed of 20 places in 9 ms
Reduce places removed 20 places and 0 transitions.
Iterating global reduction 0 with 40 rules applied. Total rules applied 104 place count 132 transition count 2163
Applied a total of 104 rules in 91 ms. Remains 132 /194 variables (removed 62) and now considering 2163/2205 (removed 42) transitions.
[2024-05-28 16:21:04] [INFO ] Flow matrix only has 1703 transitions (discarded 460 similar events)
// Phase 1: matrix 1703 rows 132 cols
[2024-05-28 16:21:04] [INFO ] Invariants computation overflowed in 8 ms
[2024-05-28 16:21:05] [INFO ] Implicit Places using invariants in 487 ms returned []
[2024-05-28 16:21:05] [INFO ] Flow matrix only has 1703 transitions (discarded 460 similar events)
// Phase 1: matrix 1703 rows 132 cols
[2024-05-28 16:21:05] [INFO ] Invariants computation overflowed in 13 ms
[2024-05-28 16:21:06] [INFO ] Implicit Places using invariants and state equation in 1108 ms returned []
Implicit Place search using SMT with State Equation took 1600 ms to find 0 implicit places.
[2024-05-28 16:21:06] [INFO ] Flow matrix only has 1703 transitions (discarded 460 similar events)
// Phase 1: matrix 1703 rows 132 cols
[2024-05-28 16:21:06] [INFO ] Invariants computation overflowed in 12 ms
[2024-05-28 16:21:07] [INFO ] Dead Transitions using invariants and state equation in 1635 ms found 0 transitions.
Starting structural reductions in LIVENESS mode, iteration 1 : 132/194 places, 2163/2205 transitions.
Finished structural reductions in LIVENESS mode , in 1 iterations and 3329 ms. Remains : 132/194 places, 2163/2205 transitions.
Initial state reduction rules removed 20 formulas.
[2024-05-28 16:21:08] [INFO ] Flatten gal took : 278 ms
[2024-05-28 16:21:08] [INFO ] Flatten gal took : 502 ms
[2024-05-28 16:21:09] [INFO ] Time to serialize gal into /tmp/ReachabilityCardinality13111600923184021579.gal : 139 ms
[2024-05-28 16:21:09] [INFO ] Time to serialize properties into /tmp/ReachabilityCardinality8893968753432262453.prop : 76 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.202304061127/bin/its-reach-linux64' '--gc-threshold' '2000000' '--quiet' '-i' '/tmp/ReachabilityCardinality13111600923184021579.gal' '-t' 'CGAL' '-reachable-file' '/tmp/ReachabilityCardinality8893968753432262453.prop' '--nowitness' '--gen-order' 'FOLLOW'

its-reach command run as :

/home/mcc/BenchKit/itstools/itstools/plugins/fr.lip6.move.gal.itstools.binaries_1.0.0.202304061127/bin/its-reach-linux64 --gc-threshold 2000000 --quiet ...329
Loading property file /tmp/ReachabilityCardinality8893968753432262453.prop.
Reachability property qltransition_2145 is true.
Reachability property qltransition_2143 is true.
Reachability property qltransition_2141 is true.
Reachability property qltransition_2133 is true.
Reachability property qltransition_2131 is true.
Reachability property qltransition_2129 is true.
Reachability property qltransition_2127 is true.
Reachability property qltransition_2125 is true.
Reachability property qltransition_2123 is true.
Reachability property qltransition_1222 is true.
Reachability property qltransition_462 is true.
Reachability property qltransition_422 is true.
Reachability property qltransition_382 is true.
Reachability property qltransition_222 is true.
Reachability property qltransition_182 is true.
Reachability property qltransition_142 is true.
Reachability property qltransition_102 is true.
Reachability property qltransition_62 is true.
Reachability property qltransition_22 is true.
SDD proceeding with computation,2124 properties remain. new max is 2
SDD size :1 after 20
Reachability property qltransition_1262 is true.
Reachability property qltransition_1042 is true.
Reachability property qltransition_1022 is true.
Reachability property qltransition_1002 is true.
Reachability property qltransition_922 is true.
Reachability property qltransition_902 is true.
Reachability property qltransition_882 is true.
Reachability property qltransition_862 is true.
Reachability property qltransition_842 is true.
Reachability property qltransition_822 is true.
Reachability property qltransition_0 is true.
SDD proceeding with computation,2113 properties remain. new max is 2
SDD size :20 after 103
Reachability property qltransition_2146 is true.
Reachability property qltransition_2144 is true.
Reachability property qltransition_2142 is true.
Reachability property qltransition_2134 is true.
Reachability property qltransition_2132 is true.
Reachability property qltransition_2130 is true.
Reachability property qltransition_2128 is true.
Reachability property qltransition_2126 is true.
Reachability property qltransition_2124 is true.
Reachability property qltransition_1242 is true.
SDD proceeding with computation,2103 properties remain. new max is 2
SDD size :103 after 187
SDD proceeding with computation,2103 properties remain. new max is 4
SDD size :187 after 189
SDD proceeding with computation,2103 properties remain. new max is 8
SDD size :189 after 190
SDD proceeding with computation,2103 properties remain. new max is 16
SDD size :190 after 191
SDD proceeding with computation,2103 properties remain. new max is 32
SDD size :191 after 193
Incomplete random walk after 10000 steps, including 2 resets, run finished after 3247 ms. (steps per millisecond=3 ) properties (out of 2143) seen :593
SDD proceeding with computation,2103 properties remain. new max is 64
SDD size :193 after 195
Running SMT prover for 1544 properties.
[2024-05-28 16:21:11] [INFO ] Flow matrix only has 1703 transitions (discarded 460 similar events)
// Phase 1: matrix 1703 rows 132 cols
[2024-05-28 16:21:11] [INFO ] Invariants computation overflowed in 11 ms
Reachability property qltransition_2103 is true.
Reachability property qltransition_2083 is true.
Reachability property qltransition_1264 is true.
Reachability property qltransition_1263 is true.
Reachability property qltransition_464 is true.
Reachability property qltransition_424 is true.
Reachability property qltransition_384 is true.
Reachability property qltransition_224 is true.
Reachability property qltransition_184 is true.
Reachability property qltransition_144 is true.
Reachability property qltransition_104 is true.
Reachability property qltransition_64 is true.
Reachability property qltransition_24 is true.
Reachability property qltransition_1 is true.
SDD proceeding with computation,2089 properties remain. new max is 64
SDD size :195 after 893
SDD proceeding with computation,2089 properties remain. new max is 128
SDD size :893 after 898
Reachability property qltransition_2084 is true.
Reachability property qltransition_1714 is true.
Reachability property qltransition_1713 is true.
Reachability property qltransition_1712 is true.
Reachability property qltransition_1708 is true.
Reachability property qltransition_1707 is true.
Reachability property qltransition_1706 is true.
Reachability property qltransition_1705 is true.
Reachability property qltransition_1704 is true.
Reachability property qltransition_1703 is true.
Reachability property qltransition_1265 is true.
Reachability property qltransition_1223 is true.
Reachability property qltransition_1043 is true.
Reachability property qltransition_1023 is true.
Reachability property qltransition_1003 is true.
Reachability property qltransition_923 is true.
Reachability property qltransition_903 is true.
Reachability property qltransition_883 is true.
Reachability property qltransition_863 is true.
Reachability property qltransition_843 is true.
Reachability property qltransition_823 is true.
Reachability property qltransition_463 is true.
Reachability property qltransition_423 is true.
Reachability property qltransition_383 is true.
Reachability property qltransition_223 is true.
Reachability property qltransition_183 is true.
Reachability property qltransition_143 is true.
Reachability property qltransition_103 is true.
Reachability property qltransition_63 is true.
Reachability property qltransition_23 is true.
SDD proceeding with computation,2059 properties remain. new max is 128
SDD size :898 after 4141
SDD proceeding with computation,2059 properties remain. new max is 256
SDD size :4141 after 4173
SDD proceeding with computation,2059 properties remain. new max is 512
SDD size :4173 after 4219
Reachability property qltransition_2104 is true.
Reachability property qltransition_1267 is true.
Reachability property qltransition_1266 is true.
Reachability property qltransition_1243 is true.
Reachability property qltransition_466 is true.
Reachability property qltransition_426 is true.
Reachability property qltransition_386 is true.
Reachability property qltransition_226 is true.
Reachability property qltransition_186 is true.
Reachability property qltransition_146 is true.
Reachability property qltransition_106 is true.
Reachability property qltransition_66 is true.
Reachability property qltransition_26 is true.
SDD proceeding with computation,2046 properties remain. new max is 512
SDD size :4219 after 15143
SDD proceeding with computation,2046 properties remain. new max is 1024
SDD size :15143 after 15383
Reachability property qltransition_1334 is true.
Reachability property qltransition_1333 is true.
Reachability property qltransition_1332 is true.
Reachability property qltransition_1327 is true.
Reachability property qltransition_1326 is true.
Reachability property qltransition_1325 is true.
Reachability property qltransition_1324 is true.
Reachability property qltransition_1323 is true.
SDD proceeding with computation,2038 properties remain. new max is 1024
SDD size :15383 after 15874
Reachability property qltransition_2085 is true.
Reachability property qltransition_1734 is true.
Reachability property qltransition_1733 is true.
Reachability property qltransition_1732 is true.
Reachability property qltransition_1728 is true.
Reachability property qltransition_1727 is true.
Reachability property qltransition_1726 is true.
Reachability property qltransition_1725 is true.
Reachability property qltransition_1724 is true.
Reachability property qltransition_1723 is true.
Reachability property qltransition_1328 is true.
Reachability property qltransition_1268 is true.
Reachability property qltransition_1224 is true.
Reachability property qltransition_1044 is true.
Reachability property qltransition_1024 is true.
Reachability property qltransition_1004 is true.
Reachability property qltransition_924 is true.
Reachability property qltransition_904 is true.
Reachability property qltransition_884 is true.
Reachability property qltransition_864 is true.
Reachability property qltransition_844 is true.
Reachability property qltransition_824 is true.
Reachability property qltransition_465 is true.
Reachability property qltransition_425 is true.
Reachability property qltransition_385 is true.
Reachability property qltransition_225 is true.
Reachability property qltransition_185 is true.
Reachability property qltransition_145 is true.
Reachability property qltransition_105 is true.
Reachability property qltransition_65 is true.
Reachability property qltransition_25 is true.
SDD proceeding with computation,2007 properties remain. new max is 1024
SDD size :15874 after 44307
SDD proceeding with computation,2007 properties remain. new max is 2048
SDD size :44307 after 45412
Reachability property qltransition_2105 is true.
Reachability property qltransition_1270 is true.
Reachability property qltransition_1269 is true.
Reachability property qltransition_1244 is true.
Reachability property qltransition_468 is true.
Reachability property qltransition_428 is true.
Reachability property qltransition_388 is true.
Reachability property qltransition_228 is true.
Reachability property qltransition_188 is true.
Reachability property qltransition_148 is true.
Reachability property qltransition_108 is true.
Reachability property qltransition_68 is true.
Reachability property qltransition_28 is true.
SDD proceeding with computation,1994 properties remain. new max is 2048
SDD size :45412 after 89642
Reachability property qltransition_1354 is true.
Reachability property qltransition_1353 is true.
Reachability property qltransition_1352 is true.
Reachability property qltransition_1347 is true.
Reachability property qltransition_1346 is true.
Reachability property qltransition_1345 is true.
Reachability property qltransition_1344 is true.
Reachability property qltransition_1343 is true.
SDD proceeding with computation,1986 properties remain. new max is 2048
SDD size :89642 after 93833
SDD proceeding with computation,1986 properties remain. new max is 4096
SDD size :93833 after 95805
[2024-05-28 16:21:55] [INFO ] After 9535ms SMT Verify possible using state equation in real domain returned unsat :90 sat :1386 real:68
[2024-05-28 16:21:55] [INFO ] State equation strengthened by 820 read => feed constraints.
java.lang.RuntimeException: SMT solver raised an error when submitting script. Raised (error "Failed to assert expression: java.io.IOException: Stream close...
at fr.lip6.move.gal.structural.smt.SMTUtils.execAndCheckResult(SMTUtils.java:251)
at fr.lip6.move.gal.structural.smt.DeadlockTester.verifyPossible(DeadlockTester.java:645)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMTIncremental(DeadlockTester.java:342)
at fr.lip6.move.gal.structural.smt.DeadlockTester.testUnreachableWithSMT(DeadlockTester.java:226)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.applyReductions(ReachabilitySolver.java:96)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.applyReachabilitySolver(GlobalPropertySolver.java:724)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.solveProperty(GlobalPropertySolver.java:558)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.preSolveLiveness(GlobalPropertySolver.java:399)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.preStableMarking(GlobalPropertySolver.java:321)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.solveProperty(GlobalPropertySolver.java:294)
at fr.lip6.move.gal.application.Application.startNoEx(Application.java:426)
at fr.lip6.move.gal.application.Application.start(Application.java:182)
at fr.lip6.move.gal.itscl.application.Application.start(Application.java:45)
at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:136)
at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:104)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:402)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:659)
at org.eclipse.equinox.launcher.Main.basicRun(Main.java:596)
at org.eclipse.equinox.launcher.Main.run(Main.java:1467)
at org.eclipse.equinox.launcher.Main.main(Main.java:1440)
[2024-05-28 16:21:55] [WARNING] SMT solver failed with error :SMT solver raised an error when submitting script.... while checking expressions.
[2024-05-28 16:21:55] [INFO ] After 25058ms SMT Verify possible using all constraints in real domain returned unsat :0 sat :0
ITS runner failed with exception null
java.lang.InterruptedException
at java.base/java.lang.Object.wait(Native Method)
at java.base/java.lang.Thread.join(Thread.java:1304)
at java.base/java.lang.Thread.join(Thread.java:1372)
at fr.lip6.move.gal.application.runner.AbstractRunner.join(AbstractRunner.java:27)
at fr.lip6.move.gal.application.runner.its.ITSRunner.join(ITSRunner.java:177)
at fr.lip6.move.gal.application.solver.global.GlobalPropertySolver.verifyWithSDD(GlobalPropertySolver.java:675)
at fr.lip6.move.gal.application.solver.ReachabilitySolver.lambda$2(ReachabilitySolver.java:63)
at java.base/java.lang.Thread.run(Thread.java:833)
FORMULA Liveness FALSE TECHNIQUES QUASILIVENESS_TEST
Total runtime 227813 ms.

BK_STOP 1716913317100

--------------------
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.202304061127.jar
+ VERSION=202304061127
+ echo 'Running Version 202304061127'
+ /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-20"
export BK_EXAMINATION="Liveness"
export BK_TOOL="gold2023"
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 gold2023"
echo " Input is SimpleLoadBal-PT-20, 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 r396-smll-171683824700114"
echo "====================================================================="
echo
echo "--------------------"
echo "preparation of the directory to be used:"

tar xzf /home/mcc/BenchKit/INPUTS/SimpleLoadBal-PT-20.tgz
mv SimpleLoadBal-PT-20 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 ;