#! ./tesh
p Testing the bypassing of the flexml parser
-
-$ $SG_TEST_EXENV masterslave/masterslave_bypass
-> [0.000000] surf/surfxml_parse.c:447: [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
+> [ 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!
