-$ $SG_TEST_EXENV ./rpc_simulator$EXEEXT ${srcdir:=.}/../../msg/small_platform.xml ${srcdir:=.}/rpc.xml --log=root.fmt:"'[%h:%t:(%i) %.2r] [%c/%p] %m%n'"
-> [Tremblay:server:(1) 0.00] [Rpc/INFO] Launch server (port=4000)
-> [Tremblay:server:(1) 0.00] [Rpc/INFO] Listening on port 4000
-> [Ginette:forwarder:(2) 0.00] [Rpc/INFO] Launch forwarder (port=4000)
-> [Fafard:client:(3) 0.00] [Rpc/INFO] Launch client (server on Tremblay:4000)
-> [Fafard:client:(3) 2.00] [Rpc/INFO] Connected to Tremblay:4000.
-> [Fafard:client:(3) 2.00] [Rpc/INFO] Connected to server which is on Tremblay:4000
-> [Tremblay:server:(1) 2.00] [Rpc/INFO] Got message PING(1234) from Fafard:0
-> [Fafard:client:(3) 2.00] [Rpc/INFO] The answer to PING(1234) on Tremblay:4000 is PONG(4321)
-> [Fafard:client:(3) 2.00] [Rpc/INFO] Call the exception raising RPC
-> [Tremblay:server:(1) 2.00] [Rpc/INFO] Answered with PONG(4321)
-> [Fafard:client:(3) 2.01] [Rpc/INFO] Got the expected exception when calling the exception raising RPC
-> [Fafard:client:(3) 2.01] [Rpc/INFO] Called the exception raising RPC
-> [Fafard:client:(3) 2.01] [Rpc/INFO] Call the exception raising RPC (i=0)
-> [Fafard:client:(3) 2.01] [Rpc/INFO] Call the exception raising RPC (i=1)
-> [Fafard:client:(3) 2.02] [Rpc/INFO] Call the exception raising RPC (i=2)
-> [Fafard:client:(3) 2.02] [Rpc/INFO] Call the exception raising RPC (i=3)
-> [Fafard:client:(3) 2.02] [Rpc/INFO] Call the exception raising RPC (i=4)
-> [Fafard:client:(3) 2.03] [Rpc/INFO] Call the exception raising RPC on the forwarder (i=0)
-> [Ginette:forwarder:(2) 2.03] [Rpc/INFO] Forward a request
-> [Fafard:client:(3) 2.03] [Rpc/INFO] Got the expected exception when calling the exception raising RPC
-> [Fafard:client:(3) 2.03] [Rpc/INFO] Call the exception raising RPC on the forwarder (i=1)
-> [Ginette:forwarder:(2) 2.03] [Rpc/INFO] Forward a request
-> [Fafard:client:(3) 2.04] [Rpc/INFO] Got the expected exception when calling the exception raising RPC
-> [Fafard:client:(3) 2.04] [Rpc/INFO] Call the exception raising RPC on the forwarder (i=2)
-> [Ginette:forwarder:(2) 2.04] [Rpc/INFO] Forward a request
-> [Fafard:client:(3) 2.04] [Rpc/INFO] Got the expected exception when calling the exception raising RPC
-> [Fafard:client:(3) 2.04] [Rpc/INFO] Call the exception raising RPC on the forwarder (i=3)
-> [Ginette:forwarder:(2) 2.05] [Rpc/INFO] Forward a request
-> [Fafard:client:(3) 2.05] [Rpc/INFO] Got the expected exception when calling the exception raising RPC
-> [Fafard:client:(3) 2.05] [Rpc/INFO] Call the exception raising RPC on the forwarder (i=4)
-> [Ginette:forwarder:(2) 2.05] [Rpc/INFO] Forward a request
-> [Fafard:client:(3) 2.05] [Rpc/INFO] Got the expected exception when calling the exception raising RPC
-> [Fafard:client:(3) 2.05] [Rpc/INFO] Ask Ginette:4000 to die
-> [Ginette:forwarder:(2) 2.06] [Rpc/INFO] Asked to die by Fafard:0
-> [Ginette:forwarder:(2) 2.06] [Rpc/INFO] Done.
-> [Ginette:forwarder:(2) 2.06] [gras/INFO] Exiting GRAS
-> [Fafard:client:(3) 2.06] [Rpc/INFO] Ask Tremblay:4000 to die
-> [Tremblay:server:(1) 2.06] [Rpc/INFO] Asked to die by Fafard:0
-> [Tremblay:server:(1) 2.06] [Rpc/INFO] Done.
-> [Tremblay:server:(1) 2.06] [gras/INFO] Exiting GRAS
-> [Fafard:client:(3) 2.06] [Rpc/INFO] Done.
-> [Fafard:client:(3) 2.06] [gras/INFO] Exiting GRAS
+#! ./tesh
+
+! output sort
+$ $SG_TEST_EXENV ./rpc_simulator$EXEEXT ${srcdir:=.}/../../msg/small_platform.xml ${srcdir:=.}/rpc.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000000] (1:server@Tremblay) Launch server (port=4000)
+> [ 0.000000] (2:forwarder@Ginette) Launch forwarder (port=4000)
+> [ 0.000000] (3:client@Fafard) Launch client (server on Tremblay:4000)
+> [ 0.000156] (1:server@Tremblay) Listening on port 4000
+> [ 2.000312] (3:client@Fafard) Connected to Tremblay:4000.
+> [ 2.000312] (3:client@Fafard) Connected to server which is on Tremblay:4000
+> [ 2.020863] (1:server@Tremblay) Got message PING(1234) from Fafard:5000
+> [ 2.041415] (1:server@Tremblay) Answered with PONG(4321)
+> [ 2.041415] (3:client@Fafard) The answer to PING(1234) on Tremblay:4000 is PONG(4321)
+> [ 2.041415] (3:client@Fafard) Call the exception raising RPC
+> [ 2.061966] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Fafard:5000
+> [ 2.082632] (3:client@Fafard) Got the expected exception when calling the exception raising RPC
+> [ 2.082632] (3:client@Fafard) Called the exception raising RPC
+> [ 2.082632] (3:client@Fafard) Call the exception raising RPC (i=0)
+> [ 2.103182] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Fafard:5000
+> [ 2.123849] (3:client@Fafard) Call the exception raising RPC (i=1)
+> [ 2.144399] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Fafard:5000
+> [ 2.165066] (3:client@Fafard) Call the exception raising RPC (i=2)
+> [ 2.185616] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Fafard:5000
+> [ 2.206283] (3:client@Fafard) Call the exception raising RPC (i=3)
+> [ 2.226833] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Fafard:5000
+> [ 2.247499] (3:client@Fafard) Call the exception raising RPC (i=4)
+> [ 2.268050] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Fafard:5000
+> [ 2.288716] (3:client@Fafard) Call the exception raising RPC on the forwarder (i=0)
+> [ 2.301819] (2:forwarder@Ginette) Forward a request
+> [ 2.315051] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Ginette:4000
+> [ 2.328357] (2:forwarder@Ginette) Propagate remote exception ('Error for the client') from 'forward exception' RPC cb back to Fafard:5000
+> [ 2.341538] (3:client@Fafard) Got the expected exception when calling the exception raising RPC
+> [ 2.341538] (3:client@Fafard) Call the exception raising RPC on the forwarder (i=1)
+> [ 2.354640] (2:forwarder@Ginette) Forward a request
+> [ 2.367872] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Ginette:4000
+> [ 2.381178] (2:forwarder@Ginette) Propagate remote exception ('Error for the client') from 'forward exception' RPC cb back to Fafard:5000
+> [ 2.394359] (3:client@Fafard) Got the expected exception when calling the exception raising RPC
+> [ 2.394359] (3:client@Fafard) Call the exception raising RPC on the forwarder (i=2)
+> [ 2.407462] (2:forwarder@Ginette) Forward a request
+> [ 2.420693] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Ginette:4000
+> [ 2.433999] (2:forwarder@Ginette) Propagate remote exception ('Error for the client') from 'forward exception' RPC cb back to Fafard:5000
+> [ 2.447180] (3:client@Fafard) Got the expected exception when calling the exception raising RPC
+> [ 2.447180] (3:client@Fafard) Call the exception raising RPC on the forwarder (i=3)
+> [ 2.460283] (2:forwarder@Ginette) Forward a request
+> [ 2.473515] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Ginette:4000
+> [ 2.486821] (2:forwarder@Ginette) Propagate remote exception ('Error for the client') from 'forward exception' RPC cb back to Fafard:5000
+> [ 2.500001] (3:client@Fafard) Got the expected exception when calling the exception raising RPC
+> [ 2.500001] (3:client@Fafard) Call the exception raising RPC on the forwarder (i=4)
+> [ 2.513104] (2:forwarder@Ginette) Forward a request
+> [ 2.526336] (1:server@Tremblay) Propagate local exception ('Error for the client') from 'raise exception' RPC cb back to Ginette:4000
+> [ 2.539642] (2:forwarder@Ginette) Propagate remote exception ('Error for the client') from 'forward exception' RPC cb back to Fafard:5000
+> [ 2.552823] (3:client@Fafard) Got the expected exception when calling the exception raising RPC
+> [ 2.552823] (3:client@Fafard) Ask Ginette:4000 to die
+> [ 2.565925] (2:forwarder@Ginette) Asked to die by Fafard:5000
+> [ 2.565925] (2:forwarder@Ginette) Done.
+> [ 2.565925] (2:forwarder@Ginette) Exiting GRAS
+> [ 2.565925] (3:client@Fafard) Ask Tremblay:4000 to die
+> [ 2.586476] (1:server@Tremblay) Asked to die by Fafard:5000
+> [ 2.586476] (1:server@Tremblay) Done.
+> [ 2.586476] (1:server@Tremblay) Exiting GRAS
+> [ 2.586476] (3:client@Fafard) Done.
+> [ 2.586476] (3:client@Fafard) Exiting GRAS
