p Test1 MSG_comm_test() with Sleep_sender > Sleep_receiver
-$ ./peer small_platform.xml deployment_peer01.xml
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] sleep_start_time : 5.000000 , sleep_test_time : 0.100000
-> [Ruby:receiver:(2) 0.000000] [msg_test/INFO] sleep_start_time : 1.000000 , sleep_test_time : 0.100000
-> [Ruby:receiver:(2) 1.000000] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.000000] [msg_test/INFO] Send to receiver-0 Task_0
-> [Ruby:receiver:(2) 5.100000] [msg_test/INFO] Received "Task_0"
-> [Ruby:receiver:(2) 5.100000] [msg_test/INFO] Processing "Task_0"
-> [Tremblay:sender:(1) 5.100000] [msg_test/INFO] Send to receiver-0 Task_1
-> [Ruby:receiver:(2) 5.609710] [msg_test/INFO] "Task_0" done
-> [Ruby:receiver:(2) 5.609710] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.700000] [msg_test/INFO] Send to receiver-0 Task_2
-> [Ruby:receiver:(2) 5.709710] [msg_test/INFO] Received "Task_1"
-> [Ruby:receiver:(2) 5.709710] [msg_test/INFO] Processing "Task_1"
-> [Ruby:receiver:(2) 6.219420] [msg_test/INFO] "Task_1" done
-> [Ruby:receiver:(2) 6.219420] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.300000] [msg_test/INFO] Send to receiver-0 finalize
-> [Ruby:receiver:(2) 6.319420] [msg_test/INFO] Received "Task_2"
-> [Ruby:receiver:(2) 6.319420] [msg_test/INFO] Processing "Task_2"
-> [Ruby:receiver:(2) 6.829130] [msg_test/INFO] "Task_2" done
-> [Ruby:receiver:(2) 6.829130] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.900000] [msg_test/INFO] Goodbye now!
-> [Ruby:receiver:(2) 6.929130] [msg_test/INFO] Received "finalize"
-> [Ruby:receiver:(2) 6.929130] [msg_test/INFO] I'm done. See you!
-> [6.929130] [msg_test/INFO] Simulation time 6.92913
+! output sort
+$ ./peer small_platform.xml deployment_peer01.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000000] (1:sender@Tremblay) sleep_start_time : 5.000000 , sleep_test_time : 0.100000
+> [ 0.000000] (2:receiver@Ruby) sleep_start_time : 1.000000 , sleep_test_time : 0.100000
+> [ 1.000000] (2:receiver@Ruby) Wait to receive a task
+> [ 5.000000] (1:sender@Tremblay) Send to receiver-0 Task_0
+> [ 5.100000] (1:sender@Tremblay) Send to receiver-0 Task_1
+> [ 5.100000] (2:receiver@Ruby) Received "Task_0"
+> [ 5.100000] (2:receiver@Ruby) Processing "Task_0"
+> [ 5.609710] (2:receiver@Ruby) "Task_0" done
+> [ 5.609710] (2:receiver@Ruby) Wait to receive a task
+> [ 5.700000] (1:sender@Tremblay) Send to receiver-0 Task_2
+> [ 5.709710] (2:receiver@Ruby) Received "Task_1"
+> [ 5.709710] (2:receiver@Ruby) Processing "Task_1"
+> [ 6.219420] (2:receiver@Ruby) "Task_1" done
+> [ 6.219420] (2:receiver@Ruby) Wait to receive a task
+> [ 6.300000] (1:sender@Tremblay) Send to receiver-0 finalize
+> [ 6.319420] (2:receiver@Ruby) Received "Task_2"
+> [ 6.319420] (2:receiver@Ruby) Processing "Task_2"
+> [ 6.829130] (2:receiver@Ruby) "Task_2" done
+> [ 6.829130] (2:receiver@Ruby) Wait to receive a task
+> [ 6.900000] (1:sender@Tremblay) Goodbye now!
+> [ 6.929130] (0:@) Simulation time 6.92913
+> [ 6.929130] (2:receiver@Ruby) Received "finalize"
+> [ 6.929130] (2:receiver@Ruby) I'm done. See you!
p Test2 MSG_comm_test() with Sleep_sender < Sleep_receiver
-$ ./peer small_platform.xml deployment_peer02.xml
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] sleep_start_time : 1.000000 , sleep_test_time : 0.100000
-> [Ruby:receiver:(2) 0.000000] [msg_test/INFO] sleep_start_time : 5.000000 , sleep_test_time : 0.100000
-> [Tremblay:sender:(1) 1.000000] [msg_test/INFO] Send to receiver-0 Task_0
-> [Ruby:receiver:(2) 5.000000] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.100000] [msg_test/INFO] Send to receiver-0 Task_1
-> [Ruby:receiver:(2) 5.100000] [msg_test/INFO] Received "Task_0"
-> [Ruby:receiver:(2) 5.100000] [msg_test/INFO] Processing "Task_0"
-> [Ruby:receiver:(2) 5.609710] [msg_test/INFO] "Task_0" done
-> [Ruby:receiver:(2) 5.609710] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.700000] [msg_test/INFO] Send to receiver-0 Task_2
-> [Ruby:receiver:(2) 5.709710] [msg_test/INFO] Received "Task_1"
-> [Ruby:receiver:(2) 5.709710] [msg_test/INFO] Processing "Task_1"
-> [Ruby:receiver:(2) 6.219420] [msg_test/INFO] "Task_1" done
-> [Ruby:receiver:(2) 6.219420] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.300000] [msg_test/INFO] Send to receiver-0 finalize
-> [Ruby:receiver:(2) 6.319420] [msg_test/INFO] Received "Task_2"
-> [Ruby:receiver:(2) 6.319420] [msg_test/INFO] Processing "Task_2"
-> [Ruby:receiver:(2) 6.829130] [msg_test/INFO] "Task_2" done
-> [Ruby:receiver:(2) 6.829130] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.900000] [msg_test/INFO] Goodbye now!
-> [Ruby:receiver:(2) 6.929130] [msg_test/INFO] Received "finalize"
-> [Ruby:receiver:(2) 6.929130] [msg_test/INFO] I'm done. See you!
-> [6.929130] [msg_test/INFO] Simulation time 6.92913
+! output sort
+$ ./peer small_platform.xml deployment_peer02.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000000] (1:sender@Tremblay) sleep_start_time : 1.000000 , sleep_test_time : 0.100000
+> [ 0.000000] (2:receiver@Ruby) sleep_start_time : 5.000000 , sleep_test_time : 0.100000
+> [ 1.000000] (1:sender@Tremblay) Send to receiver-0 Task_0
+> [ 5.000000] (2:receiver@Ruby) Wait to receive a task
+> [ 5.100000] (1:sender@Tremblay) Send to receiver-0 Task_1
+> [ 5.100000] (2:receiver@Ruby) Received "Task_0"
+> [ 5.100000] (2:receiver@Ruby) Processing "Task_0"
+> [ 5.609710] (2:receiver@Ruby) "Task_0" done
+> [ 5.609710] (2:receiver@Ruby) Wait to receive a task
+> [ 5.700000] (1:sender@Tremblay) Send to receiver-0 Task_2
+> [ 5.709710] (2:receiver@Ruby) Received "Task_1"
+> [ 5.709710] (2:receiver@Ruby) Processing "Task_1"
+> [ 6.219420] (2:receiver@Ruby) "Task_1" done
+> [ 6.219420] (2:receiver@Ruby) Wait to receive a task
+> [ 6.300000] (1:sender@Tremblay) Send to receiver-0 finalize
+> [ 6.319420] (2:receiver@Ruby) Received "Task_2"
+> [ 6.319420] (2:receiver@Ruby) Processing "Task_2"
+> [ 6.829130] (2:receiver@Ruby) "Task_2" done
+> [ 6.829130] (2:receiver@Ruby) Wait to receive a task
+> [ 6.900000] (1:sender@Tremblay) Goodbye now!
+> [ 6.929130] (0:@) Simulation time 6.92913
+> [ 6.929130] (2:receiver@Ruby) Received "finalize"
+> [ 6.929130] (2:receiver@Ruby) I'm done. See you!
p Test1 MSG_comm_wait() with Sleep_sender > Sleep_receiver
-$ ./peer small_platform.xml deployment_peer03.xml
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] sleep_start_time : 5.000000 , sleep_test_time : 0.000000
-> [Ruby:receiver:(2) 0.000000] [msg_test/INFO] sleep_start_time : 1.000000 , sleep_test_time : 0.000000
-> [Ruby:receiver:(2) 1.000000] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.000000] [msg_test/INFO] Send to receiver-0 Task_0
-> [Ruby:receiver:(2) 5.016560] [msg_test/INFO] Received "Task_0"
-> [Ruby:receiver:(2) 5.016560] [msg_test/INFO] Processing "Task_0"
-> [Tremblay:sender:(1) 5.016560] [msg_test/INFO] Send to receiver-0 Task_1
-> [Ruby:receiver:(2) 5.526270] [msg_test/INFO] "Task_0" done
-> [Ruby:receiver:(2) 5.526270] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.542830] [msg_test/INFO] Send to receiver-0 Task_2
-> [Ruby:receiver:(2) 5.542830] [msg_test/INFO] Received "Task_1"
-> [Ruby:receiver:(2) 5.542830] [msg_test/INFO] Processing "Task_1"
-> [Ruby:receiver:(2) 6.052540] [msg_test/INFO] "Task_1" done
-> [Ruby:receiver:(2) 6.052540] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.069100] [msg_test/INFO] Send to receiver-0 finalize
-> [Ruby:receiver:(2) 6.069100] [msg_test/INFO] Received "Task_2"
-> [Ruby:receiver:(2) 6.069100] [msg_test/INFO] Processing "Task_2"
-> [Ruby:receiver:(2) 6.578810] [msg_test/INFO] "Task_2" done
-> [Ruby:receiver:(2) 6.578810] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.580370] [msg_test/INFO] Goodbye now!
-> [Ruby:receiver:(2) 6.580370] [msg_test/INFO] Received "finalize"
-> [Ruby:receiver:(2) 6.580370] [msg_test/INFO] I'm done. See you!
-> [6.580370] [msg_test/INFO] Simulation time 6.58037
+! output sort
+$ ./peer small_platform.xml deployment_peer03.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000000] (1:sender@Tremblay) sleep_start_time : 5.000000 , sleep_test_time : 0.000000
+> [ 0.000000] (2:receiver@Ruby) sleep_start_time : 1.000000 , sleep_test_time : 0.000000
+> [ 1.000000] (2:receiver@Ruby) Wait to receive a task
+> [ 5.000000] (1:sender@Tremblay) Send to receiver-0 Task_0
+> [ 5.016560] (1:sender@Tremblay) Send to receiver-0 Task_1
+> [ 5.016560] (2:receiver@Ruby) Received "Task_0"
+> [ 5.016560] (2:receiver@Ruby) Processing "Task_0"
+> [ 5.526270] (2:receiver@Ruby) "Task_0" done
+> [ 5.526270] (2:receiver@Ruby) Wait to receive a task
+> [ 5.542830] (1:sender@Tremblay) Send to receiver-0 Task_2
+> [ 5.542830] (2:receiver@Ruby) Received "Task_1"
+> [ 5.542830] (2:receiver@Ruby) Processing "Task_1"
+> [ 6.052540] (2:receiver@Ruby) "Task_1" done
+> [ 6.052540] (2:receiver@Ruby) Wait to receive a task
+> [ 6.069100] (1:sender@Tremblay) Send to receiver-0 finalize
+> [ 6.069100] (2:receiver@Ruby) Received "Task_2"
+> [ 6.069100] (2:receiver@Ruby) Processing "Task_2"
+> [ 6.578810] (2:receiver@Ruby) "Task_2" done
+> [ 6.578810] (2:receiver@Ruby) Wait to receive a task
+> [ 6.580370] (0:@) Simulation time 6.58037
+> [ 6.580370] (1:sender@Tremblay) Goodbye now!
+> [ 6.580370] (2:receiver@Ruby) Received "finalize"
+> [ 6.580370] (2:receiver@Ruby) I'm done. See you!
p Test2 MSG_comm_wait() with Sleep_sender < Sleep_receiver
-$ ./peer small_platform.xml deployment_peer04.xml
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] sleep_start_time : 1.000000 , sleep_test_time : 0.000000
-> [Ruby:receiver:(2) 0.000000] [msg_test/INFO] sleep_start_time : 5.000000 , sleep_test_time : 0.000000
-> [Tremblay:sender:(1) 1.000000] [msg_test/INFO] Send to receiver-0 Task_0
-> [Ruby:receiver:(2) 5.000000] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.016560] [msg_test/INFO] Send to receiver-0 Task_1
-> [Ruby:receiver:(2) 5.016560] [msg_test/INFO] Received "Task_0"
-> [Ruby:receiver:(2) 5.016560] [msg_test/INFO] Processing "Task_0"
-> [Ruby:receiver:(2) 5.526270] [msg_test/INFO] "Task_0" done
-> [Ruby:receiver:(2) 5.526270] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 5.542830] [msg_test/INFO] Send to receiver-0 Task_2
-> [Ruby:receiver:(2) 5.542830] [msg_test/INFO] Received "Task_1"
-> [Ruby:receiver:(2) 5.542830] [msg_test/INFO] Processing "Task_1"
-> [Ruby:receiver:(2) 6.052540] [msg_test/INFO] "Task_1" done
-> [Ruby:receiver:(2) 6.052540] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.069100] [msg_test/INFO] Send to receiver-0 finalize
-> [Ruby:receiver:(2) 6.069100] [msg_test/INFO] Received "Task_2"
-> [Ruby:receiver:(2) 6.069100] [msg_test/INFO] Processing "Task_2"
-> [Ruby:receiver:(2) 6.578810] [msg_test/INFO] "Task_2" done
-> [Ruby:receiver:(2) 6.578810] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 6.580370] [msg_test/INFO] Goodbye now!
-> [Ruby:receiver:(2) 6.580370] [msg_test/INFO] Received "finalize"
-> [Ruby:receiver:(2) 6.580370] [msg_test/INFO] I'm done. See you!
-> [6.580370] [msg_test/INFO] Simulation time 6.58037
+! output sort
+$ ./peer small_platform.xml deployment_peer04.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000000] (1:sender@Tremblay) sleep_start_time : 1.000000 , sleep_test_time : 0.000000
+> [ 0.000000] (2:receiver@Ruby) sleep_start_time : 5.000000 , sleep_test_time : 0.000000
+> [ 1.000000] (1:sender@Tremblay) Send to receiver-0 Task_0
+> [ 5.000000] (2:receiver@Ruby) Wait to receive a task
+> [ 5.016560] (1:sender@Tremblay) Send to receiver-0 Task_1
+> [ 5.016560] (2:receiver@Ruby) Received "Task_0"
+> [ 5.016560] (2:receiver@Ruby) Processing "Task_0"
+> [ 5.526270] (2:receiver@Ruby) "Task_0" done
+> [ 5.526270] (2:receiver@Ruby) Wait to receive a task
+> [ 5.542830] (1:sender@Tremblay) Send to receiver-0 Task_2
+> [ 5.542830] (2:receiver@Ruby) Received "Task_1"
+> [ 5.542830] (2:receiver@Ruby) Processing "Task_1"
+> [ 6.052540] (2:receiver@Ruby) "Task_1" done
+> [ 6.052540] (2:receiver@Ruby) Wait to receive a task
+> [ 6.069100] (1:sender@Tremblay) Send to receiver-0 finalize
+> [ 6.069100] (2:receiver@Ruby) Received "Task_2"
+> [ 6.069100] (2:receiver@Ruby) Processing "Task_2"
+> [ 6.578810] (2:receiver@Ruby) "Task_2" done
+> [ 6.578810] (2:receiver@Ruby) Wait to receive a task
+> [ 6.580370] (0:@) Simulation time 6.58037
+> [ 6.580370] (1:sender@Tremblay) Goodbye now!
+> [ 6.580370] (2:receiver@Ruby) Received "finalize"
+> [ 6.580370] (2:receiver@Ruby) I'm done. See you!
p Test1 MSG_comm_waitall() for sender
-$ ./peer2 small_platform.xml deployment_peer.xml
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] Send to receiver-0 Task_0
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] Send to receiver-0 Task_1
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] Send to receiver-0 Task_2
-> [Tremblay:sender:(1) 0.000000] [msg_test/INFO] Send to receiver-0 finalize
-> [Ruby:receiver:(2) 10.000000] [msg_test/INFO] Wait to receive a task
-> [Ruby:receiver:(2) 10.016560] [msg_test/INFO] Received "Task_0"
-> [Ruby:receiver:(2) 10.016560] [msg_test/INFO] Processing "Task_0"
-> [Ruby:receiver:(2) 10.526270] [msg_test/INFO] "Task_0" done
-> [Ruby:receiver:(2) 10.526270] [msg_test/INFO] Wait to receive a task
-> [Ruby:receiver:(2) 10.542830] [msg_test/INFO] Received "Task_1"
-> [Ruby:receiver:(2) 10.542830] [msg_test/INFO] Processing "Task_1"
-> [Ruby:receiver:(2) 11.052540] [msg_test/INFO] "Task_1" done
-> [Ruby:receiver:(2) 11.052540] [msg_test/INFO] Wait to receive a task
-> [Ruby:receiver:(2) 11.069100] [msg_test/INFO] Received "Task_2"
-> [Ruby:receiver:(2) 11.069100] [msg_test/INFO] Processing "Task_2"
-> [Ruby:receiver:(2) 11.578810] [msg_test/INFO] "Task_2" done
-> [Ruby:receiver:(2) 11.578810] [msg_test/INFO] Wait to receive a task
-> [Tremblay:sender:(1) 11.580370] [msg_test/INFO] Goodbye now!
-> [Ruby:receiver:(2) 11.580370] [msg_test/INFO] Received "finalize"
-> [Ruby:receiver:(2) 11.580370] [msg_test/INFO] I'm done. See you!
-> [11.580370] [msg_test/INFO] Simulation time 11.5804
+! output sort
+$ ./peer2 small_platform.xml deployment_peer.xml --log=root.fmt:[%10.6r]%e(%i:%P@%h)%e%m%n
+> [ 0.000000] (1:sender@Tremblay) Send to receiver-0 Task_0
+> [ 0.000000] (1:sender@Tremblay) Send to receiver-0 Task_1
+> [ 0.000000] (1:sender@Tremblay) Send to receiver-0 Task_2
+> [ 0.000000] (1:sender@Tremblay) Send to receiver-0 finalize
+> [ 10.000000] (2:receiver@Ruby) Wait to receive a task
+> [ 10.016560] (2:receiver@Ruby) Received "Task_0"
+> [ 10.016560] (2:receiver@Ruby) Processing "Task_0"
+> [ 10.526270] (2:receiver@Ruby) "Task_0" done
+> [ 10.526270] (2:receiver@Ruby) Wait to receive a task
+> [ 10.542830] (2:receiver@Ruby) Received "Task_1"
+> [ 10.542830] (2:receiver@Ruby) Processing "Task_1"
+> [ 11.052540] (2:receiver@Ruby) "Task_1" done
+> [ 11.052540] (2:receiver@Ruby) Wait to receive a task
+> [ 11.069100] (2:receiver@Ruby) Received "Task_2"
+> [ 11.069100] (2:receiver@Ruby) Processing "Task_2"
+> [ 11.578810] (2:receiver@Ruby) "Task_2" done
+> [ 11.578810] (2:receiver@Ruby) Wait to receive a task
+> [ 11.580370] (0:@) Simulation time 11.5804
+> [ 11.580370] (1:sender@Tremblay) Goodbye now!
+> [ 11.580370] (2:receiver@Ruby) Received "finalize"
+> [ 11.580370] (2:receiver@Ruby) I'm done. See you!
