X-Git-Url: http://info.iut-bm.univ-fcomte.fr/pub/gitweb/simgrid.git/blobdiff_plain/7b1e594eae3a15ebd76c3938b82d0eef2a265cd7..c5ad8ca1a68bbaa9152471c8d0eeb99d762f0d86:/examples/msg/masterslave/masterslave_bypass.tesh diff --git a/examples/msg/masterslave/masterslave_bypass.tesh b/examples/msg/masterslave/masterslave_bypass.tesh index af74940e6d..89f8b5612e 100644 --- a/examples/msg/masterslave/masterslave_bypass.tesh +++ b/examples/msg/masterslave/masterslave_bypass.tesh @@ -1,135 +1,135 @@ #! ./tesh p Testing the bypassing of the flexml parser - -$ $SG_TEST_EXENV masterslave/masterslave_bypass -> [0.000000] surf/surfxml_parse.c:237: [surf_parse/WARNING] Bypassing the XML parser since surf_parse_open received a NULL pointer. If it is not what you want, go fix your code. -> [host A:master:(1) 0.000000] [msg_test/INFO] Got 1 slave(s) : -> [host A:master:(1) 0.000000] [msg_test/INFO] host B -> [host A:master:(1) 0.000000] [msg_test/INFO] Got 20 task to process : -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_0" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_1" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_2" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_3" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_4" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_5" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_6" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_7" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_8" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_9" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_10" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_11" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_12" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_13" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_14" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_15" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_16" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_17" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_18" -> [host A:master:(1) 0.000000] [msg_test/INFO] "Task_19" -> [host A:master:(1) 0.000000] [msg_test/INFO] Sending "Task_0" to "host B" -> [host B:slave:(2) 0.000000] [msg_test/INFO] I'm a slave -> [host A:master:(1) 2.200000] [msg_test/INFO] Send completed -> [host A:master:(1) 2.200000] [msg_test/INFO] Sending "Task_1" to "host B" -> [host B:slave:(2) 2.200000] [msg_test/INFO] Received "Task_0" -> [host B:slave:(2) 2.200000] [msg_test/INFO] Processing "Task_0" -> [host B:slave:(2) 2.250000] [msg_test/INFO] "Task_0" done -> [host A:master:(1) 4.450000] [msg_test/INFO] Send completed -> [host A:master:(1) 4.450000] [msg_test/INFO] Sending "Task_2" to "host B" -> [host B:slave:(2) 4.450000] [msg_test/INFO] Received "Task_1" -> [host B:slave:(2) 4.450000] [msg_test/INFO] Processing "Task_1" -> [host B:slave:(2) 4.500000] [msg_test/INFO] "Task_1" done -> [host A:master:(1) 6.700000] [msg_test/INFO] Send completed -> [host A:master:(1) 6.700000] [msg_test/INFO] Sending "Task_3" to "host B" -> [host B:slave:(2) 6.700000] [msg_test/INFO] Received "Task_2" -> [host B:slave:(2) 6.700000] [msg_test/INFO] Processing "Task_2" -> [host B:slave:(2) 6.750000] [msg_test/INFO] "Task_2" done -> [host A:master:(1) 8.950000] [msg_test/INFO] Send completed -> [host A:master:(1) 8.950000] [msg_test/INFO] Sending "Task_4" to "host B" -> [host B:slave:(2) 8.950000] [msg_test/INFO] Received "Task_3" -> [host B:slave:(2) 8.950000] [msg_test/INFO] Processing "Task_3" -> [host B:slave:(2) 9.000000] [msg_test/INFO] "Task_3" done -> [host A:master:(1) 11.200000] [msg_test/INFO] Send completed -> [host A:master:(1) 11.200000] [msg_test/INFO] Sending "Task_5" to "host B" -> [host B:slave:(2) 11.200000] [msg_test/INFO] Received "Task_4" -> [host B:slave:(2) 11.200000] [msg_test/INFO] Processing "Task_4" -> [host B:slave:(2) 11.250000] [msg_test/INFO] "Task_4" done -> [host A:master:(1) 13.450000] [msg_test/INFO] Send completed -> [host A:master:(1) 13.450000] [msg_test/INFO] Sending "Task_6" to "host B" -> [host B:slave:(2) 13.450000] [msg_test/INFO] Received "Task_5" -> [host B:slave:(2) 13.450000] [msg_test/INFO] Processing "Task_5" -> [host B:slave:(2) 13.500000] [msg_test/INFO] "Task_5" done -> [host A:master:(1) 15.700000] [msg_test/INFO] Send completed -> [host A:master:(1) 15.700000] [msg_test/INFO] Sending "Task_7" to "host B" -> [host B:slave:(2) 15.700000] [msg_test/INFO] Received "Task_6" -> [host B:slave:(2) 15.700000] [msg_test/INFO] Processing "Task_6" -> [host B:slave:(2) 15.750000] [msg_test/INFO] "Task_6" done -> [host A:master:(1) 17.950000] [msg_test/INFO] Send completed -> [host A:master:(1) 17.950000] [msg_test/INFO] Sending "Task_8" to "host B" -> [host B:slave:(2) 17.950000] [msg_test/INFO] Received "Task_7" -> [host B:slave:(2) 17.950000] [msg_test/INFO] Processing "Task_7" -> [host B:slave:(2) 18.000000] [msg_test/INFO] "Task_7" done -> [host A:master:(1) 20.200000] [msg_test/INFO] Send completed -> [host A:master:(1) 20.200000] [msg_test/INFO] Sending "Task_9" to "host B" -> [host B:slave:(2) 20.200000] [msg_test/INFO] Received "Task_8" -> [host B:slave:(2) 20.200000] [msg_test/INFO] Processing "Task_8" -> [host B:slave:(2) 20.250000] [msg_test/INFO] "Task_8" done -> [host A:master:(1) 22.450000] [msg_test/INFO] Send completed -> [host A:master:(1) 22.450000] [msg_test/INFO] Sending "Task_10" to "host B" -> [host B:slave:(2) 22.450000] [msg_test/INFO] Received "Task_9" -> [host B:slave:(2) 22.450000] [msg_test/INFO] Processing "Task_9" -> [host B:slave:(2) 22.500000] [msg_test/INFO] "Task_9" done -> [host A:master:(1) 24.700000] [msg_test/INFO] Send completed -> [host A:master:(1) 24.700000] [msg_test/INFO] Sending "Task_11" to "host B" -> [host B:slave:(2) 24.700000] [msg_test/INFO] Received "Task_10" -> [host B:slave:(2) 24.700000] [msg_test/INFO] Processing "Task_10" -> [host B:slave:(2) 24.750000] [msg_test/INFO] "Task_10" done -> [host A:master:(1) 26.950000] [msg_test/INFO] Send completed -> [host A:master:(1) 26.950000] [msg_test/INFO] Sending "Task_12" to "host B" -> [host B:slave:(2) 26.950000] [msg_test/INFO] Received "Task_11" -> [host B:slave:(2) 26.950000] [msg_test/INFO] Processing "Task_11" -> [host B:slave:(2) 27.000000] [msg_test/INFO] "Task_11" done -> [host A:master:(1) 29.200000] [msg_test/INFO] Send completed -> [host A:master:(1) 29.200000] [msg_test/INFO] Sending "Task_13" to "host B" -> [host B:slave:(2) 29.200000] [msg_test/INFO] Received "Task_12" -> [host B:slave:(2) 29.200000] [msg_test/INFO] Processing "Task_12" -> [host B:slave:(2) 29.250000] [msg_test/INFO] "Task_12" done -> [host A:master:(1) 31.450000] [msg_test/INFO] Send completed -> [host A:master:(1) 31.450000] [msg_test/INFO] Sending "Task_14" to "host B" -> [host B:slave:(2) 31.450000] [msg_test/INFO] Received "Task_13" -> [host B:slave:(2) 31.450000] [msg_test/INFO] Processing "Task_13" -> [host B:slave:(2) 31.500000] [msg_test/INFO] "Task_13" done -> [host A:master:(1) 33.700000] [msg_test/INFO] Send completed -> [host A:master:(1) 33.700000] [msg_test/INFO] Sending "Task_15" to "host B" -> [host B:slave:(2) 33.700000] [msg_test/INFO] Received "Task_14" -> [host B:slave:(2) 33.700000] [msg_test/INFO] Processing "Task_14" -> [host B:slave:(2) 33.750000] [msg_test/INFO] "Task_14" done -> [host A:master:(1) 35.950000] [msg_test/INFO] Send completed -> [host A:master:(1) 35.950000] [msg_test/INFO] Sending "Task_16" to "host B" -> [host B:slave:(2) 35.950000] [msg_test/INFO] Received "Task_15" -> [host B:slave:(2) 35.950000] [msg_test/INFO] Processing "Task_15" -> [host B:slave:(2) 36.000000] [msg_test/INFO] "Task_15" done -> [host A:master:(1) 38.200000] [msg_test/INFO] Send completed -> [host A:master:(1) 38.200000] [msg_test/INFO] Sending "Task_17" to "host B" -> [host B:slave:(2) 38.200000] [msg_test/INFO] Received "Task_16" -> [host B:slave:(2) 38.200000] [msg_test/INFO] Processing "Task_16" -> [host B:slave:(2) 38.250000] [msg_test/INFO] "Task_16" done -> [host A:master:(1) 40.450000] [msg_test/INFO] Send completed -> [host A:master:(1) 40.450000] [msg_test/INFO] Sending "Task_18" to "host B" -> [host B:slave:(2) 40.450000] [msg_test/INFO] Received "Task_17" -> [host B:slave:(2) 40.450000] [msg_test/INFO] Processing "Task_17" -> [host B:slave:(2) 40.500000] [msg_test/INFO] "Task_17" done -> [host A:master:(1) 42.700000] [msg_test/INFO] Send completed -> [host A:master:(1) 42.700000] [msg_test/INFO] Sending "Task_19" to "host B" -> [host B:slave:(2) 42.700000] [msg_test/INFO] Received "Task_18" -> [host B:slave:(2) 42.700000] [msg_test/INFO] Processing "Task_18" -> [host B:slave:(2) 42.750000] [msg_test/INFO] "Task_18" done -> [host A:master:(1) 44.950000] [msg_test/INFO] Send completed -> [host A:master:(1) 44.950000] [msg_test/INFO] All tasks have been dispatched. Let's tell everybody the computation is over. -> [host B:slave:(2) 44.950000] [msg_test/INFO] Received "Task_19" -> [host B:slave:(2) 44.950000] [msg_test/INFO] Processing "Task_19" -> [host B:slave:(2) 45.000000] [msg_test/INFO] "Task_19" done -> [host A:master:(1) 45.200000] [msg_test/INFO] Goodbye now! -> [host B:slave:(2) 45.200000] [msg_test/INFO] Received "finalize" -> [host B:slave:(2) 45.200000] [msg_test/INFO] I'm done. See you! -> [45.200000] [msg_test/INFO] Simulation time 45.2 +! output sort +$ $SG_TEST_EXENV masterslave/masterslave_bypass --log=no_loc "--log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n" +> [ 0.000000] (0:@) Bypassing the XML parser since surf_parse_open received a NULL pointer. If it is not what you want, go fix your code. +> [ 0.000000] (1:master@host A) Got 1 slave(s) : +> [ 0.000000] (1:master@host A) host B +> [ 0.000000] (1:master@host A) Got 20 task to process : +> [ 0.000000] (1:master@host A) "Task_0" +> [ 0.000000] (1:master@host A) "Task_1" +> [ 0.000000] (1:master@host A) "Task_2" +> [ 0.000000] (1:master@host A) "Task_3" +> [ 0.000000] (1:master@host A) "Task_4" +> [ 0.000000] (1:master@host A) "Task_5" +> [ 0.000000] (1:master@host A) "Task_6" +> [ 0.000000] (1:master@host A) "Task_7" +> [ 0.000000] (1:master@host A) "Task_8" +> [ 0.000000] (1:master@host A) "Task_9" +> [ 0.000000] (1:master@host A) "Task_10" +> [ 0.000000] (1:master@host A) "Task_11" +> [ 0.000000] (1:master@host A) "Task_12" +> [ 0.000000] (1:master@host A) "Task_13" +> [ 0.000000] (1:master@host A) "Task_14" +> [ 0.000000] (1:master@host A) "Task_15" +> [ 0.000000] (1:master@host A) "Task_16" +> [ 0.000000] (1:master@host A) "Task_17" +> [ 0.000000] (1:master@host A) "Task_18" +> [ 0.000000] (1:master@host A) "Task_19" +> [ 0.000000] (1:master@host A) Sending "Task_0" to "host B" +> [ 0.000000] (2:slave@host B) I'm a slave +> [ 4.602000] (1:master@host A) Send completed +> [ 4.602000] (1:master@host A) Sending "Task_1" to "host B" +> [ 4.602000] (2:slave@host B) Received "Task_0" +> [ 4.602000] (2:slave@host B) Processing "Task_0" +> [ 4.652000] (2:slave@host B) "Task_0" done +> [ 9.254000] (1:master@host A) Send completed +> [ 9.254000] (1:master@host A) Sending "Task_2" to "host B" +> [ 9.254000] (2:slave@host B) Received "Task_1" +> [ 9.254000] (2:slave@host B) Processing "Task_1" +> [ 9.304000] (2:slave@host B) "Task_1" done +> [ 13.906000] (1:master@host A) Send completed +> [ 13.906000] (1:master@host A) Sending "Task_3" to "host B" +> [ 13.906000] (2:slave@host B) Received "Task_2" +> [ 13.906000] (2:slave@host B) Processing "Task_2" +> [ 13.956000] (2:slave@host B) "Task_2" done +> [ 18.558000] (1:master@host A) Send completed +> [ 18.558000] (1:master@host A) Sending "Task_4" to "host B" +> [ 18.558000] (2:slave@host B) Received "Task_3" +> [ 18.558000] (2:slave@host B) Processing "Task_3" +> [ 18.608000] (2:slave@host B) "Task_3" done +> [ 23.210000] (1:master@host A) Send completed +> [ 23.210000] (1:master@host A) Sending "Task_5" to "host B" +> [ 23.210000] (2:slave@host B) Received "Task_4" +> [ 23.210000] (2:slave@host B) Processing "Task_4" +> [ 23.260000] (2:slave@host B) "Task_4" done +> [ 27.862000] (1:master@host A) Send completed +> [ 27.862000] (1:master@host A) Sending "Task_6" to "host B" +> [ 27.862000] (2:slave@host B) Received "Task_5" +> [ 27.862000] (2:slave@host B) Processing "Task_5" +> [ 27.912000] (2:slave@host B) "Task_5" done +> [ 32.514000] (1:master@host A) Send completed +> [ 32.514000] (1:master@host A) Sending "Task_7" to "host B" +> [ 32.514000] (2:slave@host B) Received "Task_6" +> [ 32.514000] (2:slave@host B) Processing "Task_6" +> [ 32.564000] (2:slave@host B) "Task_6" done +> [ 37.166000] (1:master@host A) Send completed +> [ 37.166000] (1:master@host A) Sending "Task_8" to "host B" +> [ 37.166000] (2:slave@host B) Received "Task_7" +> [ 37.166000] (2:slave@host B) Processing "Task_7" +> [ 37.216000] (2:slave@host B) "Task_7" done +> [ 41.818000] (1:master@host A) Send completed +> [ 41.818000] (1:master@host A) Sending "Task_9" to "host B" +> [ 41.818000] (2:slave@host B) Received "Task_8" +> [ 41.818000] (2:slave@host B) Processing "Task_8" +> [ 41.868000] (2:slave@host B) "Task_8" done +> [ 46.470000] (1:master@host A) Send completed +> [ 46.470000] (1:master@host A) Sending "Task_10" to "host B" +> [ 46.470000] (2:slave@host B) Received "Task_9" +> [ 46.470000] (2:slave@host B) Processing "Task_9" +> [ 46.520000] (2:slave@host B) "Task_9" done +> [ 51.122000] (1:master@host A) Send completed +> [ 51.122000] (1:master@host A) Sending "Task_11" to "host B" +> [ 51.122000] (2:slave@host B) Received "Task_10" +> [ 51.122000] (2:slave@host B) Processing "Task_10" +> [ 51.172000] (2:slave@host B) "Task_10" done +> [ 55.774000] (1:master@host A) Send completed +> [ 55.774000] (1:master@host A) Sending "Task_12" to "host B" +> [ 55.774000] (2:slave@host B) Received "Task_11" +> [ 55.774000] (2:slave@host B) Processing "Task_11" +> [ 55.824000] (2:slave@host B) "Task_11" done +> [ 60.426000] (1:master@host A) Send completed +> [ 60.426000] (1:master@host A) Sending "Task_13" to "host B" +> [ 60.426000] (2:slave@host B) Received "Task_12" +> [ 60.426000] (2:slave@host B) Processing "Task_12" +> [ 60.476000] (2:slave@host B) "Task_12" done +> [ 65.078000] (1:master@host A) Send completed +> [ 65.078000] (1:master@host A) Sending "Task_14" to "host B" +> [ 65.078000] (2:slave@host B) Received "Task_13" +> [ 65.078000] (2:slave@host B) Processing "Task_13" +> [ 65.128000] (2:slave@host B) "Task_13" done +> [ 69.730000] (1:master@host A) Send completed +> [ 69.730000] (1:master@host A) Sending "Task_15" to "host B" +> [ 69.730000] (2:slave@host B) Received "Task_14" +> [ 69.730000] (2:slave@host B) Processing "Task_14" +> [ 69.780000] (2:slave@host B) "Task_14" done +> [ 74.382000] (1:master@host A) Send completed +> [ 74.382000] (1:master@host A) Sending "Task_16" to "host B" +> [ 74.382000] (2:slave@host B) Received "Task_15" +> [ 74.382000] (2:slave@host B) Processing "Task_15" +> [ 74.432000] (2:slave@host B) "Task_15" done +> [ 79.034000] (1:master@host A) Send completed +> [ 79.034000] (1:master@host A) Sending "Task_17" to "host B" +> [ 79.034000] (2:slave@host B) Received "Task_16" +> [ 79.034000] (2:slave@host B) Processing "Task_16" +> [ 79.084000] (2:slave@host B) "Task_16" done +> [ 83.686000] (1:master@host A) Send completed +> [ 83.686000] (1:master@host A) Sending "Task_18" to "host B" +> [ 83.686000] (2:slave@host B) Received "Task_17" +> [ 83.686000] (2:slave@host B) Processing "Task_17" +> [ 83.736000] (2:slave@host B) "Task_17" done +> [ 88.338000] (1:master@host A) Send completed +> [ 88.338000] (1:master@host A) Sending "Task_19" to "host B" +> [ 88.338000] (2:slave@host B) Received "Task_18" +> [ 88.338000] (2:slave@host B) Processing "Task_18" +> [ 88.388000] (2:slave@host B) "Task_18" done +> [ 92.990000] (1:master@host A) Send completed +> [ 92.990000] (1:master@host A) All tasks have been dispatched. Let's tell everybody the computation is over. +> [ 92.990000] (2:slave@host B) Received "Task_19" +> [ 92.990000] (2:slave@host B) Processing "Task_19" +> [ 93.040000] (2:slave@host B) "Task_19" done +> [ 95.642000] (0:@) Simulation time 95.642 +> [ 95.642000] (1:master@host A) Goodbye now! +> [ 95.642000] (2:slave@host B) Received "finalize" +> [ 95.642000] (2:slave@host B) I'm done. See you!