examples/msg/masterslave/masterslave_cpu_ti.tesh

   1 #! ./tesh
   2
   3 p Testing a simple master/slave example application
   4
   5 ! output sort
   6 $ $SG_TEST_EXENV ${bindir:=.}/masterslave_forwarder$EXEEXT small_platform.xml masterslave/deployment_masterslave.xml --cfg=cpu/optim:TI "--log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n"
   7 > [  0.000000] (0:@) Configuration change: Set 'cpu/optim' to 'TI'
   8 > [  0.000000] (1:master@Tremblay) Got 5 slaves and 20 tasks to process
   9 > [  0.000000] (1:master@Tremblay) Sending "Task_0" to "Jupiter"
  10 > [  0.165962] (1:master@Tremblay) Sent
  11 > [  0.165962] (1:master@Tremblay) Sending "Task_1" to "Fafard"
  12 > [  0.165962] (3:slave@Jupiter) Received "Task_0"
  13 > [  0.165962] (3:slave@Jupiter) Processing "Task_0"
  14 > [  0.384115] (1:master@Tremblay) Sent
  15 > [  0.384115] (1:master@Tremblay) Sending "Task_2" to "Ginette"
  16 > [  0.384115] (4:slave@Fafard) Received "Task_1"
  17 > [  0.384115] (4:slave@Fafard) Processing "Task_1"
  18 > [  0.524575] (1:master@Tremblay) Sent
  19 > [  0.524575] (1:master@Tremblay) Sending "Task_3" to "Bourassa"
  20 > [  0.524575] (5:slave@Ginette) Received "Task_2"
  21 > [  0.524575] (5:slave@Ginette) Processing "Task_2"
  22 > [  0.740447] (1:master@Tremblay) Sent
  23 > [  0.740447] (1:master@Tremblay) Sending "Task_4" to "Tremblay"
  24 > [  0.740447] (1:master@Tremblay) Hey ! It's me ! :)
  25 > [  0.740447] (6:slave@Bourassa) Received "Task_3"
  26 > [  0.740447] (6:slave@Bourassa) Processing "Task_3"
  27 > [  0.742786] (1:master@Tremblay) Sent
  28 > [  0.742786] (1:master@Tremblay) Sending "Task_5" to "Jupiter"
  29 > [  0.742786] (2:slave@Tremblay) Received "Task_4"
  30 > [  0.742786] (2:slave@Tremblay) Processing "Task_4"
  31 > [  0.821304] (3:slave@Jupiter) "Task_0" done
  32 > [  0.987266] (1:master@Tremblay) Sent
  33 > [  0.987266] (1:master@Tremblay) Sending "Task_6" to "Fafard"
  34 > [  0.987266] (3:slave@Jupiter) Received "Task_5"
  35 > [  0.987266] (3:slave@Jupiter) Processing "Task_5"
  36 > [  1.039457] (4:slave@Fafard) "Task_1" done
  37 > [  1.252495] (2:slave@Tremblay) "Task_4" done
  38 > [  1.257610] (1:master@Tremblay) Sent
  39 > [  1.257610] (1:master@Tremblay) Sending "Task_7" to "Ginette"
  40 > [  1.257610] (4:slave@Fafard) Received "Task_6"
  41 > [  1.257610] (4:slave@Fafard) Processing "Task_6"
  42 > [  1.555672] (5:slave@Ginette) "Task_2" done
  43 > [  1.642608] (3:slave@Jupiter) "Task_5" done
  44 > [  1.696132] (1:master@Tremblay) Sent
  45 > [  1.696132] (1:master@Tremblay) Sending "Task_8" to "Bourassa"
  46 > [  1.696132] (5:slave@Ginette) Received "Task_7"
  47 > [  1.696132] (5:slave@Ginette) Processing "Task_7"
  48 > [  1.771545] (6:slave@Bourassa) "Task_3" done
  49 > [  1.912953] (4:slave@Fafard) "Task_6" done
  50 > [  1.987417] (1:master@Tremblay) Sent
  51 > [  1.987417] (1:master@Tremblay) Sending "Task_9" to "Tremblay"
  52 > [  1.987417] (1:master@Tremblay) Hey ! It's me ! :)
  53 > [  1.987417] (6:slave@Bourassa) Received "Task_8"
  54 > [  1.987417] (6:slave@Bourassa) Processing "Task_8"
  55 > [  1.989756] (1:master@Tremblay) Sent
  56 > [  1.989756] (1:master@Tremblay) Sending "Task_10" to "Jupiter"
  57 > [  1.989756] (2:slave@Tremblay) Received "Task_9"
  58 > [  1.989756] (2:slave@Tremblay) Processing "Task_9"
  59 > [  2.155718] (1:master@Tremblay) Sent
  60 > [  2.155718] (1:master@Tremblay) Sending "Task_11" to "Fafard"
  61 > [  2.155718] (3:slave@Jupiter) Received "Task_10"
  62 > [  2.155718] (3:slave@Jupiter) Processing "Task_10"
  63 > [  2.373871] (1:master@Tremblay) Sent
  64 > [  2.373871] (1:master@Tremblay) Sending "Task_12" to "Ginette"
  65 > [  2.373871] (4:slave@Fafard) Received "Task_11"
  66 > [  2.373871] (4:slave@Fafard) Processing "Task_11"
  67 > [  2.499466] (2:slave@Tremblay) "Task_9" done
  68 > [  2.727230] (5:slave@Ginette) "Task_7" done
  69 > [  2.811060] (3:slave@Jupiter) "Task_10" done
  70 > [  2.867690] (1:master@Tremblay) Sent
  71 > [  2.867690] (1:master@Tremblay) Sending "Task_13" to "Bourassa"
  72 > [  2.867690] (5:slave@Ginette) Received "Task_12"
  73 > [  2.867690] (5:slave@Ginette) Processing "Task_12"
  74 > [  3.018515] (6:slave@Bourassa) "Task_8" done
  75 > [  3.029213] (4:slave@Fafard) "Task_11" done
  76 > [  3.234387] (1:master@Tremblay) Sent
  77 > [  3.234387] (1:master@Tremblay) Sending "Task_14" to "Tremblay"
  78 > [  3.234387] (1:master@Tremblay) Hey ! It's me ! :)
  79 > [  3.234387] (6:slave@Bourassa) Received "Task_13"
  80 > [  3.234387] (6:slave@Bourassa) Processing "Task_13"
  81 > [  3.236726] (1:master@Tremblay) Sent
  82 > [  3.236726] (1:master@Tremblay) Sending "Task_15" to "Jupiter"
  83 > [  3.236726] (2:slave@Tremblay) Received "Task_14"
  84 > [  3.236726] (2:slave@Tremblay) Processing "Task_14"
  85 > [  3.402688] (1:master@Tremblay) Sent
  86 > [  3.402688] (1:master@Tremblay) Sending "Task_16" to "Fafard"
  87 > [  3.402688] (3:slave@Jupiter) Received "Task_15"
  88 > [  3.402688] (3:slave@Jupiter) Processing "Task_15"
  89 > [  3.620841] (1:master@Tremblay) Sent
  90 > [  3.620841] (1:master@Tremblay) Sending "Task_17" to "Ginette"
  91 > [  3.620841] (4:slave@Fafard) Received "Task_16"
  92 > [  3.620841] (4:slave@Fafard) Processing "Task_16"
  93 > [  3.746436] (2:slave@Tremblay) "Task_14" done
  94 > [  3.898788] (5:slave@Ginette) "Task_12" done
  95 > [  4.039247] (1:master@Tremblay) Sent
  96 > [  4.039247] (1:master@Tremblay) Sending "Task_18" to "Bourassa"
  97 > [  4.039247] (5:slave@Ginette) Received "Task_17"
  98 > [  4.039247] (5:slave@Ginette) Processing "Task_17"
  99 > [  4.058030] (3:slave@Jupiter) "Task_15" done
 100 > [  4.265485] (6:slave@Bourassa) "Task_13" done
 101 > [  4.276183] (4:slave@Fafard) "Task_16" done
 102 > [  4.481357] (1:master@Tremblay) Sent
 103 > [  4.481357] (1:master@Tremblay) Sending "Task_19" to "Tremblay"
 104 > [  4.481357] (1:master@Tremblay) Hey ! It's me ! :)
 105 > [  4.481357] (6:slave@Bourassa) Received "Task_18"
 106 > [  4.481357] (6:slave@Bourassa) Processing "Task_18"
 107 > [  4.483696] (1:master@Tremblay) Sent
 108 > [  4.483696] (1:master@Tremblay) All tasks have been dispatched. Let's tell everybody the computation is over.
 109 > [  4.483696] (2:slave@Tremblay) Received "Task_19"
 110 > [  4.483696] (2:slave@Tremblay) Processing "Task_19"
 111 > [  4.498896] (3:slave@Jupiter) Received "finalize"
 112 > [  4.498896] (3:slave@Jupiter) I'm done. See you!
 113 > [  4.519447] (4:slave@Fafard) Received "finalize"
 114 > [  4.519447] (4:slave@Fafard) I'm done. See you!
 115 > [  4.993406] (2:slave@Tremblay) "Task_19" done
 116 > [  5.070345] (5:slave@Ginette) "Task_17" done
 117 > [  5.083577] (5:slave@Ginette) Received "finalize"
 118 > [  5.083577] (5:slave@Ginette) I'm done. See you!
 119 > [  5.512455] (6:slave@Bourassa) "Task_18" done
 120 > [  5.532791] (6:slave@Bourassa) Received "finalize"
 121 > [  5.532791] (6:slave@Bourassa) I'm done. See you!
 122 > [  5.532947] (0:@) Simulation time 5.53295
 123 > [  5.532947] (1:master@Tremblay) Goodbye now!
 124 > [  5.532947] (2:slave@Tremblay) Received "finalize"
 125 > [  5.532947] (2:slave@Tremblay) I'm done. See you!
 126
 127 p Testing a master/slave example application with a forwarder module
 128
 129 ! output sort
 130 $ $SG_TEST_EXENV ${bindir:=.}/masterslave_forwarder$EXEEXT msg_platform.xml masterslave/deployment_masterslave_forwarder.xml --cfg=cpu/optim:TI "--log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n"
 131 > [  0.000000] (0:@) Configuration change: Set 'cpu/optim' to 'TI'
 132 > [  0.000000] (1:master@Jacquelin) Got 5 slaves and 20 tasks to process
 133 > [  0.000000] (1:master@Jacquelin) Sending "Task_0" to "iRMX"
 134 > [  4.772530] (1:master@Jacquelin) Sent
 135 > [  4.772530] (1:master@Jacquelin) Sending "Task_1" to "Casavant"
 136 > [  4.772530] (4:slave@iRMX) Received "Task_0"
 137 > [  4.772530] (4:slave@iRMX) Processing "Task_0"
 138 > [  4.845345] (4:slave@iRMX) "Task_0" done
 139 > [  6.900351] (1:master@Jacquelin) Sent
 140 > [  6.900351] (1:master@Jacquelin) Sending "Task_2" to "Bousquet"
 141 > [  6.900351] (3:forwarder@Casavant) Received "Task_1"
 142 > [  6.900351] (3:forwarder@Casavant) Sending "Task_1" to "Robert"
 143 > [  8.491392] (1:master@Jacquelin) Sent
 144 > [  8.491392] (1:master@Jacquelin) Sending "Task_3" to "Soucy"
 145 > [  8.491392] (5:slave@Bousquet) Received "Task_2"
 146 > [  8.491392] (5:slave@Bousquet) Processing "Task_2"
 147 > [  8.607896] (5:slave@Bousquet) "Task_2" done
 148 > [  9.260549] (10:slave@Robert) Received "Task_1"
 149 > [  9.260549] (10:slave@Robert) Processing "Task_1"
 150 > [  9.296956] (10:slave@Robert) "Task_1" done
 151 > [ 10.755127] (1:master@Jacquelin) Sent
 152 > [ 10.755127] (1:master@Jacquelin) Sending "Task_4" to "Jackson"
 153 > [ 10.755127] (6:slave@Soucy) Received "Task_3"
 154 > [ 10.755127] (6:slave@Soucy) Processing "Task_3"
 155 > [ 10.791535] (6:slave@Soucy) "Task_3" done
 156 > [ 12.090242] (1:master@Jacquelin) Sent
 157 > [ 12.090242] (1:master@Jacquelin) Sending "Task_5" to "iRMX"
 158 > [ 12.090242] (2:forwarder@Jackson) Received "Task_4"
 159 > [ 12.090242] (2:forwarder@Jackson) Sending "Task_4" to "Kuenning"
 160 > [ 12.173866] (7:slave@Kuenning) Received "Task_4"
 161 > [ 12.173866] (7:slave@Kuenning) Processing "Task_4"
 162 > [ 12.232118] (7:slave@Kuenning) "Task_4" done
 163 > [ 16.862772] (1:master@Jacquelin) Sent
 164 > [ 16.862772] (1:master@Jacquelin) Sending "Task_6" to "Casavant"
 165 > [ 16.862772] (4:slave@iRMX) Received "Task_5"
 166 > [ 16.862772] (4:slave@iRMX) Processing "Task_5"
 167 > [ 16.935587] (4:slave@iRMX) "Task_5" done
 168 > [ 18.990593] (1:master@Jacquelin) Sent
 169 > [ 18.990593] (1:master@Jacquelin) Sending "Task_7" to "Bousquet"
 170 > [ 18.990593] (3:forwarder@Casavant) Received "Task_6"
 171 > [ 18.990593] (3:forwarder@Casavant) Sending "Task_6" to "Sirois"
 172 > [ 19.793293] (11:slave@Sirois) Received "Task_6"
 173 > [ 19.793293] (11:slave@Sirois) Processing "Task_6"
 174 > [ 19.836983] (11:slave@Sirois) "Task_6" done
 175 > [ 20.581634] (1:master@Jacquelin) Sent
 176 > [ 20.581634] (1:master@Jacquelin) Sending "Task_8" to "Soucy"
 177 > [ 20.581634] (5:slave@Bousquet) Received "Task_7"
 178 > [ 20.581634] (5:slave@Bousquet) Processing "Task_7"
 179 > [ 20.698138] (5:slave@Bousquet) "Task_7" done
 180 > [ 22.845369] (1:master@Jacquelin) Sent
 181 > [ 22.845369] (1:master@Jacquelin) Sending "Task_9" to "Jackson"
 182 > [ 22.845369] (6:slave@Soucy) Received "Task_8"
 183 > [ 22.845369] (6:slave@Soucy) Processing "Task_8"
 184 > [ 22.881777] (6:slave@Soucy) "Task_8" done
 185 > [ 24.180485] (1:master@Jacquelin) Sent
 186 > [ 24.180485] (1:master@Jacquelin) Sending "Task_10" to "iRMX"
 187 > [ 24.180485] (2:forwarder@Jackson) Received "Task_9"
 188 > [ 24.180485] (2:forwarder@Jackson) Sending "Task_9" to "Browne"
 189 > [ 27.009931] (8:slave@Browne) Received "Task_9"
 190 > [ 27.009931] (8:slave@Browne) Processing "Task_9"
 191 > [ 27.046339] (8:slave@Browne) "Task_9" done
 192 > [ 28.953014] (1:master@Jacquelin) Sent
 193 > [ 28.953014] (1:master@Jacquelin) Sending "Task_11" to "Casavant"
 194 > [ 28.953014] (4:slave@iRMX) Received "Task_10"
 195 > [ 28.953014] (4:slave@iRMX) Processing "Task_10"
 196 > [ 29.025830] (4:slave@iRMX) "Task_10" done
 197 > [ 31.080835] (1:master@Jacquelin) Sent
 198 > [ 31.080835] (1:master@Jacquelin) Sending "Task_12" to "Bousquet"
 199 > [ 31.080835] (3:forwarder@Casavant) Received "Task_11"
 200 > [ 31.080835] (3:forwarder@Casavant) Sending "Task_11" to "Monique"
 201 > [ 32.472434] (12:slave@Monique) Received "Task_11"
 202 > [ 32.472434] (12:slave@Monique) Processing "Task_11"
 203 > [ 32.516124] (12:slave@Monique) "Task_11" done
 204 > [ 32.671876] (1:master@Jacquelin) Sent
 205 > [ 32.671876] (1:master@Jacquelin) Sending "Task_13" to "Soucy"
 206 > [ 32.671876] (5:slave@Bousquet) Received "Task_12"
 207 > [ 32.671876] (5:slave@Bousquet) Processing "Task_12"
 208 > [ 32.788380] (5:slave@Bousquet) "Task_12" done
 209 > [ 34.935611] (1:master@Jacquelin) Sent
 210 > [ 34.935611] (1:master@Jacquelin) Sending "Task_14" to "Jackson"
 211 > [ 34.935611] (6:slave@Soucy) Received "Task_13"
 212 > [ 34.935611] (6:slave@Soucy) Processing "Task_13"
 213 > [ 34.972019] (6:slave@Soucy) "Task_13" done
 214 > [ 36.270727] (1:master@Jacquelin) Sent
 215 > [ 36.270727] (1:master@Jacquelin) Sending "Task_15" to "iRMX"
 216 > [ 36.270727] (2:forwarder@Jackson) Received "Task_14"
 217 > [ 36.270727] (2:forwarder@Jackson) Sending "Task_14" to "Stephen"
 218 > [ 40.508273] (9:slave@Stephen) Received "Task_14"
 219 > [ 40.508273] (9:slave@Stephen) Processing "Task_14"
 220 > [ 40.581088] (9:slave@Stephen) "Task_14" done
 221 > [ 41.043257] (1:master@Jacquelin) Sent
 222 > [ 41.043257] (1:master@Jacquelin) Sending "Task_16" to "Casavant"
 223 > [ 41.043257] (4:slave@iRMX) Received "Task_15"
 224 > [ 41.043257] (4:slave@iRMX) Processing "Task_15"
 225 > [ 41.116072] (4:slave@iRMX) "Task_15" done
 226 > [ 43.171078] (1:master@Jacquelin) Sent
 227 > [ 43.171078] (1:master@Jacquelin) Sending "Task_17" to "Bousquet"
 228 > [ 43.171078] (3:forwarder@Casavant) Received "Task_16"
 229 > [ 43.171078] (3:forwarder@Casavant) Sending "Task_16" to "Robert"
 230 > [ 44.762118] (1:master@Jacquelin) Sent
 231 > [ 44.762118] (1:master@Jacquelin) Sending "Task_18" to "Soucy"
 232 > [ 44.762118] (5:slave@Bousquet) Received "Task_17"
 233 > [ 44.762118] (5:slave@Bousquet) Processing "Task_17"
 234 > [ 44.878622] (5:slave@Bousquet) "Task_17" done
 235 > [ 45.531275] (10:slave@Robert) Received "Task_16"
 236 > [ 45.531275] (10:slave@Robert) Processing "Task_16"
 237 > [ 45.567683] (10:slave@Robert) "Task_16" done
 238 > [ 47.025854] (1:master@Jacquelin) Sent
 239 > [ 47.025854] (1:master@Jacquelin) Sending "Task_19" to "Jackson"
 240 > [ 47.025854] (6:slave@Soucy) Received "Task_18"
 241 > [ 47.025854] (6:slave@Soucy) Processing "Task_18"
 242 > [ 47.062262] (6:slave@Soucy) "Task_18" done
 243 > [ 48.360969] (1:master@Jacquelin) Sent
 244 > [ 48.360969] (1:master@Jacquelin) All tasks have been dispatched. Let's tell everybody the computation is over.
 245 > [ 48.360969] (2:forwarder@Jackson) Received "Task_19"
 246 > [ 48.360969] (2:forwarder@Jackson) Sending "Task_19" to "Kuenning"
 247 > [ 48.444592] (7:slave@Kuenning) Received "Task_19"
 248 > [ 48.444592] (7:slave@Kuenning) Processing "Task_19"
 249 > [ 48.502845] (7:slave@Kuenning) "Task_19" done
 250 > [ 50.794024] (4:slave@iRMX) Received "finalize"
 251 > [ 50.794024] (4:slave@iRMX) I'm done. See you!
 252 > [ 51.878795] (3:forwarder@Casavant) Received "finalize"
 253 > [ 51.878795] (3:forwarder@Casavant) All tasks have been dispatched. Let's tell everybody the computation is over.
 254 > [ 52.689914] (5:slave@Bousquet) Received "finalize"
 255 > [ 52.689914] (5:slave@Bousquet) I'm done. See you!
 256 > [ 53.082033] (10:slave@Robert) Received "finalize"
 257 > [ 53.082033] (10:slave@Robert) I'm done. See you!
 258 > [ 53.491253] (11:slave@Sirois) Received "finalize"
 259 > [ 53.491253] (11:slave@Sirois) I'm done. See you!
 260 > [ 53.843975] (6:slave@Soucy) Received "finalize"
 261 > [ 53.843975] (6:slave@Soucy) I'm done. See you!
 262 > [ 54.200695] (12:slave@Monique) Received "finalize"
 263 > [ 54.200695] (12:slave@Monique) I'm done. See you!
 264 > [ 54.200695] (3:forwarder@Casavant) I'm done. See you!
 265 > [ 54.524622] (1:master@Jacquelin) Goodbye now!
 266 > [ 54.524622] (2:forwarder@Jackson) Received "finalize"
 267 > [ 54.524622] (2:forwarder@Jackson) All tasks have been dispatched. Let's tell everybody the computation is over.
 268 > [ 54.529294] (7:slave@Kuenning) Received "finalize"
 269 > [ 54.529294] (7:slave@Kuenning) I'm done. See you!
 270 > [ 55.971757] (8:slave@Browne) Received "finalize"
 271 > [ 55.971757] (8:slave@Browne) I'm done. See you!
 272 > [ 58.132075] (0:@) Simulation time 58.1321
 273 > [ 58.132075] (2:forwarder@Jackson) I'm done. See you!
 274 > [ 58.132075] (9:slave@Stephen) Received "finalize"
 275 > [ 58.132075] (9:slave@Stephen) I'm done. See you!
 276
 277 p Testing a simple master/slave example application handling failures
 278
 279 ! output sort
 280 $ ${bindir:=.}/masterslave_failure$EXEEXT --log=xbt_cfg.thres:critical --log=no_loc small_platform_with_failures.xml masterslave/deployment_masterslave.xml --cfg=path:${srcdir} --cfg=cpu/optim:TI "--log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n"
 281 > [  0.000000] (0:@) Cannot launch process 'slave' on failed host 'Fafard'
 282 > [  0.000000] (1:master@Tremblay) Got 5 slave(s) :
 283 > [  0.000000] (1:master@Tremblay) Jupiter
 284 > [  0.000000] (1:master@Tremblay) Fafard
 285 > [  0.000000] (1:master@Tremblay) Ginette
 286 > [  0.000000] (1:master@Tremblay) Bourassa
 287 > [  0.000000] (1:master@Tremblay) Tremblay
 288 > [  0.000000] (1:master@Tremblay) Got 20 task to process :
 289 > [  0.165962] (1:master@Tremblay) Send completed
 290 > [  0.165962] (3:slave@Jupiter) Received "Task"
 291 > [  0.165962] (3:slave@Jupiter) Communication time : "0.165962"
 292 > [  0.165962] (3:slave@Jupiter) Processing "Task"
 293 > [  0.821304] (3:slave@Jupiter) "Task" done
 294 > [  1.100000] (3:slave@Jupiter) Gloups. The cpu on which I'm running just turned off!. See you!
 295 > [ 10.165962] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Fafard'. Nevermind. Let's keep going!
 296 > [ 10.306421] (1:master@Tremblay) Send completed
 297 > [ 10.306421] (4:slave@Ginette) Received "Task"
 298 > [ 10.306421] (4:slave@Ginette) Communication time : "0.140460"
 299 > [ 10.306421] (4:slave@Ginette) Processing "Task"
 300 > [ 10.522294] (1:master@Tremblay) Send completed
 301 > [ 10.522294] (5:slave@Bourassa) Received "Task"
 302 > [ 10.522294] (5:slave@Bourassa) Communication time : "0.215872"
 303 > [ 10.522294] (5:slave@Bourassa) Processing "Task"
 304 > [ 10.524632] (1:master@Tremblay) Send completed
 305 > [ 10.524632] (2:slave@Tremblay) Received "Task"
 306 > [ 10.524632] (2:slave@Tremblay) Communication time : "0.002339"
 307 > [ 10.524632] (2:slave@Tremblay) Processing "Task"
 308 > [ 11.034342] (2:slave@Tremblay) "Task" done
 309 > [ 11.337519] (4:slave@Ginette) "Task" done
 310 > [ 11.553392] (5:slave@Bourassa) "Task" done
 311 > [ 20.524632] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Jupiter'. Nevermind. Let's keep going!
 312 > [ 30.524632] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Fafard'. Nevermind. Let's keep going!
 313 > [ 30.524632] (1:master@Tremblay) Mmh. Something went wrong with 'Ginette'. Nevermind. Let's keep going!
 314 > [ 30.524632] (4:slave@Ginette) Mmh. Something went wrong. Nevermind. Let's keep going!
 315 > [ 30.740505] (1:master@Tremblay) Send completed
 316 > [ 30.740505] (5:slave@Bourassa) Received "Task"
 317 > [ 30.740505] (5:slave@Bourassa) Communication time : "0.215872"
 318 > [ 30.740505] (5:slave@Bourassa) Processing "Task"
 319 > [ 30.742843] (1:master@Tremblay) Send completed
 320 > [ 30.742843] (2:slave@Tremblay) Received "Task"
 321 > [ 30.742843] (2:slave@Tremblay) Communication time : "0.002339"
 322 > [ 30.742843] (2:slave@Tremblay) Processing "Task"
 323 > [ 31.252553] (2:slave@Tremblay) "Task" done
 324 > [ 31.771603] (5:slave@Bourassa) "Task" done
 325 > [ 40.742843] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Jupiter'. Nevermind. Let's keep going!
 326 > [ 50.742843] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Fafard'. Nevermind. Let's keep going!
 327 > [ 50.883303] (1:master@Tremblay) Send completed
 328 > [ 50.883303] (4:slave@Ginette) Received "Task"
 329 > [ 50.883303] (4:slave@Ginette) Communication time : "0.140460"
 330 > [ 50.883303] (4:slave@Ginette) Processing "Task"
 331 > [ 51.099175] (1:master@Tremblay) Send completed
 332 > [ 51.099175] (5:slave@Bourassa) Received "Task"
 333 > [ 51.099175] (5:slave@Bourassa) Communication time : "0.215872"
 334 > [ 51.099175] (5:slave@Bourassa) Processing "Task"
 335 > [ 51.101514] (1:master@Tremblay) Send completed
 336 > [ 51.101514] (2:slave@Tremblay) Received "Task"
 337 > [ 51.101514] (2:slave@Tremblay) Communication time : "0.002339"
 338 > [ 51.101514] (2:slave@Tremblay) Processing "Task"
 339 > [ 51.611224] (2:slave@Tremblay) "Task" done
 340 > [ 51.914401] (4:slave@Ginette) "Task" done
 341 > [ 52.130273] (5:slave@Bourassa) "Task" done
 342 > [ 61.101514] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Jupiter'. Nevermind. Let's keep going!
 343 > [ 71.101514] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Fafard'. Nevermind. Let's keep going!
 344 > [ 71.241973] (1:master@Tremblay) Send completed
 345 > [ 71.241973] (4:slave@Ginette) Received "Task"
 346 > [ 71.241973] (4:slave@Ginette) Communication time : "0.140460"
 347 > [ 71.241973] (4:slave@Ginette) Processing "Task"
 348 > [ 71.457846] (1:master@Tremblay) Send completed
 349 > [ 71.457846] (5:slave@Bourassa) Received "Task"
 350 > [ 71.457846] (5:slave@Bourassa) Communication time : "0.215872"
 351 > [ 71.457846] (5:slave@Bourassa) Processing "Task"
 352 > [ 71.460184] (1:master@Tremblay) Send completed
 353 > [ 71.460184] (1:master@Tremblay) All tasks have been dispatched. Let's tell everybody the computation is over.
 354 > [ 71.460184] (2:slave@Tremblay) Received "Task"
 355 > [ 71.460184] (2:slave@Tremblay) Communication time : "0.002339"
 356 > [ 71.460184] (2:slave@Tremblay) Processing "Task"
 357 > [ 71.969894] (2:slave@Tremblay) "Task" done
 358 > [ 72.273071] (4:slave@Ginette) "Task" done
 359 > [ 72.460184] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Jupiter'. Nevermind. Let's keep going!
 360 > [ 72.488944] (5:slave@Bourassa) "Task" done
 361 > [ 73.460184] (1:master@Tremblay) Mmh. Got timeouted while speaking to 'Fafard'. Nevermind. Let's keep going!
 362 > [ 73.473416] (4:slave@Ginette) Received "finalize"
 363 > [ 73.473416] (4:slave@Ginette) I'm done. See you!
 364 > [ 73.493752] (5:slave@Bourassa) Received "finalize"
 365 > [ 73.493752] (5:slave@Bourassa) I'm done. See you!
 366 > [ 73.493908] (0:@) Simulation time 73.4939
 367 > [ 73.493908] (1:master@Tremblay) Goodbye now!
 368 > [ 73.493908] (2:slave@Tremblay) Received "finalize"
 369 > [ 73.493908] (2:slave@Tremblay) I'm done. See you!
 370
 371 p Testing the bypassing of the flexml parser
 372
 373 ! output sort
 374 $ $SG_TEST_EXENV ${bindir:=.}/masterslave_bypass --log=no_loc --cfg=cpu/optim:TI "--log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n"
 375 > [  0.000000] (0:@) Configuration change: Set 'cpu/optim' to 'TI'
 376 > [  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.
 377 > [  0.000000] (1:master@host A) Got 1 slave(s) :
 378 > [  0.000000] (1:master@host A)         host B
 379 > [  0.000000] (1:master@host A) Got 20 task to process :
 380 > [  0.000000] (1:master@host A)        "Task_0"
 381 > [  0.000000] (1:master@host A)        "Task_1"
 382 > [  0.000000] (1:master@host A)        "Task_2"
 383 > [  0.000000] (1:master@host A)        "Task_3"
 384 > [  0.000000] (1:master@host A)        "Task_4"
 385 > [  0.000000] (1:master@host A)        "Task_5"
 386 > [  0.000000] (1:master@host A)        "Task_6"
 387 > [  0.000000] (1:master@host A)        "Task_7"
 388 > [  0.000000] (1:master@host A)        "Task_8"
 389 > [  0.000000] (1:master@host A)        "Task_9"
 390 > [  0.000000] (1:master@host A)        "Task_10"
 391 > [  0.000000] (1:master@host A)        "Task_11"
 392 > [  0.000000] (1:master@host A)        "Task_12"
 393 > [  0.000000] (1:master@host A)        "Task_13"
 394 > [  0.000000] (1:master@host A)        "Task_14"
 395 > [  0.000000] (1:master@host A)        "Task_15"
 396 > [  0.000000] (1:master@host A)        "Task_16"
 397 > [  0.000000] (1:master@host A)        "Task_17"
 398 > [  0.000000] (1:master@host A)        "Task_18"
 399 > [  0.000000] (1:master@host A)        "Task_19"
 400 > [  0.000000] (1:master@host A) Sending "Task_0" to "host B"
 401 > [  0.000000] (2:slave@host B) I'm a slave
 402 > [  4.080000] (1:master@host A) Send completed
 403 > [  4.080000] (1:master@host A) Sending "Task_1" to "host B"
 404 > [  4.080000] (2:slave@host B) Received "Task_0"
 405 > [  4.080000] (2:slave@host B) Processing "Task_0"
 406 > [  4.130000] (2:slave@host B) "Task_0" done
 407 > [  8.210000] (1:master@host A) Send completed
 408 > [  8.210000] (1:master@host A) Sending "Task_2" to "host B"
 409 > [  8.210000] (2:slave@host B) Received "Task_1"
 410 > [  8.210000] (2:slave@host B) Processing "Task_1"
 411 > [  8.260000] (2:slave@host B) "Task_1" done
 412 > [ 12.340000] (1:master@host A) Send completed
 413 > [ 12.340000] (1:master@host A) Sending "Task_3" to "host B"
 414 > [ 12.340000] (2:slave@host B) Received "Task_2"
 415 > [ 12.340000] (2:slave@host B) Processing "Task_2"
 416 > [ 12.390000] (2:slave@host B) "Task_2" done
 417 > [ 16.470000] (1:master@host A) Send completed
 418 > [ 16.470000] (1:master@host A) Sending "Task_4" to "host B"
 419 > [ 16.470000] (2:slave@host B) Received "Task_3"
 420 > [ 16.470000] (2:slave@host B) Processing "Task_3"
 421 > [ 16.520000] (2:slave@host B) "Task_3" done
 422 > [ 20.600000] (1:master@host A) Send completed
 423 > [ 20.600000] (1:master@host A) Sending "Task_5" to "host B"
 424 > [ 20.600000] (2:slave@host B) Received "Task_4"
 425 > [ 20.600000] (2:slave@host B) Processing "Task_4"
 426 > [ 20.650000] (2:slave@host B) "Task_4" done
 427 > [ 24.730000] (1:master@host A) Send completed
 428 > [ 24.730000] (1:master@host A) Sending "Task_6" to "host B"
 429 > [ 24.730000] (2:slave@host B) Received "Task_5"
 430 > [ 24.730000] (2:slave@host B) Processing "Task_5"
 431 > [ 24.780000] (2:slave@host B) "Task_5" done
 432 > [ 28.860000] (1:master@host A) Send completed
 433 > [ 28.860000] (1:master@host A) Sending "Task_7" to "host B"
 434 > [ 28.860000] (2:slave@host B) Received "Task_6"
 435 > [ 28.860000] (2:slave@host B) Processing "Task_6"
 436 > [ 28.910000] (2:slave@host B) "Task_6" done
 437 > [ 32.990000] (1:master@host A) Send completed
 438 > [ 32.990000] (1:master@host A) Sending "Task_8" to "host B"
 439 > [ 32.990000] (2:slave@host B) Received "Task_7"
 440 > [ 32.990000] (2:slave@host B) Processing "Task_7"
 441 > [ 33.040000] (2:slave@host B) "Task_7" done
 442 > [ 37.120000] (1:master@host A) Send completed
 443 > [ 37.120000] (1:master@host A) Sending "Task_9" to "host B"
 444 > [ 37.120000] (2:slave@host B) Received "Task_8"
 445 > [ 37.120000] (2:slave@host B) Processing "Task_8"
 446 > [ 37.170000] (2:slave@host B) "Task_8" done
 447 > [ 41.250000] (1:master@host A) Send completed
 448 > [ 41.250000] (1:master@host A) Sending "Task_10" to "host B"
 449 > [ 41.250000] (2:slave@host B) Received "Task_9"
 450 > [ 41.250000] (2:slave@host B) Processing "Task_9"
 451 > [ 41.300000] (2:slave@host B) "Task_9" done
 452 > [ 45.380000] (1:master@host A) Send completed
 453 > [ 45.380000] (1:master@host A) Sending "Task_11" to "host B"
 454 > [ 45.380000] (2:slave@host B) Received "Task_10"
 455 > [ 45.380000] (2:slave@host B) Processing "Task_10"
 456 > [ 45.430000] (2:slave@host B) "Task_10" done
 457 > [ 49.510000] (1:master@host A) Send completed
 458 > [ 49.510000] (1:master@host A) Sending "Task_12" to "host B"
 459 > [ 49.510000] (2:slave@host B) Received "Task_11"
 460 > [ 49.510000] (2:slave@host B) Processing "Task_11"
 461 > [ 49.560000] (2:slave@host B) "Task_11" done
 462 > [ 53.640000] (1:master@host A) Send completed
 463 > [ 53.640000] (1:master@host A) Sending "Task_13" to "host B"
 464 > [ 53.640000] (2:slave@host B) Received "Task_12"
 465 > [ 53.640000] (2:slave@host B) Processing "Task_12"
 466 > [ 53.690000] (2:slave@host B) "Task_12" done
 467 > [ 57.770000] (1:master@host A) Send completed
 468 > [ 57.770000] (1:master@host A) Sending "Task_14" to "host B"
 469 > [ 57.770000] (2:slave@host B) Received "Task_13"
 470 > [ 57.770000] (2:slave@host B) Processing "Task_13"
 471 > [ 57.820000] (2:slave@host B) "Task_13" done
 472 > [ 61.900000] (1:master@host A) Send completed
 473 > [ 61.900000] (1:master@host A) Sending "Task_15" to "host B"
 474 > [ 61.900000] (2:slave@host B) Received "Task_14"
 475 > [ 61.900000] (2:slave@host B) Processing "Task_14"
 476 > [ 61.950000] (2:slave@host B) "Task_14" done
 477 > [ 66.030000] (1:master@host A) Send completed
 478 > [ 66.030000] (1:master@host A) Sending "Task_16" to "host B"
 479 > [ 66.030000] (2:slave@host B) Received "Task_15"
 480 > [ 66.030000] (2:slave@host B) Processing "Task_15"
 481 > [ 66.080000] (2:slave@host B) "Task_15" done
 482 > [ 70.160000] (1:master@host A) Send completed
 483 > [ 70.160000] (1:master@host A) Sending "Task_17" to "host B"
 484 > [ 70.160000] (2:slave@host B) Received "Task_16"
 485 > [ 70.160000] (2:slave@host B) Processing "Task_16"
 486 > [ 70.210000] (2:slave@host B) "Task_16" done
 487 > [ 74.290000] (1:master@host A) Send completed
 488 > [ 74.290000] (1:master@host A) Sending "Task_18" to "host B"
 489 > [ 74.290000] (2:slave@host B) Received "Task_17"
 490 > [ 74.290000] (2:slave@host B) Processing "Task_17"
 491 > [ 74.340000] (2:slave@host B) "Task_17" done
 492 > [ 78.420000] (1:master@host A) Send completed
 493 > [ 78.420000] (1:master@host A) Sending "Task_19" to "host B"
 494 > [ 78.420000] (2:slave@host B) Received "Task_18"
 495 > [ 78.420000] (2:slave@host B) Processing "Task_18"
 496 > [ 78.470000] (2:slave@host B) "Task_18" done
 497 > [ 82.550000] (1:master@host A) Send completed
 498 > [ 82.550000] (1:master@host A) All tasks have been dispatched. Let's tell everybody the computation is over.
 499 > [ 82.550000] (2:slave@host B) Received "Task_19"
 500 > [ 82.550000] (2:slave@host B) Processing "Task_19"
 501 > [ 82.600000] (2:slave@host B) "Task_19" done
 502 > [ 84.680000] (0:@) Simulation time 84.68
 503 > [ 84.680000] (1:master@host A) Goodbye now!
 504 > [ 84.680000] (2:slave@host B) Received "finalize"
 505 > [ 84.680000] (2:slave@host B) I'm done. See you!