From a1bec44c4931f42dee74bc32218023ad121ec66c Mon Sep 17 00:00:00 2001 From: schnorr Date: Mon, 3 Jan 2011 12:30:34 +0000 Subject: [PATCH] [trace] faster method to insert into buffer details: - insert directly at the end if last event has the same timestamp as the event to be inserted git-svn-id: svn+ssh://scm.gforge.inria.fr/svn/simgrid/simgrid/trunk@9344 48e7efb5-ca39-0410-a469-dd3cf9ba447f --- examples/msg/tracing/ms.tesh | 898 +++++++++++++++++------------------ src/instr/instr_paje_trace.c | 13 +- 2 files changed, 460 insertions(+), 451 deletions(-) diff --git a/examples/msg/tracing/ms.tesh b/examples/msg/tracing/ms.tesh index 2e4d7da669..71f96caa38 100644 --- a/examples/msg/tracing/ms.tesh +++ b/examples/msg/tracing/ms.tesh @@ -46,28 +46,28 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=1) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 1 > [ 0.000000] (0:@) new container Fafard, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=2) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 2 > [ 0.000000] (0:@) new container Ginette, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=3) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 3 > [ 0.000000] (0:@) new container Bourassa, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=4) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 4 > [ 0.000000] (0:@) new container R.4-3, child of AS0 > [ 0.000000] (0:@) new type ROUTER, child of L1 > [ 0.000000] (0:@) new_pajeDefineContainerType: event_type=0 @@ -116,10 +116,10 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=1, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=5) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 5 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=6) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 6 > [ 0.000000] (0:@) new type bandwidth_used, child of LINK > [ 0.000000] (0:@) VariableType bandwidth_used(9), child of LINK(6) > [ 0.000000] (0:@) new_pajeDefineVariableType: event_type=1 @@ -131,130 +131,130 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=7) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 7 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=8) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 8 > [ 0.000000] (0:@) new container 3, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=9) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 9 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=10) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 10 > [ 0.000000] (0:@) new container 7, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=11) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 11 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=12) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 12 > [ 0.000000] (0:@) new container 9, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=13) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 13 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=14) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 14 > [ 0.000000] (0:@) new container 12, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=15) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 15 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=16) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 16 > [ 0.000000] (0:@) new container 2, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=17) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 17 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=18) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 18 > [ 0.000000] (0:@) new container 8, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=19) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 19 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=20) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 20 > [ 0.000000] (0:@) new container 1, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=21) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 21 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=22) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 22 > [ 0.000000] (0:@) new container 4, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=23) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 23 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=24) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 24 > [ 0.000000] (0:@) new container 0, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=25) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 25 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=26) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 26 > [ 0.000000] (0:@) new container 10, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=27) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 27 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=28) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 28 > [ 0.000000] (0:@) new container 5, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=29) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 29 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=30) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 30 > [ 0.000000] (0:@) new container loopback, child of AS0 > [ 0.000000] (0:@) new_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) print_pajeCreateContainer: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=5, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=31) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 31 > [ 0.000000] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=32) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 32 > [ 0.000000] (0:@) new type HOST-LINK, child of L1 > [ 0.000000] (0:@) LinkType HOST-LINK(10), child of L1(1) HOST(2)->LINK(6) > [ 0.000000] (0:@) new_pajeDefineLinkType: event_type=4 @@ -262,10 +262,10 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=4, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=33) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 33 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=34) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 34 > [ 0.000000] (0:@) new type LINK-HOST, child of L1 > [ 0.000000] (0:@) LinkType LINK-HOST(11), child of L1(1) LINK(6)->HOST(2) > [ 0.000000] (0:@) new_pajeDefineLinkType: event_type=4 @@ -273,16 +273,16 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=4, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=35) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 35 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=36) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 36 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=37) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 37 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=38) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 38 > [ 0.000000] (0:@) new type LINK-ROUTER, child of L1 > [ 0.000000] (0:@) LinkType LINK-ROUTER(12), child of L1(1) LINK(6)->ROUTER(5) > [ 0.000000] (0:@) new_pajeDefineLinkType: event_type=4 @@ -290,16 +290,16 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=4, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=39) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 39 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=40) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 40 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=41) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 41 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=42) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 42 > [ 0.000000] (0:@) new type LINK-LINK, child of L1 > [ 0.000000] (0:@) LinkType LINK-LINK(13), child of L1(1) LINK(6)->LINK(6) > [ 0.000000] (0:@) new_pajeDefineLinkType: event_type=4 @@ -307,148 +307,148 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=4, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=43) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 43 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=44) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 44 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=45) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 45 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=46) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 46 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=47) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 47 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=48) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 48 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=49) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 49 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=50) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 50 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=51) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 51 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=52) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 52 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=53) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 53 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=54) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 54 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=55) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 55 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=56) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 56 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=57) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=58) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 58 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=59) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=60) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 60 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=61) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=62) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 62 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=63) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=64) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 64 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=65) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 65 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=66) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 66 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=67) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 67 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=68) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 68 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=69) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 69 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=70) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 70 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=71) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=72) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 72 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=73) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=74) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 74 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=75) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=76) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 76 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=77) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=78) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 78 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=79) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=80) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 80 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=81) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=82) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 82 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=83) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 83 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=84) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 84 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=85) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=86) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 86 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=87) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 87 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=88) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 88 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=89) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 89 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=90) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 90 > [ 0.000000] (0:@) new type ROUTER-LINK, child of L1 > [ 0.000000] (0:@) LinkType ROUTER-LINK(14), child of L1(1) ROUTER(5)->LINK(6) > [ 0.000000] (0:@) new_pajeDefineLinkType: event_type=4 @@ -456,358 +456,358 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (0:@) free_paje_event: event_type=4, timestamp=0.000000 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=91) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 91 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=92) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 92 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=93) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 93 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=94) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 94 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=95) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 95 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=96) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 96 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=97) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 97 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=98) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 98 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=99) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 99 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=100) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 100 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=101) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 101 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=102) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 102 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=103) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 103 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=104) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 104 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=105) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 105 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=106) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 106 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=107) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 107 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=108) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 108 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=109) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 109 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=110) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 110 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=111) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 111 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=112) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 112 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=113) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 113 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=114) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 114 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=115) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 115 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=116) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 116 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=117) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 117 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=118) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 118 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=119) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 119 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=120) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 120 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=121) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 121 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=122) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 122 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=123) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 123 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=124) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 124 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=125) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 125 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=126) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 126 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=127) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 127 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=128) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 128 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=129) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 129 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=130) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 130 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=131) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 131 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=132) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 132 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=133) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 133 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=134) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 134 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=135) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 135 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=136) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 136 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=137) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 137 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=138) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 138 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=139) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 139 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=140) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 140 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=141) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 141 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=142) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 142 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=143) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 143 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=144) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 144 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=145) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 145 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=146) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 146 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=147) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 147 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=148) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 148 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=149) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 149 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=150) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 150 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=151) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 151 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=152) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 152 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=153) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 153 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=154) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 154 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=155) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 155 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=156) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 156 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=157) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 157 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=158) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 158 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=159) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 159 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=160) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 160 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=161) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 161 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=162) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 162 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=163) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 163 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=164) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 164 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=165) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 165 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=166) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 166 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=167) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 167 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=168) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 168 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=169) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 169 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=170) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 170 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=171) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 171 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=172) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 172 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=173) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 173 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=174) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 174 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=175) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 175 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=176) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 176 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=177) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 177 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=178) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 178 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=179) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 179 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=180) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 180 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=181) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 181 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=182) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 182 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=183) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 183 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=184) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 184 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=185) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 185 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=186) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 186 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=187) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 187 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=188) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 188 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=189) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 189 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=190) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 190 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=191) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 191 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=192) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 192 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=193) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 193 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=194) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 194 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=195) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 195 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=196) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 196 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=197) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 197 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=198) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 198 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=199) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 199 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=200) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 200 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=201) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 201 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=202) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 202 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=203) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 203 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=204) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 204 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=205) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 205 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=206) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 206 > [ 0.000000] (0:@) new_pajeStartLink: event_type=13, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=13, timestamp=0.000000, buffersize=207) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 207 > [ 0.000000] (0:@) new_pajeEndLink: event_type=14, timestamp=0.000000 > [ 0.000000] (0:@) insert_into_buffer: insert event_type=14, timestamp=0.000000, buffersize=208) -> [ 0.000000] (0:@) insert_into_buffer: inserted at end +> [ 0.000000] (0:@) insert_into_buffer: inserted at end, pos = 208 > [ 0.000000] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.000000] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (0:@) free_paje_event: event_type=7, timestamp=0.000000 @@ -1298,25 +1298,25 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.000000] (1:master@Tremblay) insert_into_buffer: inserted at beginning > [ 0.000000] (1:master@Tremblay) new_pajeNewEvent: event_type=15, timestamp=0.000000 > [ 0.000000] (1:master@Tremblay) insert_into_buffer: insert event_type=15, timestamp=0.000000, buffersize=1) -> [ 0.000000] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.000000] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 1 > [ 0.000000] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=2) -> [ 0.000000] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.000000] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 2 > [ 0.000000] (2:slave@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (2:slave@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=3) -> [ 0.000000] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 0.000000] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 3 > [ 0.000000] (3:slave@Jupiter) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (3:slave@Jupiter) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=4) -> [ 0.000000] (3:slave@Jupiter) insert_into_buffer: inserted at end +> [ 0.000000] (3:slave@Jupiter) insert_into_buffer: inserted at end, pos = 4 > [ 0.000000] (4:slave@Fafard) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (4:slave@Fafard) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=5) -> [ 0.000000] (4:slave@Fafard) insert_into_buffer: inserted at end +> [ 0.000000] (4:slave@Fafard) insert_into_buffer: inserted at end, pos = 5 > [ 0.000000] (5:slave@Ginette) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (5:slave@Ginette) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=6) -> [ 0.000000] (5:slave@Ginette) insert_into_buffer: inserted at end +> [ 0.000000] (5:slave@Ginette) insert_into_buffer: inserted at end, pos = 6 > [ 0.000000] (6:slave@Bourassa) new_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000000] (6:slave@Bourassa) insert_into_buffer: insert event_type=7, timestamp=0.000000, buffersize=7) -> [ 0.000000] (6:slave@Bourassa) insert_into_buffer: inserted at end +> [ 0.000000] (6:slave@Bourassa) insert_into_buffer: inserted at end, pos = 7 > [ 0.000156] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.000156] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.000000 > [ 0.000156] (0:@) free_paje_event: event_type=7, timestamp=0.000000 @@ -1340,7 +1340,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.002339] (0:@) insert_into_buffer: inserted at beginning > [ 0.002339] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.000156 > [ 0.002339] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.000156, buffersize=1) -> [ 0.002339] (0:@) insert_into_buffer: inserted at end +> [ 0.002339] (0:@) insert_into_buffer: inserted at end, pos = 1 > [ 0.002339] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.002339 > [ 0.002339] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.002339, buffersize=2) > [ 0.002339] (0:@) insert_into_buffer: inserted at end @@ -1352,15 +1352,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.002339] (0:@) insert_into_buffer: inserted at 3 > [ 0.002339] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.002339 > [ 0.002339] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.002339, buffersize=5) -> [ 0.002339] (0:@) insert_into_buffer: inserted at end +> [ 0.002339] (0:@) insert_into_buffer: inserted at end, pos = 5 > [ 0.002339] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.002339] (0:@) TRACE_paje_dump_buffer: ends > [ 0.002339] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.002339 > [ 0.002339] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.002339, buffersize=6) -> [ 0.002339] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.002339] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 6 > [ 0.002339] (2:slave@Tremblay) new_pajeAddVariable: event_type=8, timestamp=0.002339 > [ 0.002339] (2:slave@Tremblay) insert_into_buffer: insert event_type=8, timestamp=0.002339, buffersize=7) -> [ 0.002339] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 0.002339] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 7 > [ 0.017538] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.017538] (0:@) TRACE_paje_dump_buffer: ends > [ 0.168300] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.017538 @@ -1368,7 +1368,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.168300] (0:@) insert_into_buffer: inserted at end > [ 0.168300] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.017538 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.017538, buffersize=9) -> [ 0.168300] (0:@) insert_into_buffer: inserted at end +> [ 0.168300] (0:@) insert_into_buffer: inserted at end, pos = 9 > [ 0.168300] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.168300 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.168300, buffersize=10) > [ 0.168300] (0:@) insert_into_buffer: inserted at end @@ -1380,15 +1380,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.168300] (0:@) insert_into_buffer: inserted at 11 > [ 0.168300] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.168300 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.168300, buffersize=13) -> [ 0.168300] (0:@) insert_into_buffer: inserted at end +> [ 0.168300] (0:@) insert_into_buffer: inserted at end, pos = 13 > [ 0.168300] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.168300] (0:@) TRACE_paje_dump_buffer: ends > [ 0.168300] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.168300 > [ 0.168300] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.168300, buffersize=14) -> [ 0.168300] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.168300] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 14 > [ 0.168300] (3:slave@Jupiter) new_pajeAddVariable: event_type=8, timestamp=0.168300 > [ 0.168300] (3:slave@Jupiter) insert_into_buffer: insert event_type=8, timestamp=0.168300, buffersize=15) -> [ 0.168300] (3:slave@Jupiter) insert_into_buffer: inserted at end +> [ 0.168300] (3:slave@Jupiter) insert_into_buffer: inserted at end, pos = 15 > [ 0.168300] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.002339 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.002339, buffersize=16) > [ 0.168300] (0:@) insert_into_buffer: inserted at 8 @@ -1397,7 +1397,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.168300] (0:@) insert_into_buffer: inserted at 9 > [ 0.168300] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.168300 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.168300, buffersize=18) -> [ 0.168300] (0:@) insert_into_buffer: inserted at end +> [ 0.168300] (0:@) insert_into_buffer: inserted at end, pos = 18 > [ 0.168300] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.002339 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.002339, buffersize=19) > [ 0.168300] (0:@) insert_into_buffer: inserted at 10 @@ -1406,7 +1406,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.168300] (0:@) insert_into_buffer: inserted at 11 > [ 0.168300] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.168300 > [ 0.168300] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.168300, buffersize=21) -> [ 0.168300] (0:@) insert_into_buffer: inserted at end +> [ 0.168300] (0:@) insert_into_buffer: inserted at end, pos = 21 > [ 0.188851] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.188851] (0:@) TRACE_paje_dump_buffer: ends > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 @@ -1414,7 +1414,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at end > [ 0.386454] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.188851, buffersize=23) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 23 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=24) > [ 0.386454] (0:@) insert_into_buffer: inserted at end @@ -1426,7 +1426,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 25 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=27) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 27 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=28) > [ 0.386454] (0:@) insert_into_buffer: inserted at 26 @@ -1435,7 +1435,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 27 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=30) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 30 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=31) > [ 0.386454] (0:@) insert_into_buffer: inserted at 28 @@ -1444,7 +1444,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 29 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=33) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 33 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=34) > [ 0.386454] (0:@) insert_into_buffer: inserted at 30 @@ -1453,7 +1453,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 31 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=36) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 36 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=37) > [ 0.386454] (0:@) insert_into_buffer: inserted at 32 @@ -1462,7 +1462,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 33 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=39) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 39 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=40) > [ 0.386454] (0:@) insert_into_buffer: inserted at 34 @@ -1471,7 +1471,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 35 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=42) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 42 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=43) > [ 0.386454] (0:@) insert_into_buffer: inserted at 36 @@ -1480,7 +1480,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 37 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=45) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 45 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=46) > [ 0.386454] (0:@) insert_into_buffer: inserted at 38 @@ -1489,7 +1489,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 39 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=48) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 48 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=49) > [ 0.386454] (0:@) insert_into_buffer: inserted at 40 @@ -1498,7 +1498,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 41 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=51) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 51 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=52) > [ 0.386454] (0:@) insert_into_buffer: inserted at 42 @@ -1507,7 +1507,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 43 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=54) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 54 > [ 0.386454] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.188851 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.188851, buffersize=55) > [ 0.386454] (0:@) insert_into_buffer: inserted at 44 @@ -1516,32 +1516,32 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.386454] (0:@) insert_into_buffer: inserted at 45 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=57) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 0.386454] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.386454] (0:@) TRACE_paje_dump_buffer: ends > [ 0.386454] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.386454 > [ 0.386454] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.386454, buffersize=58) -> [ 0.386454] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.386454] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 58 > [ 0.386454] (4:slave@Fafard) new_pajeAddVariable: event_type=8, timestamp=0.386454 > [ 0.386454] (4:slave@Fafard) insert_into_buffer: insert event_type=8, timestamp=0.386454, buffersize=59) -> [ 0.386454] (4:slave@Fafard) insert_into_buffer: inserted at end +> [ 0.386454] (4:slave@Fafard) insert_into_buffer: inserted at end, pos = 59 > [ 0.386454] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.168300 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.168300, buffersize=60) > [ 0.386454] (0:@) insert_into_buffer: inserted at 22 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=61) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 0.386454] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.168300 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.168300, buffersize=62) > [ 0.386454] (0:@) insert_into_buffer: inserted at 23 > [ 0.386454] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.386454 > [ 0.386454] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.386454, buffersize=63) -> [ 0.386454] (0:@) insert_into_buffer: inserted at end +> [ 0.386454] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 0.399685] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.399685] (0:@) TRACE_paje_dump_buffer: ends > [ 0.512049] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.386454 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.386454, buffersize=64) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 64 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=65) > [ 0.512049] (0:@) insert_into_buffer: inserted at end @@ -1550,31 +1550,31 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.512049] (0:@) insert_into_buffer: inserted at 65 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=67) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 67 > [ 0.512049] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.399685 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.399685, buffersize=68) > [ 0.512049] (0:@) insert_into_buffer: inserted at 66 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=69) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 69 > [ 0.512049] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.399685 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.399685, buffersize=70) > [ 0.512049] (0:@) insert_into_buffer: inserted at 67 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=71) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 0.512049] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.399685 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.399685, buffersize=72) > [ 0.512049] (0:@) insert_into_buffer: inserted at 68 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=73) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 0.512049] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.399685 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.399685, buffersize=74) > [ 0.512049] (0:@) insert_into_buffer: inserted at 69 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=75) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 0.512049] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.399685 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.399685, buffersize=76) > [ 0.512049] (0:@) insert_into_buffer: inserted at 70 @@ -1583,7 +1583,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.512049] (0:@) insert_into_buffer: inserted at 71 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=78) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 78 > [ 0.512049] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.399685 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.399685, buffersize=79) > [ 0.512049] (0:@) insert_into_buffer: inserted at 72 @@ -1592,12 +1592,12 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.512049] (0:@) insert_into_buffer: inserted at 73 > [ 0.512049] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.512049 > [ 0.512049] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.512049, buffersize=81) -> [ 0.512049] (0:@) insert_into_buffer: inserted at end +> [ 0.512049] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 0.512049] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.512049] (0:@) TRACE_paje_dump_buffer: ends > [ 0.526913] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.512049 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.512049, buffersize=82) -> [ 0.526913] (0:@) insert_into_buffer: inserted at end +> [ 0.526913] (0:@) insert_into_buffer: inserted at end, pos = 82 > [ 0.526913] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.526913 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.526913, buffersize=83) > [ 0.526913] (0:@) insert_into_buffer: inserted at end @@ -1606,39 +1606,39 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.526913] (0:@) insert_into_buffer: inserted at 83 > [ 0.526913] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.526913 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.526913, buffersize=85) -> [ 0.526913] (0:@) insert_into_buffer: inserted at end +> [ 0.526913] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 0.526913] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.512049 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.512049, buffersize=86) > [ 0.526913] (0:@) insert_into_buffer: inserted at 84 > [ 0.526913] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.526913 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.526913, buffersize=87) -> [ 0.526913] (0:@) insert_into_buffer: inserted at end +> [ 0.526913] (0:@) insert_into_buffer: inserted at end, pos = 87 > [ 0.526913] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.512049 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.512049, buffersize=88) > [ 0.526913] (0:@) insert_into_buffer: inserted at 85 > [ 0.526913] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.526913 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.526913, buffersize=89) -> [ 0.526913] (0:@) insert_into_buffer: inserted at end +> [ 0.526913] (0:@) insert_into_buffer: inserted at end, pos = 89 > [ 0.526913] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.512049 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.512049, buffersize=90) > [ 0.526913] (0:@) insert_into_buffer: inserted at 86 > [ 0.526913] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.526913 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.526913, buffersize=91) -> [ 0.526913] (0:@) insert_into_buffer: inserted at end +> [ 0.526913] (0:@) insert_into_buffer: inserted at end, pos = 91 > [ 0.526913] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.512049 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.512049, buffersize=92) > [ 0.526913] (0:@) insert_into_buffer: inserted at 87 > [ 0.526913] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.526913 > [ 0.526913] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.526913, buffersize=93) -> [ 0.526913] (0:@) insert_into_buffer: inserted at end +> [ 0.526913] (0:@) insert_into_buffer: inserted at end, pos = 93 > [ 0.526913] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.526913] (0:@) TRACE_paje_dump_buffer: ends > [ 0.526913] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.526913 > [ 0.526913] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.526913, buffersize=94) -> [ 0.526913] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.526913] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 94 > [ 0.526913] (5:slave@Ginette) new_pajeAddVariable: event_type=8, timestamp=0.526913 > [ 0.526913] (5:slave@Ginette) insert_into_buffer: insert event_type=8, timestamp=0.526913, buffersize=95) -> [ 0.526913] (5:slave@Ginette) insert_into_buffer: inserted at end +> [ 0.526913] (5:slave@Ginette) insert_into_buffer: inserted at end, pos = 95 > [ 0.547249] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.547249] (0:@) TRACE_paje_dump_buffer: ends > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 @@ -1652,55 +1652,55 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.742786] (0:@) insert_into_buffer: inserted at 97 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=99) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 99 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=100) > [ 0.742786] (0:@) insert_into_buffer: inserted at 98 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=101) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 101 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=102) > [ 0.742786] (0:@) insert_into_buffer: inserted at 99 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=103) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 103 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=104) > [ 0.742786] (0:@) insert_into_buffer: inserted at 100 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=105) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 105 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=106) > [ 0.742786] (0:@) insert_into_buffer: inserted at 101 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=107) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 107 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=108) > [ 0.742786] (0:@) insert_into_buffer: inserted at 102 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=109) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 109 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=110) > [ 0.742786] (0:@) insert_into_buffer: inserted at 103 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=111) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 111 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=112) > [ 0.742786] (0:@) insert_into_buffer: inserted at 104 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=113) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 113 > [ 0.742786] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.547249, buffersize=114) > [ 0.742786] (0:@) insert_into_buffer: inserted at 105 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=115) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 115 > [ 0.742786] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.547249, buffersize=116) > [ 0.742786] (0:@) insert_into_buffer: inserted at 106 @@ -1709,7 +1709,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.742786] (0:@) insert_into_buffer: inserted at 107 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=118) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 118 > [ 0.742786] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.547249, buffersize=119) > [ 0.742786] (0:@) insert_into_buffer: inserted at 108 @@ -1718,7 +1718,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.742786] (0:@) insert_into_buffer: inserted at 109 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=121) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 121 > [ 0.742786] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.547249, buffersize=122) > [ 0.742786] (0:@) insert_into_buffer: inserted at 110 @@ -1727,7 +1727,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.742786] (0:@) insert_into_buffer: inserted at 111 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=124) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 124 > [ 0.742786] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.547249 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.547249, buffersize=125) > [ 0.742786] (0:@) insert_into_buffer: inserted at 112 @@ -1736,15 +1736,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.742786] (0:@) insert_into_buffer: inserted at 113 > [ 0.742786] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.742786 > [ 0.742786] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.742786, buffersize=127) -> [ 0.742786] (0:@) insert_into_buffer: inserted at end +> [ 0.742786] (0:@) insert_into_buffer: inserted at end, pos = 127 > [ 0.742786] (0:@) TRACE_paje_dump_buffer: dump until 0.000000. starts > [ 0.742786] (0:@) TRACE_paje_dump_buffer: ends > [ 0.742786] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.742786 > [ 0.742786] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.742786, buffersize=128) -> [ 0.742786] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.742786] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 128 > [ 0.742786] (6:slave@Bourassa) new_pajeAddVariable: event_type=8, timestamp=0.742786 > [ 0.742786] (6:slave@Bourassa) insert_into_buffer: insert event_type=8, timestamp=0.742786, buffersize=129) -> [ 0.742786] (6:slave@Bourassa) insert_into_buffer: inserted at end +> [ 0.742786] (6:slave@Bourassa) insert_into_buffer: inserted at end, pos = 129 > [ 0.742942] (0:@) TRACE_paje_dump_buffer: dump until 0.168300. starts > [ 0.742942] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.000156 > [ 0.742942] (0:@) free_paje_event: event_type=7, timestamp=0.000156 @@ -1806,15 +1806,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.745124] (0:@) insert_into_buffer: inserted at 107 > [ 0.745124] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.745124 > [ 0.745124] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.745124, buffersize=109) -> [ 0.745124] (0:@) insert_into_buffer: inserted at end +> [ 0.745124] (0:@) insert_into_buffer: inserted at end, pos = 109 > [ 0.745124] (0:@) TRACE_paje_dump_buffer: dump until 0.168300. starts > [ 0.745124] (0:@) TRACE_paje_dump_buffer: ends > [ 0.745124] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.745124 > [ 0.745124] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.745124, buffersize=110) -> [ 0.745124] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.745124] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 110 > [ 0.745124] (2:slave@Tremblay) new_pajeAddVariable: event_type=8, timestamp=0.745124 > [ 0.745124] (2:slave@Tremblay) insert_into_buffer: insert event_type=8, timestamp=0.745124, buffersize=111) -> [ 0.745124] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 0.745124] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 111 > [ 0.823643] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.168300 > [ 0.823643] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.168300, buffersize=112) > [ 0.823643] (0:@) insert_into_buffer: inserted at 0 @@ -1832,7 +1832,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.823643] (0:@) insert_into_buffer: inserted at 3 > [ 0.823643] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.823643 > [ 0.823643] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.823643, buffersize=117) -> [ 0.823643] (0:@) insert_into_buffer: inserted at end +> [ 0.823643] (0:@) insert_into_buffer: inserted at end, pos = 117 > [ 0.823643] (0:@) TRACE_paje_dump_buffer: dump until 0.386454. starts > [ 0.823643] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.168300 > [ 0.823643] (0:@) free_paje_event: event_type=7, timestamp=0.168300 @@ -1939,22 +1939,22 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 0.989605] (0:@) TRACE_paje_dump_buffer: ends > [ 0.989605] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=0.989605 > [ 0.989605] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=0.989605, buffersize=74) -> [ 0.989605] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 0.989605] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 74 > [ 0.989605] (3:slave@Jupiter) new_pajeAddVariable: event_type=8, timestamp=0.989605 > [ 0.989605] (3:slave@Jupiter) insert_into_buffer: insert event_type=8, timestamp=0.989605, buffersize=75) -> [ 0.989605] (3:slave@Jupiter) insert_into_buffer: inserted at end +> [ 0.989605] (3:slave@Jupiter) insert_into_buffer: inserted at end, pos = 75 > [ 0.989605] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.745124 > [ 0.989605] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.745124, buffersize=76) > [ 0.989605] (0:@) insert_into_buffer: inserted at 70 > [ 0.989605] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.989605 > [ 0.989605] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.989605, buffersize=77) -> [ 0.989605] (0:@) insert_into_buffer: inserted at end +> [ 0.989605] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 0.989605] (0:@) new_pajeAddVariable: event_type=8, timestamp=0.745124 > [ 0.989605] (0:@) insert_into_buffer: insert event_type=8, timestamp=0.745124, buffersize=78) > [ 0.989605] (0:@) insert_into_buffer: inserted at 71 > [ 0.989605] (0:@) new_pajeSubVariable: event_type=9, timestamp=0.989605 > [ 0.989605] (0:@) insert_into_buffer: insert event_type=9, timestamp=0.989605, buffersize=79) -> [ 0.989605] (0:@) insert_into_buffer: inserted at end +> [ 0.989605] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 1.041796] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.386454 > [ 1.041796] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.386454, buffersize=80) > [ 1.041796] (0:@) insert_into_buffer: inserted at 0 @@ -1972,7 +1972,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.041796] (0:@) insert_into_buffer: inserted at 3 > [ 1.041796] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.041796 > [ 1.041796] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.041796, buffersize=85) -> [ 1.041796] (0:@) insert_into_buffer: inserted at end +> [ 1.041796] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 1.041796] (0:@) TRACE_paje_dump_buffer: dump until 0.526913. starts > [ 1.041796] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.386454 > [ 1.041796] (0:@) free_paje_event: event_type=7, timestamp=0.386454 @@ -2056,48 +2056,48 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.254834] (0:@) insert_into_buffer: inserted at 51 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=55) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 55 > [ 1.254834] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.062347 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.062347, buffersize=56) > [ 1.254834] (0:@) insert_into_buffer: inserted at 54 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=57) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 1.254834] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.062347 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.062347, buffersize=58) > [ 1.254834] (0:@) insert_into_buffer: inserted at 55 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=59) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 1.254834] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.062347 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.062347, buffersize=60) > [ 1.254834] (0:@) insert_into_buffer: inserted at 56 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=61) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 1.254834] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.062347 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.062347, buffersize=62) > [ 1.254834] (0:@) insert_into_buffer: inserted at 57 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=63) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 1.254834] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.062347 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.062347, buffersize=64) > [ 1.254834] (0:@) insert_into_buffer: inserted at 58 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=65) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 65 > [ 1.254834] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.062347 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.062347, buffersize=66) > [ 1.254834] (0:@) insert_into_buffer: inserted at 59 > [ 1.254834] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.254834 > [ 1.254834] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.254834, buffersize=67) -> [ 1.254834] (0:@) insert_into_buffer: inserted at end +> [ 1.254834] (0:@) insert_into_buffer: inserted at end, pos = 67 > [ 1.254834] (0:@) TRACE_paje_dump_buffer: dump until 0.526913. starts > [ 1.254834] (0:@) TRACE_paje_dump_buffer: ends > [ 1.259949] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.254834 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.254834, buffersize=68) -> [ 1.259949] (0:@) insert_into_buffer: inserted at end +> [ 1.259949] (0:@) insert_into_buffer: inserted at end, pos = 68 > [ 1.259949] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.259949 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.259949, buffersize=69) > [ 1.259949] (0:@) insert_into_buffer: inserted at end @@ -2106,39 +2106,39 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.259949] (0:@) insert_into_buffer: inserted at 69 > [ 1.259949] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.259949 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.259949, buffersize=71) -> [ 1.259949] (0:@) insert_into_buffer: inserted at end +> [ 1.259949] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 1.259949] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.254834 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.254834, buffersize=72) > [ 1.259949] (0:@) insert_into_buffer: inserted at 70 > [ 1.259949] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.259949 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.259949, buffersize=73) -> [ 1.259949] (0:@) insert_into_buffer: inserted at end +> [ 1.259949] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 1.259949] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.254834 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.254834, buffersize=74) > [ 1.259949] (0:@) insert_into_buffer: inserted at 71 > [ 1.259949] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.259949 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.259949, buffersize=75) -> [ 1.259949] (0:@) insert_into_buffer: inserted at end +> [ 1.259949] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 1.259949] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.254834 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.254834, buffersize=76) > [ 1.259949] (0:@) insert_into_buffer: inserted at 72 > [ 1.259949] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.259949 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.259949, buffersize=77) -> [ 1.259949] (0:@) insert_into_buffer: inserted at end +> [ 1.259949] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 1.259949] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.254834 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.254834, buffersize=78) > [ 1.259949] (0:@) insert_into_buffer: inserted at 73 > [ 1.259949] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.259949 > [ 1.259949] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.259949, buffersize=79) -> [ 1.259949] (0:@) insert_into_buffer: inserted at end +> [ 1.259949] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 1.259949] (0:@) TRACE_paje_dump_buffer: dump until 0.526913. starts > [ 1.259949] (0:@) TRACE_paje_dump_buffer: ends > [ 1.259949] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=1.259949 > [ 1.259949] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=1.259949, buffersize=80) -> [ 1.259949] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 1.259949] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 80 > [ 1.259949] (4:slave@Fafard) new_pajeAddVariable: event_type=8, timestamp=1.259949 > [ 1.259949] (4:slave@Fafard) insert_into_buffer: insert event_type=8, timestamp=1.259949, buffersize=81) -> [ 1.259949] (4:slave@Fafard) insert_into_buffer: inserted at end +> [ 1.259949] (4:slave@Fafard) insert_into_buffer: inserted at end, pos = 81 > [ 1.260105] (0:@) TRACE_paje_dump_buffer: dump until 0.526913. starts > [ 1.260105] (0:@) TRACE_paje_dump_buffer: ends > [ 1.262288] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.260105 @@ -2152,15 +2152,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.262288] (0:@) insert_into_buffer: inserted at 83 > [ 1.262288] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.262288 > [ 1.262288] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.262288, buffersize=85) -> [ 1.262288] (0:@) insert_into_buffer: inserted at end +> [ 1.262288] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 1.262288] (0:@) TRACE_paje_dump_buffer: dump until 0.526913. starts > [ 1.262288] (0:@) TRACE_paje_dump_buffer: ends > [ 1.262288] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=1.262288 > [ 1.262288] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=1.262288, buffersize=86) -> [ 1.262288] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 1.262288] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 86 > [ 1.262288] (2:slave@Tremblay) new_pajeAddVariable: event_type=8, timestamp=1.262288 > [ 1.262288] (2:slave@Tremblay) insert_into_buffer: insert event_type=8, timestamp=1.262288, buffersize=87) -> [ 1.262288] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 1.262288] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 87 > [ 1.558011] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.526913 > [ 1.558011] (0:@) insert_into_buffer: insert event_type=7, timestamp=0.526913, buffersize=88) > [ 1.558011] (0:@) insert_into_buffer: inserted at 0 @@ -2178,7 +2178,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.558011] (0:@) insert_into_buffer: inserted at 3 > [ 1.558011] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.558011 > [ 1.558011] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.558011, buffersize=93) -> [ 1.558011] (0:@) insert_into_buffer: inserted at end +> [ 1.558011] (0:@) insert_into_buffer: inserted at end, pos = 93 > [ 1.558011] (0:@) TRACE_paje_dump_buffer: dump until 0.742786. starts > [ 1.558011] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.526913 > [ 1.558011] (0:@) free_paje_event: event_type=7, timestamp=0.526913 @@ -2270,30 +2270,30 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.644947] (0:@) insert_into_buffer: inserted at 19 > [ 1.644947] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.644947 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.644947, buffersize=59) -> [ 1.644947] (0:@) insert_into_buffer: inserted at end +> [ 1.644947] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 1.644947] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.571243 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.571243, buffersize=60) > [ 1.644947] (0:@) insert_into_buffer: inserted at 58 > [ 1.644947] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.644947 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.644947, buffersize=61) -> [ 1.644947] (0:@) insert_into_buffer: inserted at end +> [ 1.644947] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 1.644947] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.571243 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.571243, buffersize=62) > [ 1.644947] (0:@) insert_into_buffer: inserted at 59 > [ 1.644947] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.644947 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.644947, buffersize=63) -> [ 1.644947] (0:@) insert_into_buffer: inserted at end +> [ 1.644947] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 1.644947] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.571243 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.571243, buffersize=64) > [ 1.644947] (0:@) insert_into_buffer: inserted at 60 > [ 1.644947] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.644947 > [ 1.644947] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.644947, buffersize=65) -> [ 1.644947] (0:@) insert_into_buffer: inserted at end +> [ 1.644947] (0:@) insert_into_buffer: inserted at end, pos = 65 > [ 1.644947] (0:@) TRACE_paje_dump_buffer: dump until 0.742786. starts > [ 1.644947] (0:@) TRACE_paje_dump_buffer: ends > [ 1.698471] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.644947 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.644947, buffersize=66) -> [ 1.698471] (0:@) insert_into_buffer: inserted at end +> [ 1.698471] (0:@) insert_into_buffer: inserted at end, pos = 66 > [ 1.698471] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.698471 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.698471, buffersize=67) > [ 1.698471] (0:@) insert_into_buffer: inserted at end @@ -2302,38 +2302,38 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.698471] (0:@) insert_into_buffer: inserted at 67 > [ 1.698471] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.698471 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.698471, buffersize=69) -> [ 1.698471] (0:@) insert_into_buffer: inserted at end +> [ 1.698471] (0:@) insert_into_buffer: inserted at end, pos = 69 > [ 1.698471] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.644947 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.644947, buffersize=70) > [ 1.698471] (0:@) insert_into_buffer: inserted at 68 > [ 1.698471] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.698471 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.698471, buffersize=71) -> [ 1.698471] (0:@) insert_into_buffer: inserted at end +> [ 1.698471] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 1.698471] (0:@) TRACE_paje_dump_buffer: dump until 0.742786. starts > [ 1.698471] (0:@) TRACE_paje_dump_buffer: ends > [ 1.698471] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=1.698471 > [ 1.698471] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=1.698471, buffersize=72) -> [ 1.698471] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 1.698471] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 72 > [ 1.698471] (5:slave@Ginette) new_pajeAddVariable: event_type=8, timestamp=1.698471 > [ 1.698471] (5:slave@Ginette) insert_into_buffer: insert event_type=8, timestamp=1.698471, buffersize=73) -> [ 1.698471] (5:slave@Ginette) insert_into_buffer: inserted at end +> [ 1.698471] (5:slave@Ginette) insert_into_buffer: inserted at end, pos = 73 > [ 1.698471] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.262288 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.262288, buffersize=74) > [ 1.698471] (0:@) insert_into_buffer: inserted at 56 > [ 1.698471] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.698471 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.698471, buffersize=75) -> [ 1.698471] (0:@) insert_into_buffer: inserted at end +> [ 1.698471] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 1.698471] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.262288 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.262288, buffersize=76) > [ 1.698471] (0:@) insert_into_buffer: inserted at 57 > [ 1.698471] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.698471 > [ 1.698471] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.698471, buffersize=77) -> [ 1.698471] (0:@) insert_into_buffer: inserted at end +> [ 1.698471] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 1.713671] (0:@) TRACE_paje_dump_buffer: dump until 0.742786. starts > [ 1.713671] (0:@) TRACE_paje_dump_buffer: ends > [ 1.771998] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.698471 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.698471, buffersize=78) -> [ 1.771998] (0:@) insert_into_buffer: inserted at end +> [ 1.771998] (0:@) insert_into_buffer: inserted at end, pos = 78 > [ 1.771998] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.771998 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.771998, buffersize=79) > [ 1.771998] (0:@) insert_into_buffer: inserted at end @@ -2342,19 +2342,19 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.771998] (0:@) insert_into_buffer: inserted at 79 > [ 1.771998] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.771998 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.771998, buffersize=81) -> [ 1.771998] (0:@) insert_into_buffer: inserted at end +> [ 1.771998] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 1.771998] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.713671 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.713671, buffersize=82) > [ 1.771998] (0:@) insert_into_buffer: inserted at 80 > [ 1.771998] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.771998 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.771998, buffersize=83) -> [ 1.771998] (0:@) insert_into_buffer: inserted at end +> [ 1.771998] (0:@) insert_into_buffer: inserted at end, pos = 83 > [ 1.771998] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.713671 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.713671, buffersize=84) > [ 1.771998] (0:@) insert_into_buffer: inserted at 81 > [ 1.771998] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.771998 > [ 1.771998] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.771998, buffersize=85) -> [ 1.771998] (0:@) insert_into_buffer: inserted at end +> [ 1.771998] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 1.771998] (0:@) TRACE_paje_dump_buffer: dump until 0.742786. starts > [ 1.771998] (0:@) TRACE_paje_dump_buffer: ends > [ 1.773883] (0:@) new_pajeSetVariable: event_type=7, timestamp=0.742786 @@ -2374,19 +2374,19 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.773883] (0:@) insert_into_buffer: inserted at 3 > [ 1.773883] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.773883 > [ 1.773883] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.773883, buffersize=91) -> [ 1.773883] (0:@) insert_into_buffer: inserted at end +> [ 1.773883] (0:@) insert_into_buffer: inserted at end, pos = 91 > [ 1.773883] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.771998 > [ 1.773883] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.771998, buffersize=92) > [ 1.773883] (0:@) insert_into_buffer: inserted at 90 > [ 1.773883] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.773883 > [ 1.773883] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.773883, buffersize=93) -> [ 1.773883] (0:@) insert_into_buffer: inserted at end +> [ 1.773883] (0:@) insert_into_buffer: inserted at end, pos = 93 > [ 1.773883] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.771998 > [ 1.773883] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.771998, buffersize=94) > [ 1.773883] (0:@) insert_into_buffer: inserted at 91 > [ 1.773883] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.773883 > [ 1.773883] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.773883, buffersize=95) -> [ 1.773883] (0:@) insert_into_buffer: inserted at end +> [ 1.773883] (0:@) insert_into_buffer: inserted at end, pos = 95 > [ 1.773883] (0:@) TRACE_paje_dump_buffer: dump until 1.259949. starts > [ 1.773883] (0:@) print_pajeSetVariable: event_type=7, timestamp=0.742786 > [ 1.773883] (0:@) free_paje_event: event_type=7, timestamp=0.742786 @@ -2499,7 +2499,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.773883] (0:@) TRACE_paje_dump_buffer: ends > [ 1.864433] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.773883 > [ 1.864433] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.773883, buffersize=42) -> [ 1.864433] (0:@) insert_into_buffer: inserted at end +> [ 1.864433] (0:@) insert_into_buffer: inserted at end, pos = 42 > [ 1.864433] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.864433 > [ 1.864433] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.864433, buffersize=43) > [ 1.864433] (0:@) insert_into_buffer: inserted at end @@ -2508,15 +2508,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.864433] (0:@) insert_into_buffer: inserted at 43 > [ 1.864433] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.864433 > [ 1.864433] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.864433, buffersize=45) -> [ 1.864433] (0:@) insert_into_buffer: inserted at end +> [ 1.864433] (0:@) insert_into_buffer: inserted at end, pos = 45 > [ 1.864433] (0:@) TRACE_paje_dump_buffer: dump until 1.259949. starts > [ 1.864433] (0:@) TRACE_paje_dump_buffer: ends > [ 1.864433] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=1.864433 > [ 1.864433] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=1.864433, buffersize=46) -> [ 1.864433] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 1.864433] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 46 > [ 1.864433] (3:slave@Jupiter) new_pajeAddVariable: event_type=8, timestamp=1.864433 > [ 1.864433] (3:slave@Jupiter) insert_into_buffer: insert event_type=8, timestamp=1.864433, buffersize=47) -> [ 1.864433] (3:slave@Jupiter) insert_into_buffer: inserted at end +> [ 1.864433] (3:slave@Jupiter) insert_into_buffer: inserted at end, pos = 47 > [ 1.864589] (0:@) TRACE_paje_dump_buffer: dump until 1.259949. starts > [ 1.864589] (0:@) TRACE_paje_dump_buffer: ends > [ 1.866771] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.864589 @@ -2530,15 +2530,15 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.866771] (0:@) insert_into_buffer: inserted at 49 > [ 1.866771] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.866771 > [ 1.866771] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.866771, buffersize=51) -> [ 1.866771] (0:@) insert_into_buffer: inserted at end +> [ 1.866771] (0:@) insert_into_buffer: inserted at end, pos = 51 > [ 1.866771] (0:@) TRACE_paje_dump_buffer: dump until 1.259949. starts > [ 1.866771] (0:@) TRACE_paje_dump_buffer: ends > [ 1.866771] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=1.866771 > [ 1.866771] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=1.866771, buffersize=52) -> [ 1.866771] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 1.866771] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 52 > [ 1.866771] (2:slave@Tremblay) new_pajeAddVariable: event_type=8, timestamp=1.866771 > [ 1.866771] (2:slave@Tremblay) insert_into_buffer: insert event_type=8, timestamp=1.866771, buffersize=53) -> [ 1.866771] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 1.866771] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 53 > [ 1.887107] (0:@) TRACE_paje_dump_buffer: dump until 1.259949. starts > [ 1.887107] (0:@) TRACE_paje_dump_buffer: ends > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.259949 @@ -2552,91 +2552,91 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.915291] (0:@) insert_into_buffer: inserted at 1 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=57) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=58) > [ 1.915291] (0:@) insert_into_buffer: inserted at 56 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=59) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=60) > [ 1.915291] (0:@) insert_into_buffer: inserted at 57 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=61) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=62) > [ 1.915291] (0:@) insert_into_buffer: inserted at 58 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=63) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=64) > [ 1.915291] (0:@) insert_into_buffer: inserted at 59 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=65) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 65 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=66) > [ 1.915291] (0:@) insert_into_buffer: inserted at 60 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=67) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 67 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=68) > [ 1.915291] (0:@) insert_into_buffer: inserted at 61 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=69) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 69 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=70) > [ 1.915291] (0:@) insert_into_buffer: inserted at 62 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=71) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=72) > [ 1.915291] (0:@) insert_into_buffer: inserted at 63 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=73) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=74) > [ 1.915291] (0:@) insert_into_buffer: inserted at 64 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=75) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=76) > [ 1.915291] (0:@) insert_into_buffer: inserted at 65 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=77) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=78) > [ 1.915291] (0:@) insert_into_buffer: inserted at 66 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=79) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=80) > [ 1.915291] (0:@) insert_into_buffer: inserted at 67 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=81) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=82) > [ 1.915291] (0:@) insert_into_buffer: inserted at 68 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=83) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 83 > [ 1.915291] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.887107 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.887107, buffersize=84) > [ 1.915291] (0:@) insert_into_buffer: inserted at 69 > [ 1.915291] (0:@) new_pajeSubVariable: event_type=9, timestamp=1.915291 > [ 1.915291] (0:@) insert_into_buffer: insert event_type=9, timestamp=1.915291, buffersize=85) -> [ 1.915291] (0:@) insert_into_buffer: inserted at end +> [ 1.915291] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 1.915291] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts > [ 1.915291] (0:@) print_pajeAddVariable: event_type=8, timestamp=1.259949 > [ 1.915291] (0:@) free_paje_event: event_type=8, timestamp=1.259949 @@ -2705,7 +2705,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 1.915291] (0:@) TRACE_paje_dump_buffer: ends > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=54) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 54 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=55) > [ 2.082643] (0:@) insert_into_buffer: inserted at end @@ -2714,99 +2714,99 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.082643] (0:@) insert_into_buffer: inserted at 55 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=57) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=58) > [ 2.082643] (0:@) insert_into_buffer: inserted at 56 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=59) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=60) > [ 2.082643] (0:@) insert_into_buffer: inserted at 57 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=61) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=62) > [ 2.082643] (0:@) insert_into_buffer: inserted at 58 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=63) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=64) > [ 2.082643] (0:@) insert_into_buffer: inserted at 59 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=65) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 65 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=66) > [ 2.082643] (0:@) insert_into_buffer: inserted at 60 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=67) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 67 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=68) > [ 2.082643] (0:@) insert_into_buffer: inserted at 61 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=69) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 69 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=70) > [ 2.082643] (0:@) insert_into_buffer: inserted at 62 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=71) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=72) > [ 2.082643] (0:@) insert_into_buffer: inserted at 63 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=73) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=74) > [ 2.082643] (0:@) insert_into_buffer: inserted at 64 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=75) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=76) > [ 2.082643] (0:@) insert_into_buffer: inserted at 65 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=77) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=78) > [ 2.082643] (0:@) insert_into_buffer: inserted at 66 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=79) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.915291 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.915291, buffersize=80) > [ 2.082643] (0:@) insert_into_buffer: inserted at 67 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=81) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 2.082643] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts > [ 2.082643] (0:@) TRACE_paje_dump_buffer: ends > [ 2.082643] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=2.082643 > [ 2.082643] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=2.082643, buffersize=82) -> [ 2.082643] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 2.082643] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 82 > [ 2.082643] (6:slave@Bourassa) new_pajeAddVariable: event_type=8, timestamp=2.082643 > [ 2.082643] (6:slave@Bourassa) insert_into_buffer: insert event_type=8, timestamp=2.082643, buffersize=83) -> [ 2.082643] (6:slave@Bourassa) insert_into_buffer: inserted at end +> [ 2.082643] (6:slave@Bourassa) insert_into_buffer: inserted at end, pos = 83 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.866771 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.866771, buffersize=84) > [ 2.082643] (0:@) insert_into_buffer: inserted at 24 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=85) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 2.082643] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.866771 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.866771, buffersize=86) > [ 2.082643] (0:@) insert_into_buffer: inserted at 25 > [ 2.082643] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.082643 > [ 2.082643] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.082643, buffersize=87) -> [ 2.082643] (0:@) insert_into_buffer: inserted at end +> [ 2.082643] (0:@) insert_into_buffer: inserted at end, pos = 87 > [ 2.103194] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts > [ 2.103194] (0:@) TRACE_paje_dump_buffer: ends > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 @@ -2820,90 +2820,90 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.300797] (0:@) insert_into_buffer: inserted at 89 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=91) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 91 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=92) > [ 2.300797] (0:@) insert_into_buffer: inserted at 90 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=93) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 93 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=94) > [ 2.300797] (0:@) insert_into_buffer: inserted at 91 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=95) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 95 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=96) > [ 2.300797] (0:@) insert_into_buffer: inserted at 92 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=97) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 97 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=98) > [ 2.300797] (0:@) insert_into_buffer: inserted at 93 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=99) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 99 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=100) > [ 2.300797] (0:@) insert_into_buffer: inserted at 94 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=101) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 101 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=102) > [ 2.300797] (0:@) insert_into_buffer: inserted at 95 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=103) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 103 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=104) > [ 2.300797] (0:@) insert_into_buffer: inserted at 96 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=105) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 105 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=106) > [ 2.300797] (0:@) insert_into_buffer: inserted at 97 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=107) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 107 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=108) > [ 2.300797] (0:@) insert_into_buffer: inserted at 98 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=109) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 109 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.103194 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.103194, buffersize=110) > [ 2.300797] (0:@) insert_into_buffer: inserted at 99 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=111) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 111 > [ 2.300797] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts > [ 2.300797] (0:@) TRACE_paje_dump_buffer: ends > [ 2.300797] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=2.300797 > [ 2.300797] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=2.300797, buffersize=112) -> [ 2.300797] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 2.300797] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 112 > [ 2.300797] (4:slave@Fafard) new_pajeAddVariable: event_type=8, timestamp=2.300797 > [ 2.300797] (4:slave@Fafard) insert_into_buffer: insert event_type=8, timestamp=2.300797, buffersize=113) -> [ 2.300797] (4:slave@Fafard) insert_into_buffer: inserted at end +> [ 2.300797] (4:slave@Fafard) insert_into_buffer: inserted at end, pos = 113 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.082643 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.082643, buffersize=114) > [ 2.300797] (0:@) insert_into_buffer: inserted at 88 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=115) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 115 > [ 2.300797] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.082643 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.082643, buffersize=116) > [ 2.300797] (0:@) insert_into_buffer: inserted at 89 > [ 2.300797] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.300797 > [ 2.300797] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.300797, buffersize=117) -> [ 2.300797] (0:@) insert_into_buffer: inserted at end +> [ 2.300797] (0:@) insert_into_buffer: inserted at end, pos = 117 > [ 2.376481] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.300797 > [ 2.376481] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.300797, buffersize=118) -> [ 2.376481] (0:@) insert_into_buffer: inserted at end +> [ 2.376481] (0:@) insert_into_buffer: inserted at end, pos = 118 > [ 2.376481] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.376481 > [ 2.376481] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.376481, buffersize=119) > [ 2.376481] (0:@) insert_into_buffer: inserted at end @@ -2912,7 +2912,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.376481] (0:@) insert_into_buffer: inserted at 119 > [ 2.376481] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.376481 > [ 2.376481] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.376481, buffersize=121) -> [ 2.376481] (0:@) insert_into_buffer: inserted at end +> [ 2.376481] (0:@) insert_into_buffer: inserted at end, pos = 121 > [ 2.376481] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts > [ 2.376481] (0:@) TRACE_paje_dump_buffer: ends > [ 2.376637] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts @@ -2927,10 +2927,10 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.378820] (0:@) TRACE_paje_dump_buffer: ends > [ 2.378820] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=2.378820 > [ 2.378820] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=2.378820, buffersize=124) -> [ 2.378820] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 2.378820] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 124 > [ 2.378820] (2:slave@Tremblay) new_pajeAddVariable: event_type=8, timestamp=2.378820 > [ 2.378820] (2:slave@Tremblay) insert_into_buffer: insert event_type=8, timestamp=2.378820, buffersize=125) -> [ 2.378820] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 2.378820] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 125 > [ 2.519775] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.864433 > [ 2.519775] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.864433, buffersize=126) > [ 2.519775] (0:@) insert_into_buffer: inserted at 18 @@ -2942,7 +2942,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.519775] (0:@) insert_into_buffer: inserted at 19 > [ 2.519775] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.519775 > [ 2.519775] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.519775, buffersize=129) -> [ 2.519775] (0:@) insert_into_buffer: inserted at end +> [ 2.519775] (0:@) insert_into_buffer: inserted at end, pos = 129 > [ 2.519775] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts > [ 2.519775] (0:@) TRACE_paje_dump_buffer: ends > [ 2.534975] (0:@) TRACE_paje_dump_buffer: dump until 1.698471. starts @@ -2957,22 +2957,22 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.685737] (0:@) TRACE_paje_dump_buffer: ends > [ 2.685737] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=2.685737 > [ 2.685737] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=2.685737, buffersize=132) -> [ 2.685737] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 2.685737] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 132 > [ 2.685737] (3:slave@Jupiter) new_pajeAddVariable: event_type=8, timestamp=2.685737 > [ 2.685737] (3:slave@Jupiter) insert_into_buffer: insert event_type=8, timestamp=2.685737, buffersize=133) -> [ 2.685737] (3:slave@Jupiter) insert_into_buffer: inserted at end +> [ 2.685737] (3:slave@Jupiter) insert_into_buffer: inserted at end, pos = 133 > [ 2.685737] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.378820 > [ 2.685737] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.378820, buffersize=134) > [ 2.685737] (0:@) insert_into_buffer: inserted at 128 > [ 2.685737] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.685737 > [ 2.685737] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.685737, buffersize=135) -> [ 2.685737] (0:@) insert_into_buffer: inserted at end +> [ 2.685737] (0:@) insert_into_buffer: inserted at end, pos = 135 > [ 2.685737] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.378820 > [ 2.685737] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.378820, buffersize=136) > [ 2.685737] (0:@) insert_into_buffer: inserted at 129 > [ 2.685737] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.685737 > [ 2.685737] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.685737, buffersize=137) -> [ 2.685737] (0:@) insert_into_buffer: inserted at end +> [ 2.685737] (0:@) insert_into_buffer: inserted at end, pos = 137 > [ 2.729569] (0:@) new_pajeAddVariable: event_type=8, timestamp=1.698471 > [ 2.729569] (0:@) insert_into_buffer: insert event_type=8, timestamp=1.698471, buffersize=138) > [ 2.729569] (0:@) insert_into_buffer: inserted at 0 @@ -2984,7 +2984,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.729569] (0:@) insert_into_buffer: inserted at 1 > [ 2.729569] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.729569 > [ 2.729569] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.729569, buffersize=141) -> [ 2.729569] (0:@) insert_into_buffer: inserted at end +> [ 2.729569] (0:@) insert_into_buffer: inserted at end, pos = 141 > [ 2.729569] (0:@) TRACE_paje_dump_buffer: dump until 2.082643. starts > [ 2.729569] (0:@) print_pajeAddVariable: event_type=8, timestamp=1.698471 > [ 2.729569] (0:@) free_paje_event: event_type=8, timestamp=1.698471 @@ -3188,36 +3188,36 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.870028] (0:@) insert_into_buffer: inserted at 49 > [ 2.870028] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.870028 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.870028, buffersize=51) -> [ 2.870028] (0:@) insert_into_buffer: inserted at end +> [ 2.870028] (0:@) insert_into_buffer: inserted at end, pos = 51 > [ 2.870028] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.742800 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.742800, buffersize=52) > [ 2.870028] (0:@) insert_into_buffer: inserted at 50 > [ 2.870028] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.870028 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.870028, buffersize=53) -> [ 2.870028] (0:@) insert_into_buffer: inserted at end +> [ 2.870028] (0:@) insert_into_buffer: inserted at end, pos = 53 > [ 2.870028] (0:@) TRACE_paje_dump_buffer: dump until 2.082643. starts > [ 2.870028] (0:@) TRACE_paje_dump_buffer: ends > [ 2.870028] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=2.870028 > [ 2.870028] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=2.870028, buffersize=54) -> [ 2.870028] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 2.870028] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 54 > [ 2.870028] (5:slave@Ginette) new_pajeAddVariable: event_type=8, timestamp=2.870028 > [ 2.870028] (5:slave@Ginette) insert_into_buffer: insert event_type=8, timestamp=2.870028, buffersize=55) -> [ 2.870028] (5:slave@Ginette) insert_into_buffer: inserted at end +> [ 2.870028] (5:slave@Ginette) insert_into_buffer: inserted at end, pos = 55 > [ 2.870028] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.685737 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.685737, buffersize=56) > [ 2.870028] (0:@) insert_into_buffer: inserted at 46 > [ 2.870028] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.870028 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.870028, buffersize=57) -> [ 2.870028] (0:@) insert_into_buffer: inserted at end +> [ 2.870028] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 2.870028] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.685737 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.685737, buffersize=58) > [ 2.870028] (0:@) insert_into_buffer: inserted at 47 > [ 2.870028] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.870028 > [ 2.870028] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.870028, buffersize=59) -> [ 2.870028] (0:@) insert_into_buffer: inserted at end +> [ 2.870028] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 2.888530] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.870028 > [ 2.888530] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.870028, buffersize=60) -> [ 2.888530] (0:@) insert_into_buffer: inserted at end +> [ 2.888530] (0:@) insert_into_buffer: inserted at end, pos = 60 > [ 2.888530] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.888530 > [ 2.888530] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.888530, buffersize=61) > [ 2.888530] (0:@) insert_into_buffer: inserted at end @@ -3226,7 +3226,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.888530] (0:@) insert_into_buffer: inserted at 61 > [ 2.888530] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.888530 > [ 2.888530] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.888530, buffersize=63) -> [ 2.888530] (0:@) insert_into_buffer: inserted at end +> [ 2.888530] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 2.888530] (0:@) TRACE_paje_dump_buffer: dump until 2.082643. starts > [ 2.888530] (0:@) TRACE_paje_dump_buffer: ends > [ 2.888686] (0:@) TRACE_paje_dump_buffer: dump until 2.082643. starts @@ -3241,10 +3241,10 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.890868] (0:@) TRACE_paje_dump_buffer: ends > [ 2.890868] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=2.890868 > [ 2.890868] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=2.890868, buffersize=66) -> [ 2.890868] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 2.890868] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 66 > [ 2.890868] (2:slave@Tremblay) new_pajeAddVariable: event_type=8, timestamp=2.890868 > [ 2.890868] (2:slave@Tremblay) insert_into_buffer: insert event_type=8, timestamp=2.890868, buffersize=67) -> [ 2.890868] (2:slave@Tremblay) insert_into_buffer: inserted at end +> [ 2.890868] (2:slave@Tremblay) insert_into_buffer: inserted at end, pos = 67 > [ 2.956139] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.300797 > [ 2.956139] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.300797, buffersize=68) > [ 2.956139] (0:@) insert_into_buffer: inserted at 30 @@ -3256,7 +3256,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 2.956139] (0:@) insert_into_buffer: inserted at 31 > [ 2.956139] (0:@) new_pajeSubVariable: event_type=9, timestamp=2.956139 > [ 2.956139] (0:@) insert_into_buffer: insert event_type=9, timestamp=2.956139, buffersize=71) -> [ 2.956139] (0:@) insert_into_buffer: inserted at end +> [ 2.956139] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 2.956139] (0:@) TRACE_paje_dump_buffer: dump until 2.082643. starts > [ 2.956139] (0:@) TRACE_paje_dump_buffer: ends > [ 2.976690] (0:@) TRACE_paje_dump_buffer: dump until 2.082643. starts @@ -3272,43 +3272,43 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.113741] (0:@) insert_into_buffer: inserted at 1 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=75) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 3.113741] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.976690 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.976690, buffersize=76) > [ 3.113741] (0:@) insert_into_buffer: inserted at 74 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=77) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 3.113741] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.976690 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.976690, buffersize=78) > [ 3.113741] (0:@) insert_into_buffer: inserted at 75 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=79) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 3.113741] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.976690 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.976690, buffersize=80) > [ 3.113741] (0:@) insert_into_buffer: inserted at 76 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=81) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 3.113741] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.976690 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.976690, buffersize=82) > [ 3.113741] (0:@) insert_into_buffer: inserted at 77 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=83) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 83 > [ 3.113741] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.976690 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.976690, buffersize=84) > [ 3.113741] (0:@) insert_into_buffer: inserted at 78 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=85) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 3.113741] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.976690 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.976690, buffersize=86) > [ 3.113741] (0:@) insert_into_buffer: inserted at 79 > [ 3.113741] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.113741 > [ 3.113741] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.113741, buffersize=87) -> [ 3.113741] (0:@) insert_into_buffer: inserted at end +> [ 3.113741] (0:@) insert_into_buffer: inserted at end, pos = 87 > [ 3.113741] (0:@) TRACE_paje_dump_buffer: dump until 2.685737. starts > [ 3.113741] (0:@) print_pajeAddVariable: event_type=8, timestamp=2.082643 > [ 3.113741] (0:@) free_paje_event: event_type=8, timestamp=2.082643 @@ -3417,7 +3417,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.113741] (0:@) TRACE_paje_dump_buffer: ends > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.113741 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.113741, buffersize=36) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 36 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=37) > [ 3.174292] (0:@) insert_into_buffer: inserted at end @@ -3426,51 +3426,51 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.174292] (0:@) insert_into_buffer: inserted at 37 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=39) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 39 > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.113741 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.113741, buffersize=40) > [ 3.174292] (0:@) insert_into_buffer: inserted at 38 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=41) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 41 > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.113741 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.113741, buffersize=42) > [ 3.174292] (0:@) insert_into_buffer: inserted at 39 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=43) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 43 > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.113741 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.113741, buffersize=44) > [ 3.174292] (0:@) insert_into_buffer: inserted at 40 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=45) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 45 > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.113741 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.113741, buffersize=46) > [ 3.174292] (0:@) insert_into_buffer: inserted at 41 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=47) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 47 > [ 3.174292] (0:@) TRACE_paje_dump_buffer: dump until 2.685737. starts > [ 3.174292] (0:@) TRACE_paje_dump_buffer: ends > [ 3.174292] (1:master@Tremblay) new_pajeSetVariable: event_type=7, timestamp=3.174292 > [ 3.174292] (1:master@Tremblay) insert_into_buffer: insert event_type=7, timestamp=3.174292, buffersize=48) -> [ 3.174292] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 3.174292] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 48 > [ 3.174292] (4:slave@Fafard) new_pajeAddVariable: event_type=8, timestamp=3.174292 > [ 3.174292] (4:slave@Fafard) insert_into_buffer: insert event_type=8, timestamp=3.174292, buffersize=49) -> [ 3.174292] (4:slave@Fafard) insert_into_buffer: inserted at end +> [ 3.174292] (4:slave@Fafard) insert_into_buffer: inserted at end, pos = 49 > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.890868 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.890868, buffersize=50) > [ 3.174292] (0:@) insert_into_buffer: inserted at 20 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=51) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 51 > [ 3.174292] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.890868 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=8, timestamp=2.890868, buffersize=52) > [ 3.174292] (0:@) insert_into_buffer: inserted at 21 > [ 3.174292] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.174292 > [ 3.174292] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.174292, buffersize=53) -> [ 3.174292] (0:@) insert_into_buffer: inserted at end +> [ 3.174292] (0:@) insert_into_buffer: inserted at end, pos = 53 > [ 3.194628] (0:@) TRACE_paje_dump_buffer: dump until 2.685737. starts > [ 3.194628] (0:@) TRACE_paje_dump_buffer: ends > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=2.685737 @@ -3484,91 +3484,91 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.341079] (0:@) insert_into_buffer: inserted at 1 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=57) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 57 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=58) > [ 3.341079] (0:@) insert_into_buffer: inserted at 56 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=59) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 59 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=60) > [ 3.341079] (0:@) insert_into_buffer: inserted at 57 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=61) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 61 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=62) > [ 3.341079] (0:@) insert_into_buffer: inserted at 58 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=63) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 63 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=64) > [ 3.341079] (0:@) insert_into_buffer: inserted at 59 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=65) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 65 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=66) > [ 3.341079] (0:@) insert_into_buffer: inserted at 60 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=67) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 67 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=68) > [ 3.341079] (0:@) insert_into_buffer: inserted at 61 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=69) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 69 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=70) > [ 3.341079] (0:@) insert_into_buffer: inserted at 62 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=71) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 71 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=72) > [ 3.341079] (0:@) insert_into_buffer: inserted at 63 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=73) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=74) > [ 3.341079] (0:@) insert_into_buffer: inserted at 64 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=75) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=76) > [ 3.341079] (0:@) insert_into_buffer: inserted at 65 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=77) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=78) > [ 3.341079] (0:@) insert_into_buffer: inserted at 66 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=79) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=80) > [ 3.341079] (0:@) insert_into_buffer: inserted at 67 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=81) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=82) > [ 3.341079] (0:@) insert_into_buffer: inserted at 68 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=83) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 83 > [ 3.341079] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.194628 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.194628, buffersize=84) > [ 3.341079] (0:@) insert_into_buffer: inserted at 69 > [ 3.341079] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.341079 > [ 3.341079] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.341079, buffersize=85) -> [ 3.341079] (0:@) insert_into_buffer: inserted at end +> [ 3.341079] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 3.341079] (0:@) TRACE_paje_dump_buffer: dump until 2.870028. starts > [ 3.341079] (0:@) print_pajeAddVariable: event_type=8, timestamp=2.685737 > [ 3.341079] (0:@) free_paje_event: event_type=8, timestamp=2.685737 @@ -3605,7 +3605,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.341079] (0:@) TRACE_paje_dump_buffer: ends > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=70) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 70 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=71) > [ 3.390164] (0:@) insert_into_buffer: inserted at end @@ -3614,102 +3614,102 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.390164] (0:@) insert_into_buffer: inserted at 71 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=73) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 73 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=74) > [ 3.390164] (0:@) insert_into_buffer: inserted at 72 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=75) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 75 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=76) > [ 3.390164] (0:@) insert_into_buffer: inserted at 73 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=77) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 77 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=78) > [ 3.390164] (0:@) insert_into_buffer: inserted at 74 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=79) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 79 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=80) > [ 3.390164] (0:@) insert_into_buffer: inserted at 75 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=81) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 81 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=82) > [ 3.390164] (0:@) insert_into_buffer: inserted at 76 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=83) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 83 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=84) > [ 3.390164] (0:@) insert_into_buffer: inserted at 77 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=85) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 85 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=86) > [ 3.390164] (0:@) insert_into_buffer: inserted at 78 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=87) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 87 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=88) > [ 3.390164] (0:@) insert_into_buffer: inserted at 79 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=89) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 89 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=90) > [ 3.390164] (0:@) insert_into_buffer: inserted at 80 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=91) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 91 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=92) > [ 3.390164] (0:@) insert_into_buffer: inserted at 81 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=93) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 93 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=94) > [ 3.390164] (0:@) insert_into_buffer: inserted at 82 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=95) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 95 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.341079 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.341079, buffersize=96) > [ 3.390164] (0:@) insert_into_buffer: inserted at 83 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=97) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 97 > [ 3.390164] (0:@) TRACE_paje_dump_buffer: dump until 2.870028. starts > [ 3.390164] (0:@) TRACE_paje_dump_buffer: ends > [ 3.390164] (1:master@Tremblay) new_pajeNewEvent: event_type=15, timestamp=3.390164 > [ 3.390164] (1:master@Tremblay) insert_into_buffer: insert event_type=15, timestamp=3.390164, buffersize=98) -> [ 3.390164] (1:master@Tremblay) insert_into_buffer: inserted at end +> [ 3.390164] (1:master@Tremblay) insert_into_buffer: inserted at end, pos = 98 > [ 3.390164] (6:slave@Bourassa) new_pajeAddVariable: event_type=8, timestamp=3.390164 > [ 3.390164] (6:slave@Bourassa) insert_into_buffer: insert event_type=8, timestamp=3.390164, buffersize=99) -> [ 3.390164] (6:slave@Bourassa) insert_into_buffer: inserted at end +> [ 3.390164] (6:slave@Bourassa) insert_into_buffer: inserted at end, pos = 99 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.174292 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.174292, buffersize=100) > [ 3.390164] (0:@) insert_into_buffer: inserted at 40 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=101) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 101 > [ 3.390164] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.174292 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.174292, buffersize=102) > [ 3.390164] (0:@) insert_into_buffer: inserted at 41 > [ 3.390164] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.390164 > [ 3.390164] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.390164, buffersize=103) -> [ 3.390164] (0:@) insert_into_buffer: inserted at end +> [ 3.390164] (0:@) insert_into_buffer: inserted at end, pos = 103 > [ 3.400578] (0:@) new_pajeAddVariable: event_type=8, timestamp=3.390164 > [ 3.400578] (0:@) insert_into_buffer: insert event_type=8, timestamp=3.390164, buffersize=104) -> [ 3.400578] (0:@) insert_into_buffer: inserted at end +> [ 3.400578] (0:@) insert_into_buffer: inserted at end, pos = 104 > [ 3.400578] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.400578 > [ 3.400578] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.400578, buffersize=105) > [ 3.400578] (0:@) insert_into_buffer: inserted at end @@ -3718,7 +3718,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.400578] (0:@) insert_into_buffer: inserted at 105 > [ 3.400578] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.400578 > [ 3.400578] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.400578, buffersize=107) -> [ 3.400578] (0:@) insert_into_buffer: inserted at end +> [ 3.400578] (0:@) insert_into_buffer: inserted at end, pos = 107 > [ 3.400578] (0:@) TRACE_paje_dump_buffer: dump until 2.870028. starts > [ 3.400578] (0:@) TRACE_paje_dump_buffer: ends > [ 3.405364] (0:@) TRACE_paje_dump_buffer: dump until 2.870028. starts @@ -3736,7 +3736,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.829634] (0:@) insert_into_buffer: inserted at 43 > [ 3.829634] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.829634 > [ 3.829634] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.829634, buffersize=111) -> [ 3.829634] (0:@) insert_into_buffer: inserted at end +> [ 3.829634] (0:@) insert_into_buffer: inserted at end, pos = 111 > [ 3.829634] (0:@) TRACE_paje_dump_buffer: dump until 2.870028. starts > [ 3.829634] (0:@) TRACE_paje_dump_buffer: ends > [ 3.850185] (0:@) TRACE_paje_dump_buffer: dump until 2.870028. starts @@ -3752,7 +3752,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 3.901126] (0:@) insert_into_buffer: inserted at 1 > [ 3.901126] (0:@) new_pajeSubVariable: event_type=9, timestamp=3.901126 > [ 3.901126] (0:@) insert_into_buffer: insert event_type=9, timestamp=3.901126, buffersize=115) -> [ 3.901126] (0:@) insert_into_buffer: inserted at end +> [ 3.901126] (0:@) insert_into_buffer: inserted at end, pos = 115 > [ 3.901126] (0:@) TRACE_paje_dump_buffer: dump until 3.390164. starts > [ 3.901126] (0:@) print_pajeAddVariable: event_type=8, timestamp=2.870028 > [ 3.901126] (0:@) free_paje_event: event_type=8, timestamp=2.870028 @@ -3988,7 +3988,7 @@ $ $SG_TEST_EXENV tracing/ms$EXEEXT --cfg=tracing:1 --cfg=tracing/filename:tracin > [ 4.421262] (0:@) insert_into_buffer: inserted at 1 > [ 4.421262] (0:@) new_pajeSubVariable: event_type=9, timestamp=4.421262 > [ 4.421262] (0:@) insert_into_buffer: insert event_type=9, timestamp=4.421262, buffersize=9) -> [ 4.421262] (0:@) insert_into_buffer: inserted at end +> [ 4.421262] (0:@) insert_into_buffer: inserted at end, pos = 9 > [ 4.421262] (0:@) TRACE_paje_dump_buffer: dump until 3.405364. starts > [ 4.421262] (0:@) print_pajeAddVariable: event_type=8, timestamp=3.390164 > [ 4.421262] (0:@) free_paje_event: event_type=8, timestamp=3.390164 diff --git a/src/instr/instr_paje_trace.c b/src/instr/instr_paje_trace.c index 4841f79ae5..945d3f773b 100644 --- a/src/instr/instr_paje_trace.c +++ b/src/instr/instr_paje_trace.c @@ -321,12 +321,21 @@ static void insert_into_buffer (paje_event_t tbi) DEBUG4("%s: insert event_type=%d, timestamp=%f, buffersize=%ld)", __FUNCTION__, tbi->event_type, tbi->timestamp, xbt_dynar_length(buffer)); unsigned int i; - if (xbt_dynar_length(buffer) == 0){ + unsigned long len = xbt_dynar_length(buffer); + if (len == 0){ xbt_dynar_push (buffer, &tbi); DEBUG1("%s: inserted at beginning", __FUNCTION__); }else{ + //check if last event has the same timestamp that tbi event + paje_event_t e2 = *(paje_event_t*)xbt_dynar_get_ptr (buffer, len-1); + if (e2->timestamp == tbi->timestamp){ + //insert at the end + DEBUG2("%s: inserted at end, pos = %ld", __FUNCTION__, len); + xbt_dynar_insert_at (buffer, len, &tbi); + return; + } int inserted = 0; - for (i = 0; i < xbt_dynar_length(buffer); i++){ + for (i = 0; i < len; i++){ paje_event_t e1 = *(paje_event_t*)xbt_dynar_get_ptr(buffer, i); if (e1->timestamp > tbi->timestamp){ xbt_dynar_insert_at (buffer, i, &tbi); -- 2.20.1