examples/smpi/replay/replay.tesh

   1 # use the tested library, not the installed one
   2 # (since we want to pass it to the child, it has to be redefined before each command)
   3 # Go for the first test
   4
   5 p Test of trace replay with SMPI (one trace for all processes)
   6
   7 < replay/actions_bcast.txt
   8 $ mkfile replay/one_trace
   9 ! timeout 60
  10
  11 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
  12 > [Tremblay:0:(1) 0.000000] [smpi_replay/VERBOSE] 0 bcast 5e4 0.000000
  13 > [Jupiter:1:(2) 0.015036] [smpi_replay/VERBOSE] 1 bcast 5e4 0.015036
  14 > [Fafard:2:(3) 0.015676] [smpi_replay/VERBOSE] 2 bcast 5e4 0.015676
  15 > [Jupiter:1:(2) 2.636405] [smpi_replay/VERBOSE] 1 compute 2e8 2.621369
  16 > [Tremblay:0:(1) 5.097100] [smpi_replay/VERBOSE] 0 compute 5e8 5.097100
  17 > [Tremblay:0:(1) 5.097100] [smpi_replay/VERBOSE] 0 bcast 5e4 0.000000
  18 > [Jupiter:1:(2) 5.112136] [smpi_replay/VERBOSE] 1 bcast 5e4 2.475730
  19 > [Fafard:2:(3) 6.569099] [smpi_replay/VERBOSE] 2 compute 5e8 6.553424
  20 > [Fafard:2:(3) 6.584775] [smpi_replay/VERBOSE] 2 bcast 5e4 0.015676
  21 > [Jupiter:1:(2) 7.733505] [smpi_replay/VERBOSE] 1 compute 2e8 2.621369
  22 > [Tremblay:0:(1) 10.194200] [smpi_replay/VERBOSE] 0 compute 5e8 5.097100
  23 > [Fafard:2:(3) 13.138198] [smpi_replay/VERBOSE] 2 compute 5e8 6.553424
  24 > [Jupiter:1:(2) 14.286929] [smpi_replay/VERBOSE] 1 reduce 5e4 5e8 6.553424
  25 > [Tremblay:0:(1) 18.250974] [smpi_replay/VERBOSE] 0 reduce 5e4 5e8 8.056774
  26 > [Fafard:2:(3) 19.691622] [smpi_replay/VERBOSE] 2 reduce 5e4 5e8 6.553424
  27 > [Fafard:2:(3) 19.691622] [smpi_replay/INFO] Simulation time 19.691622
  28
  29 $ rm -f replay/one_trace
  30
  31 p The same with tracing activated
  32
  33 < replay/actions_bcast.txt
  34 $ mkfile replay/one_trace
  35
  36 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=no_loc  --cfg=tracing:yes --cfg=tracing/smpi:yes --cfg=tracing/smpi/computing:yes --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
  37 > [Fafard:2:(3) 19.691622] [smpi_replay/INFO] Simulation time 19.691622
  38
  39 $ rm -f replay/one_trace
  40
  41 $ tail -n +3 ./simgrid.trace
  42 > %EventDef PajeDefineContainerType 0
  43 > %       Alias string
  44 > %       Type string
  45 > %       Name string
  46 > %EndEventDef
  47 > %EventDef PajeDefineVariableType 1
  48 > %       Alias string
  49 > %       Type string
  50 > %       Name string
  51 > %       Color color
  52 > %EndEventDef
  53 > %EventDef PajeDefineStateType 2
  54 > %       Alias string
  55 > %       Type string
  56 > %       Name string
  57 > %EndEventDef
  58 > %EventDef PajeDefineEventType 3
  59 > %       Alias string
  60 > %       Type string
  61 > %       Name string
  62 > %EndEventDef
  63 > %EventDef PajeDefineLinkType 4
  64 > %       Alias string
  65 > %       Type string
  66 > %       StartContainerType string
  67 > %       EndContainerType string
  68 > %       Name string
  69 > %EndEventDef
  70 > %EventDef PajeDefineEntityValue 5
  71 > %       Alias string
  72 > %       Type string
  73 > %       Name string
  74 > %       Color color
  75 > %EndEventDef
  76 > %EventDef PajeCreateContainer 6
  77 > %       Time date
  78 > %       Alias string
  79 > %       Type string
  80 > %       Container string
  81 > %       Name string
  82 > %EndEventDef
  83 > %EventDef PajeDestroyContainer 7
  84 > %       Time date
  85 > %       Type string
  86 > %       Name string
  87 > %EndEventDef
  88 > %EventDef PajeSetVariable 8
  89 > %       Time date
  90 > %       Type string
  91 > %       Container string
  92 > %       Value double
  93 > %EndEventDef
  94 > %EventDef PajeAddVariable 9
  95 > %       Time date
  96 > %       Type string
  97 > %       Container string
  98 > %       Value double
  99 > %EndEventDef
 100 > %EventDef PajeSubVariable 10
 101 > %       Time date
 102 > %       Type string
 103 > %       Container string
 104 > %       Value double
 105 > %EndEventDef
 106 > %EventDef PajeSetState 11
 107 > %       Time date
 108 > %       Type string
 109 > %       Container string
 110 > %       Value string
 111 > %EndEventDef
 112 > %EventDef PajePushState 12
 113 > %       Time date
 114 > %       Type string
 115 > %       Container string
 116 > %       Value string
 117 > %EndEventDef
 118 > %EventDef PajePopState 13
 119 > %       Time date
 120 > %       Type string
 121 > %       Container string
 122 > %EndEventDef
 123 > %EventDef PajeResetState 14
 124 > %       Time date
 125 > %       Type string
 126 > %       Container string
 127 > %EndEventDef
 128 > %EventDef PajeStartLink 15
 129 > %       Time date
 130 > %       Type string
 131 > %       Container string
 132 > %       Value string
 133 > %       StartContainer string
 134 > %       Key string
 135 > %EndEventDef
 136 > %EventDef PajeEndLink 16
 137 > %       Time date
 138 > %       Type string
 139 > %       Container string
 140 > %       Value string
 141 > %       EndContainer string
 142 > %       Key string
 143 > %EndEventDef
 144 > %EventDef PajeNewEvent 17
 145 > %       Time date
 146 > %       Type string
 147 > %       Container string
 148 > %       Value string
 149 > %EndEventDef
 150 > 0 1 0 MPI
 151 > 2 2 1 MPI_STATE
 152 > 4 3 0 1 1 MPI_LINK
 153 > 6 0 1 1 0 "rank-0"
 154 > 5 4 2 computing "0 1 1"
 155 > 5 5 2 smpi_replay_run_init "0 1 0"
 156 > 6 0 2 1 0 "rank-1"
 157 > 6 0 3 1 0 "rank-2"
 158 > 12 0 2 1 5
 159 > 13 0 2 1
 160 > 12 0 2 2 5
 161 > 13 0 2 2
 162 > 12 0 2 3 5
 163 > 13 0 2 3
 164 > 5 6 2 action_bcast "0 0.78 0.39"
 165 > 12 0 2 1 6
 166 > 12 0 2 3 6
 167 > 12 0 2 2 6
 168 > 13 0 2 1
 169 > 12 0 2 1 4
 170 > 13 0.015036 2 2
 171 > 12 0.015036 2 2 4
 172 > 13 0.015676 2 3
 173 > 12 0.015676 2 3 4
 174 > 13 2.636405 2 2
 175 > 12 2.636405 2 2 6
 176 > 13 5.097100 2 1
 177 > 12 5.097100 2 1 6
 178 > 13 5.097100 2 1
 179 > 12 5.097100 2 1 4
 180 > 5 7 2 action_reduce "0 1 0"
 181 > 13 5.112136 2 2
 182 > 12 5.112136 2 2 4
 183 > 13 6.569099 2 3
 184 > 12 6.569099 2 3 6
 185 > 13 6.584775 2 3
 186 > 12 6.584775 2 3 4
 187 > 13 7.733505 2 2
 188 > 12 7.733505 2 2 7
 189 > 13 10.194200 2 1
 190 > 12 10.194200 2 1 7
 191 > 13 13.138198 2 3
 192 > 12 13.138198 2 3 7
 193 > 5 8 2 smpi_replay_run_finalize "0 1 0"
 194 > 13 14.286929 2 2
 195 > 12 14.286929 2 2 8
 196 > 13 18.250974 2 1
 197 > 12 18.250974 2 1 8
 198 > 13 19.691622 2 3
 199 > 12 19.691622 2 3 8
 200 > 13 19.691622 2 3
 201 > 7 19.691622 1 3
 202 > 13 19.691622 2 2
 203 > 7 19.691622 1 2
 204 > 13 19.691622 2 1
 205 > 7 19.691622 1 1
 206
 207 $ rm -f ./simgrid.trace
 208
 209 p Another test of trace replay with SMPI (one trace per process)
 210
 211 < replay/actions0.txt
 212 < replay/actions1.txt
 213 $ mkfile ./split_traces_tesh
 214
 215 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 2 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay ./split_traces_tesh --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 216 > [Tremblay:0:(1) 0.167158] [smpi_replay/VERBOSE] 0 send 1 1e6 0.167158
 217 > [Jupiter:1:(2) 0.167158] [smpi_replay/VERBOSE] 1 recv 0 1e6 0.167158
 218 > [Jupiter:1:(2) 13.274005] [smpi_replay/VERBOSE] 1 compute 1e9 13.106847
 219 > [Jupiter:1:(2) 13.274005] [smpi_replay/VERBOSE] 1 Isend 0 1e6 0.000000
 220 > [Jupiter:1:(2) 13.274005] [smpi_replay/VERBOSE] 1 Irecv 0 1e6 0.000000
 221 > [Tremblay:0:(1) 13.441162] [smpi_replay/VERBOSE] 0 recv 1 1e6 13.274005
 222 > [Jupiter:1:(2) 13.608320] [smpi_replay/VERBOSE] 1 wait 0.334315
 223 > [Tremblay:0:(1) 13.608320] [smpi_replay/VERBOSE] 0 send 1 1e6 0.167158
 224 > [Jupiter:1:(2) 13.608320] [smpi_replay/INFO] Simulation time 13.608320
 225
 226 $ rm -f ./split_traces_tesh
 227
 228 p Test of barrier replay with SMPI (one trace for all processes)
 229
 230 < replay/actions_barrier.txt
 231 $ mkfile replay/one_trace
 232
 233 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 234 > [Tremblay:0:(1) 1.518421] [smpi_replay/VERBOSE] 0 send 1 1e7 1.518421
 235 > [Jupiter:1:(2) 1.518421] [smpi_replay/VERBOSE] 1 recv 0 1e7 1.518421
 236 > [Tremblay:0:(1) 1.520397] [smpi_replay/VERBOSE] 0 barrier 0.001976
 237 > [Jupiter:1:(2) 1.521858] [smpi_replay/VERBOSE] 1 barrier 0.003438
 238 > [Fafard:2:(3) 1.522373] [smpi_replay/VERBOSE] 2 barrier 1.522373
 239 > [Tremblay:0:(1) 2.520397] [smpi_replay/VERBOSE] 0 compute 98095000 1.000000
 240 > [Jupiter:1:(2) 2.521858] [smpi_replay/VERBOSE] 1 compute 76296000 1.000000
 241 > [Fafard:2:(3) 2.522373] [smpi_replay/VERBOSE] 2 compute 76296000 1.000000
 242 > [Fafard:2:(3) 2.522373] [smpi_replay/INFO] Simulation time 2.522373
 243
 244 $ rm -f replay/one_trace
 245
 246 p Test of Isend replay with SMPI (one trace for all processes)
 247
 248 < replay/actions_with_isend.txt
 249 $ mkfile replay/one_trace
 250
 251 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 252 > [Jupiter:1:(2) 0.000000] [smpi_replay/VERBOSE] 1 Irecv 0 1e6 0.000000
 253 > [Jupiter:1:(2) 6.553424] [smpi_replay/VERBOSE] 1 compute 5e8 6.553424
 254 > [Jupiter:1:(2) 6.553524] [smpi_replay/VERBOSE] 1 test 0.000100
 255 > [Tremblay:0:(1) 10.194200] [smpi_replay/VERBOSE] 0 compute 1e9 10.194200
 256 > [Tremblay:0:(1) 10.361357] [smpi_replay/VERBOSE] 0 send 1 1e6 0.167158
 257 > [Jupiter:1:(2) 13.106947] [smpi_replay/VERBOSE] 1 compute 5e8 6.553424
 258 > [Jupiter:1:(2) 13.106947] [smpi_replay/VERBOSE] 1 wait 0.000000
 259 > [Tremblay:0:(1) 20.555557] [smpi_replay/VERBOSE] 0 compute 1e9 10.194200
 260 > [Fafard:2:(3) 26.213694] [smpi_replay/VERBOSE] 2 compute 2e9 26.213694
 261 > [Fafard:2:(3) 26.213694] [smpi_replay/VERBOSE] 2 Irecv 1 1e6 0.000000
 262 > [Jupiter:1:(2) 26.403860] [smpi_replay/VERBOSE] 1 send 2 1e6 13.296913
 263 > [Fafard:2:(3) 29.490406] [smpi_replay/VERBOSE] 2 compute 2.5e8 3.276712
 264 > [Fafard:2:(3) 29.490606] [smpi_replay/VERBOSE] 2 test 0.000200
 265 > [Fafard:2:(3) 32.767318] [smpi_replay/VERBOSE] 2 compute 2.5e8 3.276712
 266 > [Fafard:2:(3) 32.767318] [smpi_replay/VERBOSE] 2 Isend 0 1e6 0.000000
 267 > [Tremblay:0:(1) 32.923014] [smpi_replay/VERBOSE] 0 recv 2 1e6 12.367458
 268 > [Fafard:2:(3) 39.320741] [smpi_replay/VERBOSE] 2 compute 5e8 6.553424
 269 > [Fafard:2:(3) 39.320741] [smpi_replay/INFO] Simulation time 39.320741
 270
 271 $ rm -f replay/one_trace
 272
 273 p Test of Isend replay with SMPI (one trace for all processes)
 274
 275 < replay/actions_allReduce.txt
 276 $ mkfile replay/one_trace
 277
 278 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 279 > [Tremblay:0:(1) 5.112775] [smpi_replay/VERBOSE] 0 allReduce 5e4 5e8 5.112775
 280 > [Jupiter:1:(2) 6.584135] [smpi_replay/VERBOSE] 1 allReduce 5e4 5e8 6.584135
 281 > [Fafard:2:(3) 6.584775] [smpi_replay/VERBOSE] 2 allReduce 5e4 5e8 6.584775
 282 > [Tremblay:0:(1) 10.209875] [smpi_replay/VERBOSE] 0 compute 5e8 5.097100
 283 > [Jupiter:1:(2) 13.137559] [smpi_replay/VERBOSE] 1 compute 5e8 6.553424
 284 > [Fafard:2:(3) 13.138198] [smpi_replay/VERBOSE] 2 compute 5e8 6.553424
 285 > [Fafard:2:(3) 13.138198] [smpi_replay/INFO] Simulation time 13.138198
 286
 287 $ rm -f replay/one_trace
 288
 289 p Test of AllToAll replay with SMPI (one trace for all processes)
 290
 291 < replay/actions_alltoall.txt
 292 $ mkfile replay/one_trace
 293
 294 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 295 > [Tremblay:0:(1) 0.004041] [smpi_replay/VERBOSE] 0 allToAll 500 500 0.004041
 296 > [Fafard:2:(3) 0.006920] [smpi_replay/VERBOSE] 2 allToAll 500 500 0.006920
 297 > [Jupiter:1:(2) 0.006920] [smpi_replay/VERBOSE] 1 allToAll 500 500 0.006920
 298 > [Jupiter:1:(2) 0.006920] [smpi_replay/INFO] Simulation time 0.006920
 299
 300
 301
 302 $ rm -f replay/one_trace
 303
 304 p Test of AllToAllv replay with SMPI (one trace for all processes)
 305
 306 < replay/actions_alltoallv.txt
 307 $ mkfile replay/one_trace
 308
 309 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 310 > [Tremblay:0:(1) 0.004000] [smpi_replay/VERBOSE] 0 allToAllV 100 1 40 30 1000 1 80 100 0.004000
 311 > [Jupiter:1:(2) 0.006935] [smpi_replay/VERBOSE] 1 allToAllV 1000 80 1 40 1000 40 1 30 0.006935
 312 > [Fafard:2:(3) 0.006936] [smpi_replay/VERBOSE] 2 allToAllV 1000 100 30 1 1000 30 40 1 0.006936
 313 > [Fafard:2:(3) 0.006936] [smpi_replay/INFO] Simulation time 0.006936
 314
 315 $ rm -f replay/one_trace
 316
 317 p Test of AllGatherv replay with SMPI (one trace for all processes)
 318
 319 < replay/actions_allgatherv.txt
 320 $ mkfile replay/one_trace
 321
 322 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 323 > [Tremblay:0:(1) 0.909909] [smpi_replay/VERBOSE] 0 allGatherV 275427 275427 275427 275427 204020 0 0 0.909909
 324 > [Fafard:2:(3) 1.340304] [smpi_replay/VERBOSE] 2 allGatherV 275427 275427 275427 275427 204020 0 0 1.340304
 325 > [Jupiter:1:(2) 1.340304] [smpi_replay/VERBOSE] 1 allGatherV 275427 275427 275427 275427 204020 0 0 1.340304
 326 > [Jupiter:1:(2) 1.340304] [smpi_replay/INFO] Simulation time 1.340304
 327
 328 $ rm -f replay/one_trace
 329
 330 p Test of waitall replay with SMPI (one trace for all processes)
 331
 332 < replay/actions_waitall.txt
 333 $ mkfile replay/one_trace
 334
 335 ! output sort 19
 336 $ ../../smpi_script/bin/smpirun -ext smpi_replay --log=replay.thresh:critical --log=smpi_replay.thresh:verbose --log=no_loc --cfg=smpi/simulate-computation:no -np 3 -platform ${srcdir:=.}/../platforms/small_platform.xml -hostfile ${srcdir:=.}/hostfile ./replay/smpi_replay replay/one_trace --log=smpi_kernel.thres:warning --log=xbt_cfg.thres:warning
 337 > [Fafard:2:(3) 0.000000] [smpi_replay/VERBOSE] 2 Irecv 1 3000 0.000000
 338 > [Fafard:2:(3) 0.000000] [smpi_replay/VERBOSE] 2 Isend 0 3000 0.000000
 339 > [Jupiter:1:(2) 0.000000] [smpi_replay/VERBOSE] 1 Isend 0 2000 0.000000
 340 > [Jupiter:1:(2) 0.000000] [smpi_replay/VERBOSE] 1 Isend 2 3000 0.000000
 341 > [Jupiter:1:(2) 0.000000] [smpi_replay/VERBOSE] 1 waitAll 0.000000
 342 > [Tremblay:0:(1) 0.000000] [smpi_replay/VERBOSE] 0 Irecv 1 2000 0.000000
 343 > [Tremblay:0:(1) 0.000000] [smpi_replay/VERBOSE] 0 Irecv 2 3000 0.000000
 344 > [Tremblay:0:(1) 0.003787] [smpi_replay/VERBOSE] 0 waitAll 0.003787
 345 > [Fafard:2:(3) 0.006220] [smpi_replay/VERBOSE] 2 waitAll 0.006220
 346 > [Fafard:2:(3) 0.006220] [smpi_replay/INFO] Simulation time 0.006220
 347
 348 $ rm -f replay/one_trace