X-Git-Url: http://info.iut-bm.univ-fcomte.fr/pub/gitweb/simgrid.git/blobdiff_plain/2db874a22e378f03041d9c74aef756e03891ca19..290e19f26b10dc49485d7d7b06859edff32fd1e1:/examples/msg/masterslave/masterslave_bypass.tesh diff --git a/examples/msg/masterslave/masterslave_bypass.tesh b/examples/msg/masterslave/masterslave_bypass.tesh index 5dd5019eca..66e0838d2d 100644 --- a/examples/msg/masterslave/masterslave_bypass.tesh +++ b/examples/msg/masterslave/masterslave_bypass.tesh @@ -1,134 +1,135 @@ #! ./tesh p Testing the bypassing of the flexml parser -$ $SG_TEST_EXENV masterslave/masterslave_bypass --log=no_loc -> [0.000000] [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) 4.080000] [msg_test/INFO] Send completed -> [host A:master:(1) 4.080000] [msg_test/INFO] Sending "Task_1" to "host B" -> [host B:slave:(2) 4.080000] [msg_test/INFO] Received "Task_0" -> [host B:slave:(2) 4.080000] [msg_test/INFO] Processing "Task_0" -> [host B:slave:(2) 4.130000] [msg_test/INFO] "Task_0" done -> [host A:master:(1) 8.210000] [msg_test/INFO] Send completed -> [host A:master:(1) 8.210000] [msg_test/INFO] Sending "Task_2" to "host B" -> [host B:slave:(2) 8.210000] [msg_test/INFO] Received "Task_1" -> [host B:slave:(2) 8.210000] [msg_test/INFO] Processing "Task_1" -> [host B:slave:(2) 8.260000] [msg_test/INFO] "Task_1" done -> [host A:master:(1) 12.340000] [msg_test/INFO] Send completed -> [host A:master:(1) 12.340000] [msg_test/INFO] Sending "Task_3" to "host B" -> [host B:slave:(2) 12.340000] [msg_test/INFO] Received "Task_2" -> [host B:slave:(2) 12.340000] [msg_test/INFO] Processing "Task_2" -> [host B:slave:(2) 12.390000] [msg_test/INFO] "Task_2" done -> [host A:master:(1) 16.470000] [msg_test/INFO] Send completed -> [host A:master:(1) 16.470000] [msg_test/INFO] Sending "Task_4" to "host B" -> [host B:slave:(2) 16.470000] [msg_test/INFO] Received "Task_3" -> [host B:slave:(2) 16.470000] [msg_test/INFO] Processing "Task_3" -> [host B:slave:(2) 16.520000] [msg_test/INFO] "Task_3" done -> [host A:master:(1) 20.600000] [msg_test/INFO] Send completed -> [host A:master:(1) 20.600000] [msg_test/INFO] Sending "Task_5" to "host B" -> [host B:slave:(2) 20.600000] [msg_test/INFO] Received "Task_4" -> [host B:slave:(2) 20.600000] [msg_test/INFO] Processing "Task_4" -> [host B:slave:(2) 20.650000] [msg_test/INFO] "Task_4" done -> [host A:master:(1) 24.730000] [msg_test/INFO] Send completed -> [host A:master:(1) 24.730000] [msg_test/INFO] Sending "Task_6" to "host B" -> [host B:slave:(2) 24.730000] [msg_test/INFO] Received "Task_5" -> [host B:slave:(2) 24.730000] [msg_test/INFO] Processing "Task_5" -> [host B:slave:(2) 24.780000] [msg_test/INFO] "Task_5" done -> [host A:master:(1) 28.860000] [msg_test/INFO] Send completed -> [host A:master:(1) 28.860000] [msg_test/INFO] Sending "Task_7" to "host B" -> [host B:slave:(2) 28.860000] [msg_test/INFO] Received "Task_6" -> [host B:slave:(2) 28.860000] [msg_test/INFO] Processing "Task_6" -> [host B:slave:(2) 28.910000] [msg_test/INFO] "Task_6" done -> [host A:master:(1) 32.990000] [msg_test/INFO] Send completed -> [host A:master:(1) 32.990000] [msg_test/INFO] Sending "Task_8" to "host B" -> [host B:slave:(2) 32.990000] [msg_test/INFO] Received "Task_7" -> [host B:slave:(2) 32.990000] [msg_test/INFO] Processing "Task_7" -> [host B:slave:(2) 33.040000] [msg_test/INFO] "Task_7" done -> [host A:master:(1) 37.120000] [msg_test/INFO] Send completed -> [host A:master:(1) 37.120000] [msg_test/INFO] Sending "Task_9" to "host B" -> [host B:slave:(2) 37.120000] [msg_test/INFO] Received "Task_8" -> [host B:slave:(2) 37.120000] [msg_test/INFO] Processing "Task_8" -> [host B:slave:(2) 37.170000] [msg_test/INFO] "Task_8" done -> [host A:master:(1) 41.250000] [msg_test/INFO] Send completed -> [host A:master:(1) 41.250000] [msg_test/INFO] Sending "Task_10" to "host B" -> [host B:slave:(2) 41.250000] [msg_test/INFO] Received "Task_9" -> [host B:slave:(2) 41.250000] [msg_test/INFO] Processing "Task_9" -> [host B:slave:(2) 41.300000] [msg_test/INFO] "Task_9" done -> [host A:master:(1) 45.380000] [msg_test/INFO] Send completed -> [host A:master:(1) 45.380000] [msg_test/INFO] Sending "Task_11" to "host B" -> [host B:slave:(2) 45.380000] [msg_test/INFO] Received "Task_10" -> [host B:slave:(2) 45.380000] [msg_test/INFO] Processing "Task_10" -> [host B:slave:(2) 45.430000] [msg_test/INFO] "Task_10" done -> [host A:master:(1) 49.510000] [msg_test/INFO] Send completed -> [host A:master:(1) 49.510000] [msg_test/INFO] Sending "Task_12" to "host B" -> [host B:slave:(2) 49.510000] [msg_test/INFO] Received "Task_11" -> [host B:slave:(2) 49.510000] [msg_test/INFO] Processing "Task_11" -> [host B:slave:(2) 49.560000] [msg_test/INFO] "Task_11" done -> [host A:master:(1) 53.640000] [msg_test/INFO] Send completed -> [host A:master:(1) 53.640000] [msg_test/INFO] Sending "Task_13" to "host B" -> [host B:slave:(2) 53.640000] [msg_test/INFO] Received "Task_12" -> [host B:slave:(2) 53.640000] [msg_test/INFO] Processing "Task_12" -> [host B:slave:(2) 53.690000] [msg_test/INFO] "Task_12" done -> [host A:master:(1) 57.770000] [msg_test/INFO] Send completed -> [host A:master:(1) 57.770000] [msg_test/INFO] Sending "Task_14" to "host B" -> [host B:slave:(2) 57.770000] [msg_test/INFO] Received "Task_13" -> [host B:slave:(2) 57.770000] [msg_test/INFO] Processing "Task_13" -> [host B:slave:(2) 57.820000] [msg_test/INFO] "Task_13" done -> [host A:master:(1) 61.900000] [msg_test/INFO] Send completed -> [host A:master:(1) 61.900000] [msg_test/INFO] Sending "Task_15" to "host B" -> [host B:slave:(2) 61.900000] [msg_test/INFO] Received "Task_14" -> [host B:slave:(2) 61.900000] [msg_test/INFO] Processing "Task_14" -> [host B:slave:(2) 61.950000] [msg_test/INFO] "Task_14" done -> [host A:master:(1) 66.030000] [msg_test/INFO] Send completed -> [host A:master:(1) 66.030000] [msg_test/INFO] Sending "Task_16" to "host B" -> [host B:slave:(2) 66.030000] [msg_test/INFO] Received "Task_15" -> [host B:slave:(2) 66.030000] [msg_test/INFO] Processing "Task_15" -> [host B:slave:(2) 66.080000] [msg_test/INFO] "Task_15" done -> [host A:master:(1) 70.160000] [msg_test/INFO] Send completed -> [host A:master:(1) 70.160000] [msg_test/INFO] Sending "Task_17" to "host B" -> [host B:slave:(2) 70.160000] [msg_test/INFO] Received "Task_16" -> [host B:slave:(2) 70.160000] [msg_test/INFO] Processing "Task_16" -> [host B:slave:(2) 70.210000] [msg_test/INFO] "Task_16" done -> [host A:master:(1) 74.290000] [msg_test/INFO] Send completed -> [host A:master:(1) 74.290000] [msg_test/INFO] Sending "Task_18" to "host B" -> [host B:slave:(2) 74.290000] [msg_test/INFO] Received "Task_17" -> [host B:slave:(2) 74.290000] [msg_test/INFO] Processing "Task_17" -> [host B:slave:(2) 74.340000] [msg_test/INFO] "Task_17" done -> [host A:master:(1) 78.420000] [msg_test/INFO] Send completed -> [host A:master:(1) 78.420000] [msg_test/INFO] Sending "Task_19" to "host B" -> [host B:slave:(2) 78.420000] [msg_test/INFO] Received "Task_18" -> [host B:slave:(2) 78.420000] [msg_test/INFO] Processing "Task_18" -> [host B:slave:(2) 78.470000] [msg_test/INFO] "Task_18" done -> [host A:master:(1) 82.550000] [msg_test/INFO] Send completed -> [host A:master:(1) 82.550000] [msg_test/INFO] All tasks have been dispatched. Let's tell everybody the computation is over. -> [host B:slave:(2) 82.550000] [msg_test/INFO] Received "Task_19" -> [host B:slave:(2) 82.550000] [msg_test/INFO] Processing "Task_19" -> [host B:slave:(2) 82.600000] [msg_test/INFO] "Task_19" done -> [host A:master:(1) 84.680000] [msg_test/INFO] Goodbye now! -> [host B:slave:(2) 84.680000] [msg_test/INFO] Received "finalize" -> [host B:slave:(2) 84.680000] [msg_test/INFO] I'm done. See you! -> [84.680000] [msg_test/INFO] Simulation time 84.68 +! 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 +> [ 2.612825] (1:master@host A) Send completed +> [ 2.612825] (1:master@host A) Sending "Task_1" to "host B" +> [ 2.612825] (2:slave@host B) Received "Task_0" +> [ 2.612825] (2:slave@host B) Processing "Task_0" +> [ 2.662825] (2:slave@host B) "Task_0" done +> [ 5.275649] (1:master@host A) Send completed +> [ 5.275649] (1:master@host A) Sending "Task_2" to "host B" +> [ 5.275649] (2:slave@host B) Received "Task_1" +> [ 5.275649] (2:slave@host B) Processing "Task_1" +> [ 5.325649] (2:slave@host B) "Task_1" done +> [ 7.938474] (1:master@host A) Send completed +> [ 7.938474] (1:master@host A) Sending "Task_3" to "host B" +> [ 7.938474] (2:slave@host B) Received "Task_2" +> [ 7.938474] (2:slave@host B) Processing "Task_2" +> [ 7.988474] (2:slave@host B) "Task_2" done +> [ 10.601299] (1:master@host A) Send completed +> [ 10.601299] (1:master@host A) Sending "Task_4" to "host B" +> [ 10.601299] (2:slave@host B) Received "Task_3" +> [ 10.601299] (2:slave@host B) Processing "Task_3" +> [ 10.651299] (2:slave@host B) "Task_3" done +> [ 13.264124] (1:master@host A) Send completed +> [ 13.264124] (1:master@host A) Sending "Task_5" to "host B" +> [ 13.264124] (2:slave@host B) Received "Task_4" +> [ 13.264124] (2:slave@host B) Processing "Task_4" +> [ 13.314124] (2:slave@host B) "Task_4" done +> [ 15.926948] (1:master@host A) Send completed +> [ 15.926948] (1:master@host A) Sending "Task_6" to "host B" +> [ 15.926948] (2:slave@host B) Received "Task_5" +> [ 15.926948] (2:slave@host B) Processing "Task_5" +> [ 15.976948] (2:slave@host B) "Task_5" done +> [ 18.589773] (1:master@host A) Send completed +> [ 18.589773] (1:master@host A) Sending "Task_7" to "host B" +> [ 18.589773] (2:slave@host B) Received "Task_6" +> [ 18.589773] (2:slave@host B) Processing "Task_6" +> [ 18.639773] (2:slave@host B) "Task_6" done +> [ 21.252598] (1:master@host A) Send completed +> [ 21.252598] (1:master@host A) Sending "Task_8" to "host B" +> [ 21.252598] (2:slave@host B) Received "Task_7" +> [ 21.252598] (2:slave@host B) Processing "Task_7" +> [ 21.302598] (2:slave@host B) "Task_7" done +> [ 23.915423] (1:master@host A) Send completed +> [ 23.915423] (1:master@host A) Sending "Task_9" to "host B" +> [ 23.915423] (2:slave@host B) Received "Task_8" +> [ 23.915423] (2:slave@host B) Processing "Task_8" +> [ 23.965423] (2:slave@host B) "Task_8" done +> [ 26.578247] (1:master@host A) Send completed +> [ 26.578247] (1:master@host A) Sending "Task_10" to "host B" +> [ 26.578247] (2:slave@host B) Received "Task_9" +> [ 26.578247] (2:slave@host B) Processing "Task_9" +> [ 26.628247] (2:slave@host B) "Task_9" done +> [ 29.241072] (1:master@host A) Send completed +> [ 29.241072] (1:master@host A) Sending "Task_11" to "host B" +> [ 29.241072] (2:slave@host B) Received "Task_10" +> [ 29.241072] (2:slave@host B) Processing "Task_10" +> [ 29.291072] (2:slave@host B) "Task_10" done +> [ 31.903897] (1:master@host A) Send completed +> [ 31.903897] (1:master@host A) Sending "Task_12" to "host B" +> [ 31.903897] (2:slave@host B) Received "Task_11" +> [ 31.903897] (2:slave@host B) Processing "Task_11" +> [ 31.953897] (2:slave@host B) "Task_11" done +> [ 34.566722] (1:master@host A) Send completed +> [ 34.566722] (1:master@host A) Sending "Task_13" to "host B" +> [ 34.566722] (2:slave@host B) Received "Task_12" +> [ 34.566722] (2:slave@host B) Processing "Task_12" +> [ 34.616722] (2:slave@host B) "Task_12" done +> [ 37.229546] (1:master@host A) Send completed +> [ 37.229546] (1:master@host A) Sending "Task_14" to "host B" +> [ 37.229546] (2:slave@host B) Received "Task_13" +> [ 37.229546] (2:slave@host B) Processing "Task_13" +> [ 37.279546] (2:slave@host B) "Task_13" done +> [ 39.892371] (1:master@host A) Send completed +> [ 39.892371] (1:master@host A) Sending "Task_15" to "host B" +> [ 39.892371] (2:slave@host B) Received "Task_14" +> [ 39.892371] (2:slave@host B) Processing "Task_14" +> [ 39.942371] (2:slave@host B) "Task_14" done +> [ 42.555196] (1:master@host A) Send completed +> [ 42.555196] (1:master@host A) Sending "Task_16" to "host B" +> [ 42.555196] (2:slave@host B) Received "Task_15" +> [ 42.555196] (2:slave@host B) Processing "Task_15" +> [ 42.605196] (2:slave@host B) "Task_15" done +> [ 45.218021] (1:master@host A) Send completed +> [ 45.218021] (1:master@host A) Sending "Task_17" to "host B" +> [ 45.218021] (2:slave@host B) Received "Task_16" +> [ 45.218021] (2:slave@host B) Processing "Task_16" +> [ 45.268021] (2:slave@host B) "Task_16" done +> [ 47.880845] (1:master@host A) Send completed +> [ 47.880845] (1:master@host A) Sending "Task_18" to "host B" +> [ 47.880845] (2:slave@host B) Received "Task_17" +> [ 47.880845] (2:slave@host B) Processing "Task_17" +> [ 47.930845] (2:slave@host B) "Task_17" done +> [ 50.543670] (1:master@host A) Send completed +> [ 50.543670] (1:master@host A) Sending "Task_19" to "host B" +> [ 50.543670] (2:slave@host B) Received "Task_18" +> [ 50.543670] (2:slave@host B) Processing "Task_18" +> [ 50.593670] (2:slave@host B) "Task_18" done +> [ 53.206495] (1:master@host A) Send completed +> [ 53.206495] (1:master@host A) All tasks have been dispatched. Let's tell everybody the computation is over. +> [ 53.206495] (2:slave@host B) Received "Task_19" +> [ 53.206495] (2:slave@host B) Processing "Task_19" +> [ 53.256495] (2:slave@host B) "Task_19" done +> [ 55.858495] (0:@) Simulation time 55.8585 +> [ 55.858495] (1:master@host A) Goodbye now! +> [ 55.858495] (2:slave@host B) Received "finalize" +> [ 55.858495] (2:slave@host B) I'm done. See you!