-$ $SG_TEST_EXENV ./pmm_simulator$EXEEXT ${srcdir:=.}/../../msg/msg_platform.xml ${srcdir:=.}/pmm.xml
-> [Jacquelin:master:(1) 0.000156] [pmm/INFO] Wait for peers for 2 sec
-> [Boivin:slave:(2) 0.000156] [pmm/INFO] Sensor 0 starting
-> [Jean_Yves:slave:(3) 0.000156] [pmm/INFO] Sensor 1 starting
-> [TeX:slave:(4) 0.000156] [pmm/INFO] Sensor 2 starting
-> [Geoff:slave:(5) 0.000156] [pmm/INFO] Sensor 3 starting
-> [Disney:slave:(6) 0.000156] [pmm/INFO] Sensor 4 starting
-> [iRMX:slave:(7) 0.000156] [pmm/INFO] Sensor 5 starting
-> [McGee:slave:(8) 0.000156] [pmm/INFO] Sensor 6 starting
-> [Gatien:slave:(9) 0.000156] [pmm/INFO] Sensor 7 starting
-> [Laroche:slave:(10) 0.000156] [pmm/INFO] Sensor 8 starting
-> [Jacquelin:master:(1) 2.416827] [pmm/INFO] Got only 2 pals (of 9). Wait 2 more seconds
-> [Jacquelin:master:(1) 4.476356] [pmm/INFO] Got only 3 pals (of 9). Wait 2 more seconds
-> [Jacquelin:master:(1) 6.476356] [pmm/INFO] Got only 5 pals (of 9). Wait 2 more seconds
-> [Jacquelin:master:(1) 9.355676] [pmm/INFO] Got only 6 pals (of 9). Wait 2 more seconds
-> [Jacquelin:master:(1) 12.524103] [pmm/INFO] Good. Got 9 pals
-> [Jacquelin:master:(1) 12.525507] [pmm/INFO] XXXXXXXXXXXXXXXXXXXXXX begin Multiplication
-> [Boivin:slave:(2) 14.369272] [pmm/INFO] Receive my pos (0,0) and assignment
-> [Jean_Yves:slave:(3) 15.113445] [pmm/INFO] Receive my pos (0,1) and assignment
-> [TeX:slave:(4) 16.571623] [pmm/INFO] Receive my pos (0,2) and assignment
-> [Geoff:slave:(5) 16.576168] [pmm/INFO] Receive my pos (1,0) and assignment
-> [Disney:slave:(6) 18.043128] [pmm/INFO] Receive my pos (1,1) and assignment
-> [iRMX:slave:(7) 20.491553] [pmm/INFO] Receive my pos (1,2) and assignment
-> [McGee:slave:(8) 21.206195] [pmm/INFO] Receive my pos (2,0) and assignment
-> [Gatien:slave:(9) 22.231455] [pmm/INFO] Receive my pos (2,1) and assignment
-> [Laroche:slave:(10) 23.679910] [pmm/INFO] Receive my pos (2,2) and assignment
-> [Jacquelin:master:(1) 73.315380] [pmm/INFO] XXXXXXXXXXXXXXXXXXXXXX Ok, the result matches expectations
-> [Boivin:slave:(2) 74.153996] [gras/INFO] Exiting GRAS
-> [Jean_Yves:slave:(3) 74.893654] [gras/INFO] Exiting GRAS
-> [TeX:slave:(4) 76.342765] [gras/INFO] Exiting GRAS
-> [Geoff:slave:(5) 76.347189] [gras/INFO] Exiting GRAS
-> [Disney:slave:(6) 77.805054] [gras/INFO] Exiting GRAS
-> [iRMX:slave:(7) 80.238265] [gras/INFO] Exiting GRAS
-> [McGee:slave:(8) 80.948556] [gras/INFO] Exiting GRAS
-> [Gatien:slave:(9) 81.967478] [gras/INFO] Exiting GRAS
-> [Jacquelin:master:(1) 83.407037] [gras/INFO] Exiting GRAS
-> [Laroche:slave:(10) 83.407037] [gras/INFO] Exiting GRAS
+! output sort
+$ $SG_TEST_EXENV ./pmm_simulator$EXEEXT ${srcdir:=.}/../../msg/msg_platform.xml ${srcdir:=.}/pmm.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000156] (10:slave@Laroche) Sensor 8 starting
+> [ 0.000156] (1:master@Jacquelin) Wait for peers for 2 sec
+> [ 0.000156] (2:slave@Boivin) Sensor 0 starting
+> [ 0.000156] (3:slave@Jean_Yves) Sensor 1 starting
+> [ 0.000156] (4:slave@TeX) Sensor 2 starting
+> [ 0.000156] (5:slave@Geoff) Sensor 3 starting
+> [ 0.000156] (6:slave@Disney) Sensor 4 starting
+> [ 0.000156] (7:slave@iRMX) Sensor 5 starting
+> [ 0.000156] (8:slave@McGee) Sensor 6 starting
+> [ 0.000156] (9:slave@Gatien) Sensor 7 starting
+> [ 2.416827] (1:master@Jacquelin) Got only 2 pals (of 9). Wait 2 more seconds
+> [ 4.476356] (1:master@Jacquelin) Got only 3 pals (of 9). Wait 2 more seconds
+> [ 6.476356] (1:master@Jacquelin) Got only 5 pals (of 9). Wait 2 more seconds
+> [ 9.355676] (1:master@Jacquelin) Got only 6 pals (of 9). Wait 2 more seconds
+> [ 12.524103] (1:master@Jacquelin) Good. Got 9 pals
+> [ 12.525507] (1:master@Jacquelin) XXXXXXXXXXXXXXXXXXXXXX begin Multiplication
+> [ 14.369272] (2:slave@Boivin) Receive my pos (0,0) and assignment
+> [ 15.113445] (3:slave@Jean_Yves) Receive my pos (0,1) and assignment
+> [ 16.571623] (4:slave@TeX) Receive my pos (0,2) and assignment
+> [ 16.576168] (5:slave@Geoff) Receive my pos (1,0) and assignment
+> [ 18.043128] (6:slave@Disney) Receive my pos (1,1) and assignment
+> [ 20.491553] (7:slave@iRMX) Receive my pos (1,2) and assignment
+> [ 21.206195] (8:slave@McGee) Receive my pos (2,0) and assignment
+> [ 22.231455] (9:slave@Gatien) Receive my pos (2,1) and assignment
+> [ 23.679910] (10:slave@Laroche) Receive my pos (2,2) and assignment
+> [ 73.315380] (1:master@Jacquelin) XXXXXXXXXXXXXXXXXXXXXX Ok, the result matches expectations
+> [ 74.153996] (2:slave@Boivin) Exiting GRAS
+> [ 74.893654] (3:slave@Jean_Yves) Exiting GRAS
+> [ 76.342765] (4:slave@TeX) Exiting GRAS
+> [ 76.347189] (5:slave@Geoff) Exiting GRAS
+> [ 77.805054] (6:slave@Disney) Exiting GRAS
+> [ 80.238265] (7:slave@iRMX) Exiting GRAS
+> [ 80.948556] (8:slave@McGee) Exiting GRAS
+> [ 81.967478] (9:slave@Gatien) Exiting GRAS
+> [ 83.407037] (1:master@Jacquelin) Exiting GRAS
+> [ 83.407037] (10:slave@Laroche) Exiting GRAS
