Project

General

Profile

Bug #424 » log_2013_01_17_13_03.txt

logs captured when consumerd crashed - Mathieu Bain, 01/18/2013 10:20 AM

 
SC-1:/cluster/dumps # cat /var/log/messages | grep -C 10 "Jan 17 13:03"
Jan 17 13:02:18 SC-1 osafimmnd[6780]: Ccb 943208 COMMITTED (TraceC)
Jan 17 13:02:19 SC-1 osafimmnd[6780]: Ccb 943209 COMMITTED (TraceC)
Jan 17 13:02:19 SC-1 osafimmnd[6780]: Ccb 943210 COMMITTED (TraceC)
Jan 17 13:02:20 SC-1 osafimmnd[6780]: Ccb 943211 COMMITTED (TraceC)
Jan 17 13:02:26 SC-1 osafimmnd[6780]: Ccb 943232 COMMITTED (TraceC)
Jan 17 13:02:26 SC-1 osafimmnd[6780]: Ccb 943233 COMMITTED (TraceC)
Jan 17 13:02:48 SC-1 osafimmnd[6780]: Ccb 943235 COMMITTED (TraceC)
Jan 17 13:02:48 SC-1 osafimmnd[6780]: Ccb 943236 COMMITTED (TraceC)
Jan 17 13:02:55 SC-1 osafimmnd[6780]: Ccb 943237 COMMITTED (TraceC)
Jan 17 13:02:56 SC-1 osafimmnd[6780]: Ccb 943238 COMMITTED (TraceC)
Jan 17 13:03:02 SC-1 osafimmnd[6780]: Ccb 943334 COMMITTED (TraceCLI)
Jan 17 13:03:08 SC-1 osafimmnd[6780]: Ccb 943392 COMMITTED (TraceCLI)
Jan 17 13:03:15 SC-1 osafimmnd[6780]: Ccb 943393 COMMITTED (TraceCLI)
Jan 17 13:03:15 SC-1 osafimmnd[6780]: Ccb 943394 COMMITTED (TraceC)
Jan 17 13:03:15 SC-1 osafimmnd[6780]: Ccb 943396 COMMITTED (TraceC)
Jan 17 13:03:15 SC-1 osafimmnd[6780]: Ccb 943397 COMMITTED (TraceC)
Jan 17 13:03:15 SC-1 osafimmnd[6780]: Ccb 943398 COMMITTED (TraceC)
Jan 17 13:03:16 SC-1 osafimmnd[6780]: Ccb 943399 COMMITTED (TraceC)
Jan 17 13:03:16 SC-1 CMW: Invoked: [cmw-status -v siass]
Jan 17 13:03:17 SC-1 CMW: Invoked: [cmw-status -v siass]
Jan 17 13:03:21 SC-1 osafimmnd[6780]: Ccb 943419 COMMITTED (TraceCLI)
Jan 17 13:03:21 SC-1 osafimmnd[6780]: Ccb 943420 COMMITTED (TraceC)
Jan 17 13:03:22 SC-1 osafimmnd[6780]: Ccb 943422 COMMITTED (TraceC)
Jan 17 13:03:22 SC-1 osafimmnd[6780]: Ccb 943423 COMMITTED (TraceC)
Jan 17 13:03:22 SC-1 osafimmnd[6780]: Ccb 943424 COMMITTED (TraceC)
Jan 17 13:03:23 SC-1 osafimmnd[6780]: Ccb 943425 COMMITTED (TraceC)
Jan 17 13:03:24 SC-1 osafimmnd[6780]: Ccb 943427 COMMITTED (TraceC)
Jan 17 13:03:24 SC-1 osafimmnd[6780]: Ccb 943428 COMMITTED (TraceC)
Jan 17 13:03:24 SC-1 CMW: Invoked: [cmw-status -v siass]
Jan 17 13:03:24 SC-1 CMW: Invoked: [cmw-status -v siass]
Jan 17 13:03:26 SC-1 osafimmnd[6780]: Ccb 943448 COMMITTED (TraceC)
Jan 17 13:03:30 SC-1 osafimmnd[6780]: Ccb 943468 COMMITTED (TraceC)
Jan 17 13:03:30 SC-1 osafimmnd[6780]: Ccb 943469 COMMITTED (TraceC)
Jan 17 13:03:30 SC-1 osafimmnd[6780]: Ccb 943470 COMMITTED (TraceC)
Jan 17 13:03:30 SC-1 osafimmnd[6780]: Ccb 943471 COMMITTED (TraceC)
Jan 17 13:03:41 SC-1 osafimmnd[6780]: Ccb 943492 COMMITTED (TraceC)
Jan 17 13:03:41 SC-1 osafimmnd[6780]: Ccb 943493 COMMITTED (TraceC)
Jan 17 13:03:43 SC-1 osafimmnd[6780]: Ccb 943495 COMMITTED (TraceC)
Jan 17 13:03:43 SC-1 osafimmnd[6780]: Ccb 943496 COMMITTED (TraceC)
Jan 17 13:03:44 SC-1 osafimmnd[6780]: Ccb 943498 COMMITTED (TraceC)
Jan 17 13:03:44 SC-1 osafimmnd[6780]: Ccb 943499 COMMITTED (TraceC)
Jan 17 13:03:44 SC-1 osafimmnd[6780]: Ccb 943500 COMMITTED (TraceC)
Jan 17 13:03:44 SC-1 osafimmnd[6780]: Ccb 943501 COMMITTED (TraceC)
Jan 17 13:03:47 SC-1 TraceEa: SessionD healthcheck failed: LTTNG_HEALTH_CONSUMER !
Jan 17 13:03:47 SC-1 TraceEa: sessiond faulted - Trying to Stop LTTNG
Jan 17 13:03:47 SC-1 logger: lttng-sessiond is stopped
Jan 17 13:03:50 SC-1 logger: lttng-sessiond is started
Jan 17 13:03:52 SC-1 osafimmnd[6780]: Ccb 943521 COMMITTED (TraceC)
Jan 17 13:03:52 SC-1 osafimmnd[6780]: Ccb 943522 COMMITTED (TraceC)
Jan 17 13:03:52 SC-1 osafimmnd[6780]: Ccb 943523 COMMITTED (TraceC)
Jan 17 13:03:52 SC-1 osafimmnd[6780]: Ccb 943524 COMMITTED (TraceC)
Jan 17 13:04:02 SC-1 osafimmnd[6780]: Ccb 943581 COMMITTED (TraceCLI)
Jan 17 13:04:11 SC-1 osafimmnd[6780]: Ccb 943640 COMMITTED (TraceCLI)
Jan 17 13:04:11 SC-1 osafimmnd[6780]: Ccb 943641 COMMITTED (TraceC)
Jan 17 13:04:12 SC-1 osafimmnd[6780]: Ccb 943643 COMMITTED (TraceC)
Jan 17 13:04:12 SC-1 osafimmnd[6780]: Ccb 943644 COMMITTED (TraceC)
Jan 17 13:04:12 SC-1 osafimmnd[6780]: Ccb 943645 COMMITTED (TraceC)
Jan 17 13:04:13 SC-1 osafimmnd[6780]: Ccb 943646 COMMITTED (TraceC)
Jan 17 13:04:18 SC-1 osafimmnd[6780]: Ccb 943667 COMMITTED (TraceC)
Jan 17 13:04:18 SC-1 osafimmnd[6780]: Ccb 943668 COMMITTED (TraceC)
Jan 17 13:04:45 SC-1 osafimmnd[6780]: Ccb 943670 COMMITTED (TraceC)

######################################################################################
######################################################################################
######################################################################################

SC-1:/storage/no-backup/coremw/var/log/saflog # cat saLogSystem_20130117_125727_20130117_133727.log | grep " 13:03"
1603903 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB003_b_1 is being added to parent directory /storage/no-backup/tracecc-apr9010500
1603904 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory SC-2 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603905 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2
1603906 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2/ust
1603907 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-2 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603908 13:03:00 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting SC-2
1603909 13:03:00 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory SC-2 is being deleted
1603910 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-2 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603911 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2
1603912 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2/ust
1603913 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-14462-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2/ust
1603914 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-14491-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2/ust
1603915 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-14430-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-2/ust
1603916 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-3 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603917 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3
1603918 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Thread1-22919-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3/ust
1603919 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3
1603920 13:03:00 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1603921 13:03:00 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1603922 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3
1603923 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Thread1-22919-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3/ust
1603924 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-22854-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3/ust
1603925 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22883-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3/ust
1603926 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22886-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-3/ust
1603927 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-4 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603928 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4
1603929 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22899-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4/ust
1603930 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4
1603931 13:03:00 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1603932 13:03:00 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1603933 13:03:00 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4
1603934 13:03:00 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22899-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4/ust
1603935 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22930-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4/ust
1603936 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22896-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4/ust
1603937 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-22867-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/PL-4/ust
1603938 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-1 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603939 13:03:01 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1
1603940 13:03:01 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Thread1-32463-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1/ust
1603941 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1
1603942 13:03:01 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1603943 13:03:01 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1603944 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1
1603945 13:03:01 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Thread1-32463-20130117-130219 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1/ust
1603946 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-32352-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1/ust
1603947 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-32406-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1/ust
1603948 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-32409-20130117-130219 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1/SC-1/ust
1603949 13:03:01 01/17/2013 IN TraceC "DBG: Converting output operation
1603950 13:03:01 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs"
1603951 13:03:01 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs was created successfully!
1603952 13:03:01 01/17/2013 NO TraceC "Converting session "STAB003_b_1"
1603953 13:03:01 01/17/2013 IN TraceC "DBG: resetOrCreate traceSessionRecordingId=STAB003_b_1,traceMId=1
1603954 13:03:01 01/17/2013 IN TraceC "DBG: ConvertAsyncProgress: Create request for child object of traceSessionRecordingId=STAB003_b_1,traceMId=1
1603955 13:03:01 01/17/2013 IN TraceC "DBG: ConvertAsyncProgressImplementer: id=1,traceSessionRecordingId=STAB003_b_1,traceMId=1 was successfully created
1603956 13:03:01 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1603957 13:03:01 01/17/2013 IN TraceC "DBG: -== start convert output from /storage/no-backup/tracecc-apr9010500//STAB003_b_1/SC-2 to /storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs/Node_SC-2.log ==-
1603958 13:03:01 01/17/2013 IN TraceC "DBG: === ConvertOutputTask::babelTraceConvert, bfile=/storage/no-backup/tracecc-apr9010500//STAB003_b_1/SC-2,desFile=/storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs/Node_SC-2.log ===
1603959 13:03:01 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory Converted_logs is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603960 13:03:01 01/17/2013 IN TraceC "DBG: Dispatch: epoll_wait returned an error: 4
1603961 13:03:01 01/17/2013 IN TraceC "DBG: SigChildHandler: second half handling. death count: 1
1603962 13:03:01 01/17/2013 IN TraceC "DBG: Received death of pid 31353 with ret 0.
1603963 13:03:01 01/17/2013 IN TraceC "DBG: ConvertOutputTask::handleSigChild line=61 return: 0
1603964 13:03:01 01/17/2013 IN TraceC "DBG: receiveConvertOutputResult() result: 0
1603965 13:03:01 01/17/2013 NO TraceC "Completed conversion of session "STAB003_b_1".
1603966 13:03:02 01/17/2013 IN TraceC "DBG: Delete Session operation was requested for traceSessionRecordingId=STAB002_3,traceMId=1
1603967 13:03:02 01/17/2013 IN TraceC "deleteSession
1603968 13:03:02 01/17/2013 IN TraceC "DBG: deleteSession Removing session Directory traceSessionRecordingId=STAB002_3,traceMId=1
1603969 13:03:02 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB002_3"
1603970 13:03:02 01/17/2013 IN TraceC "DBG: remove called to delete file /storage/no-backup/tracecc-apr9010500//.tmp/STAB002_3
1603971 13:03:02 01/17/2013 IN TraceC "DBG: deleteSession deleting ConvertAsyncActionProgress if it exists traceSessionRecordingId=STAB002_3,traceMId=1
1603972 13:03:02 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_3"
1603973 13:03:02 01/17/2013 IN TraceC "DBG: deleteSession deleting Session MO and removing it from Registry traceSessionRecordingId=STAB002_3,traceMId=1
1603974 13:03:02 01/17/2013 IN TraceC "DBG: deleteSession deleting Session Object traceSessionRecordingId=STAB002_3,traceMId=1
1603975 13:03:02 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1603976 13:03:02 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB002_3 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500
1603977 13:03:02 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting STAB002_3
1603978 13:03:02 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping: directoryDeleteHandler is deleting STAB002_3
1603979 13:03:02 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory STAB002_3 is being deleted
1603980 13:03:02 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_3" Deleted!
1603981 13:03:02 01/17/2013 IN TraceC "DBG: Completed deletion of "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_3"
1603982 13:03:03 01/17/2013 IN TraceC "DBG: Converting output operation
1603983 13:03:03 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs"
1603984 13:03:03 01/17/2013 IN TraceC "DBG: remove called to delete file /storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs
1603985 13:03:03 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs"
1603986 13:03:03 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs was created successfully!
1603987 13:03:03 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs" Deleted!
1603988 13:03:03 01/17/2013 IN TraceC "DBG: Completed deletion of "/storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs"
1603989 13:03:03 01/17/2013 NO TraceC "Converting session "STAB003_b_1"
1603990 13:03:03 01/17/2013 IN TraceC "DBG: resetOrCreate traceSessionRecordingId=STAB003_b_1,traceMId=1
1603991 13:03:03 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1603992 13:03:03 01/17/2013 IN TraceC "DBG: -== start convert output from /storage/no-backup/tracecc-apr9010500//STAB003_b_1/PL-3 to /storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs/Node_PL-3.log ==-
1603993 13:03:03 01/17/2013 IN TraceC "DBG: === ConvertOutputTask::babelTraceConvert, bfile=/storage/no-backup/tracecc-apr9010500//STAB003_b_1/PL-3,desFile=/storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs/Node_PL-3.log ===
1603994 13:03:03 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory Converted_logs has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603995 13:03:03 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting Converted_logs
1603996 13:03:03 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory Converted_logs is being deleted
1603997 13:03:03 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory Converted_logs is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1603998 13:03:03 01/17/2013 IN TraceC "DBG: Dispatch: epoll_wait returned an error: 4
1603999 13:03:03 01/17/2013 IN TraceC "DBG: SigChildHandler: second half handling. death count: 1
1604000 13:03:03 01/17/2013 IN TraceC "DBG: Received death of pid 32148 with ret 0.
1604001 13:03:03 01/17/2013 IN TraceC "DBG: ConvertOutputTask::handleSigChild line=61 return: 0
1604002 13:03:03 01/17/2013 IN TraceC "DBG: receiveConvertOutputResult() result: 0
1604003 13:03:03 01/17/2013 NO TraceC "Completed conversion of session "STAB003_b_1".
1604004 13:03:05 01/17/2013 IN TraceC "DBG: Converting output operation
1604005 13:03:05 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs"
1604006 13:03:05 01/17/2013 IN TraceC "DBG: remove called to delete file /storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs
1604007 13:03:05 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs"
1604008 13:03:05 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs was created successfully!
1604009 13:03:05 01/17/2013 NO TraceC "Converting session "STAB003_b_1"
1604010 13:03:05 01/17/2013 IN TraceC "DBG: resetOrCreate traceSessionRecordingId=STAB003_b_1,traceMId=1
1604011 13:03:05 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604012 13:03:05 01/17/2013 IN TraceC "DBG: -== start convert output from /storage/no-backup/tracecc-apr9010500//STAB003_b_1/PL-4 to /storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs/Node_PL-4.log ==-
1604013 13:03:05 01/17/2013 IN TraceC "DBG: === ConvertOutputTask::babelTraceConvert, bfile=/storage/no-backup/tracecc-apr9010500//STAB003_b_1/PL-4,desFile=/storage/no-backup/tracecc-apr9010500//STAB003_b_1/Converted_logs/Node_PL-4.log ===
1604014 13:03:05 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs" Deleted!
1604015 13:03:05 01/17/2013 IN TraceC "DBG: Completed deletion of "/storage/no-backup/tracecc-apr9010500//.tmp/Converted_logs"
1604016 13:03:05 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory Converted_logs has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1604017 13:03:05 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting Converted_logs
1604018 13:03:05 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory Converted_logs is being deleted
1604019 13:03:05 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory Converted_logs is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_b_1
1604020 13:03:05 01/17/2013 IN TraceC "DBG: Dispatch: epoll_wait returned an error: 4
1604021 13:03:05 01/17/2013 IN TraceC "DBG: SigChildHandler: second half handling. death count: 1
1604022 13:03:05 01/17/2013 IN TraceC "DBG: Received death of pid 32719 with ret 0.
1604023 13:03:05 01/17/2013 IN TraceC "DBG: ConvertOutputTask::handleSigChild line=61 return: 0
1604024 13:03:05 01/17/2013 IN TraceC "DBG: receiveConvertOutputResult() result: 0
1604025 13:03:05 01/17/2013 NO TraceC "Completed conversion of session "STAB003_b_1".
1604026 13:03:07 01/17/2013 IN TraceC "DBG: Delete Session operation was requested for traceSessionRecordingId=STAB003_b_1,traceMId=1
1604027 13:03:07 01/17/2013 IN TraceC "deleteSession
1604028 13:03:07 01/17/2013 IN TraceC "DBG: deleteSession Removing session Directory traceSessionRecordingId=STAB003_b_1,traceMId=1
1604029 13:03:07 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB003_b_1"
1604030 13:03:07 01/17/2013 IN TraceC "DBG: remove called to delete file /storage/no-backup/tracecc-apr9010500//.tmp/STAB003_b_1
1604031 13:03:07 01/17/2013 IN TraceC "DBG: deleteSession deleting ConvertAsyncActionProgress if it exists traceSessionRecordingId=STAB003_b_1,traceMId=1
1604032 13:03:07 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB003_b_1"
1604033 13:03:07 01/17/2013 IN TraceC "DBG: deleteSession deleting Session MO and removing it from Registry traceSessionRecordingId=STAB003_b_1,traceMId=1
1604034 13:03:07 01/17/2013 IN TraceC "DBG: deleteSession deleting Session Object traceSessionRecordingId=STAB003_b_1,traceMId=1
1604035 13:03:07 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604036 13:03:07 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB003_b_1 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500
1604037 13:03:07 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting STAB003_b_1
1604038 13:03:07 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping: directoryDeleteHandler is deleting STAB003_b_1
1604039 13:03:07 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory STAB003_b_1 is being deleted
1604040 13:03:07 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB003_b_1" Deleted!
1604041 13:03:07 01/17/2013 IN TraceC "DBG: Completed deletion of "/storage/no-backup/tracecc-apr9010500//.tmp/STAB003_b_1"
1604042 13:03:15 01/17/2013 IN TraceC "DBG: ProfileAdmin::profileIdValidator was called
1604043 13:03:15 01/17/2013 IN TraceC "DBG: newvalue size=22
1604044 13:03:15 01/17/2013 IN TraceC "DBG: newvalue=traceProfileId=STAB002
1604045 13:03:15 01/17/2013 IN TraceC "DBG: traceExpressionsValidator was called for traceExpression with size = 5.
1604046 13:03:15 01/17/2013 IN TraceC "DBG: conditionValidator: About to create a temporary session _TraceCValidator_zrbxQy in path /tmp/_TraceCValidator_zrbxQy - Invoke lttng_create_session
1604047 13:03:15 01/17/2013 IN TraceC "DBG: conditionValidator: Invoke lttng_create_handle for temporary session _TraceCValidator_zrbxQy.
1604048 13:03:15 01/17/2013 IN TraceC "DBG: conditionValidator: Invoke lttng_set_default_handle_attr for temporary session _TraceCValidator_zrbxQy
1604049 13:03:15 01/17/2013 IN TraceC "DBG: conditionValidator: Invoke lttng_destroy_session for temporary session _TraceCValidator_zrbxQy
1604050 13:03:15 01/17/2013 IN TraceC "DBG: Try to remove directory "/tmp/_TraceCValidator_zrbxQy"
1604051 13:03:15 01/17/2013 IN TraceC "DBG: Remove Directory "/tmp/_TraceCValidator_zrbxQy" Deleted!
1604052 13:03:15 01/17/2013 IN TraceC "DBG: conditionValidator: Reply recieved from lttng_destroy_session for temporary session _TraceCValidator_zrbxQy.
1604053 13:03:15 01/17/2013 IN TraceC "DBG: Create: class: AsyncActionProgress, parentName: traceProfileId=STAB002,traceMId=1
1604054 13:03:15 01/17/2013 IN TraceC "DBG: Activating
1604055 13:03:15 01/17/2013 IN TraceC "DBG: creating session traceSessionRecordingId=STAB002_1,traceMId=1 as a runtime object
1604056 13:03:15 01/17/2013 NO TraceC "Activating Session STAB002_1.
1604057 13:03:15 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB002_1 was created successfully!
1604058 13:03:15 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604059 13:03:15 01/17/2013 IN TraceC "DBG: performActivate: Starting RelayD for session STAB002_1.
1604060 13:03:15 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604061 13:03:15 01/17/2013 IN TraceC "DBG: RelayDManager::start() Control port selected: 56465
1604062 13:03:15 01/17/2013 IN TraceC "DBG: RelayDManager::start() Data port selected: 59168
1604063 13:03:15 01/17/2013 IN TraceC "DBG: RelayDManager::start() Pipe opened
1604064 13:03:15 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604065 13:03:15 01/17/2013 IN TraceC "DBG: RelayDManager::start() RelayD for "STAB002_1" pid: 3164 bound on 192.168.0.1:56465:59168
1604066 13:03:15 01/17/2013 IN TraceC "DBG: performActivate: Writing session into file
1604067 13:03:15 01/17/2013 IN TraceC "DBG: Done Activating
1604068 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB002_1 is being added to parent directory /storage/no-backup/tracecc-apr9010500
1604069 13:03:15 01/17/2013 IN TraceC "DBG: RelayD has been launch for STAB002_1 session after 1 tries to connect to free ports.
1604070 13:03:15 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604071 13:03:15 01/17/2013 IN TraceC "DBG: performActivateAfterRelayD: Sending commands to the trace_ps.
1604072 13:03:15 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 2, addr: 0x7F235405FE00
1604073 13:03:15 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 2, addr: 0x7F2354000C60
1604074 13:03:15 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 2, addr: 0x7F2354000D20
1604075 13:03:15 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 2, addr: 0x7F2354035B90
1604076 13:03:15 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604077 13:03:15 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F235405FE00
1604078 13:03:15 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604079 13:03:15 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F2354000C60
1604080 13:03:15 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F2354000D20
1604081 13:03:15 01/17/2013 IN TraceP_PL-3 "Activating
1604082 13:03:15 01/17/2013 IN TraceP_PL-4 "Activating
1604083 13:03:15 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F2354035B90
1604084 13:03:15 01/17/2013 IN TraceP_SC-1 "Activating
1604085 13:03:15 01/17/2013 IN TraceP_SC-2 "Activating
1604086 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: invoke lttng_create_session for session STAB002_1 with url net://192.168.0.1:56465:59168/./.
1604087 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_1
1604088 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_1.
1604089 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_1
1604090 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604091 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: invoke lttng_create_session for session STAB002_1 with url net://192.168.0.1:56465:59168/./.
1604092 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604093 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604094 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-1 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1
1604095 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: invoke lttng_create_session for session STAB002_1 with url net://192.168.0.1:56465:59168/./.
1604096 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_1
1604097 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_1.
1604098 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_1
1604099 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_1
1604100 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_1.
1604101 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604102 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_1
1604103 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604104 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604105 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604106 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604107 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604108 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604109 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604110 13:03:15 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_1
1604111 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604112 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604113 13:03:15 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_1
1604114 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604115 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_1, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604116 13:03:15 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_1
1604117 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1
1604118 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1/ust
1604119 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1
1604120 13:03:15 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604121 13:03:15 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604122 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1
1604123 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1/ust
1604124 13:03:15 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604125 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-2 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1
1604126 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2
1604127 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2/ust
1604128 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2
1604129 13:03:15 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604130 13:03:15 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604131 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2
1604132 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2/ust
1604133 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-32352-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1/ust
1604134 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-3 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1
1604135 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3
1604136 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22886-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3/ust
1604137 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3
1604138 13:03:15 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604139 13:03:15 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604140 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3
1604141 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22886-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3/ust
1604142 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-4 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1
1604143 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4
1604144 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4/ust
1604145 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4
1604146 13:03:15 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604147 13:03:15 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604148 13:03:15 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4
1604149 13:03:15 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130315 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4/ust
1604150 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-14430-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2/ust
1604151 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22883-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3/ust
1604152 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22899-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4/ust
1604153 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-32406-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1/ust
1604154 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22930-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4/ust
1604155 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-22854-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3/ust
1604156 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-14462-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2/ust
1604157 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-32463-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1/ust
1604158 13:03:16 01/17/2013 IN TraceP_SC-1 "Activation completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1
1604159 13:03:16 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604160 13:03:16 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604161 13:03:16 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604162 13:03:16 01/17/2013 NO TraceC "Session STAB002_1 activated.
1604163 13:03:16 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604164 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22919-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-3/ust
1604165 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-14491-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2/ust
1604166 13:03:16 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22896-20130117-130315 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_1/PL-4/ust
1604167 13:03:16 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_1.
1604168 13:03:16 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8284 value: 1, return code: 1 , SA_AIS_OK
1604169 13:03:16 01/17/2013 IN TraceP_SC-2 "Activation completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1
1604170 13:03:16 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604171 13:03:16 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604172 13:03:16 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604173 13:03:16 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_1.
1604174 13:03:16 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8281 value: 1, return code: 1 , SA_AIS_OK
1604175 13:03:16 01/17/2013 IN TraceP_PL-3 "Activation completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1
1604176 13:03:16 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604177 13:03:16 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_1.
1604178 13:03:16 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8282 value: 1, return code: 1 , SA_AIS_OK
1604179 13:03:16 01/17/2013 IN TraceP_PL-4 "Activation completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1
1604180 13:03:16 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604181 13:03:16 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604182 13:03:16 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604183 13:03:16 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604184 13:03:16 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604185 13:03:21 01/17/2013 IN TraceC "DBG: ProfileAdmin::profileIdValidator was called
1604186 13:03:21 01/17/2013 IN TraceC "DBG: newvalue size=24
1604187 13:03:21 01/17/2013 IN TraceC "DBG: newvalue=traceProfileId=STAB003_a
1604188 13:03:21 01/17/2013 IN TraceC "DBG: traceExpressionsValidator was called for traceExpression with size = 24.
1604189 13:03:21 01/17/2013 IN TraceC "DBG: conditionValidator: About to create a temporary session _TraceCValidator_NlYG6k in path /tmp/_TraceCValidator_NlYG6k - Invoke lttng_create_session
1604190 13:03:21 01/17/2013 IN TraceC "DBG: conditionValidator: Invoke lttng_create_handle for temporary session _TraceCValidator_NlYG6k.
1604191 13:03:21 01/17/2013 IN TraceC "DBG: conditionValidator: Invoke lttng_set_default_handle_attr for temporary session _TraceCValidator_NlYG6k
1604192 13:03:21 01/17/2013 IN TraceC "DBG: conditionValidator: Invoke lttng_destroy_session for temporary session _TraceCValidator_NlYG6k
1604193 13:03:21 01/17/2013 IN TraceC "DBG: Try to remove directory "/tmp/_TraceCValidator_NlYG6k"
1604194 13:03:21 01/17/2013 IN TraceC "DBG: Remove Directory "/tmp/_TraceCValidator_NlYG6k" Deleted!
1604195 13:03:21 01/17/2013 IN TraceC "DBG: conditionValidator: Reply recieved from lttng_destroy_session for temporary session _TraceCValidator_NlYG6k.
1604196 13:03:21 01/17/2013 IN TraceC "DBG: Create: class: AsyncActionProgress, parentName: traceProfileId=STAB003_a,traceMId=1
1604197 13:03:22 01/17/2013 IN TraceC "DBG: Activating
1604198 13:03:22 01/17/2013 IN TraceC "DBG: creating session traceSessionRecordingId=STAB003_a_1,traceMId=1 as a runtime object
1604199 13:03:22 01/17/2013 NO TraceC "Activating Session STAB003_a_1.
1604200 13:03:22 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB003_a_1 was created successfully!
1604201 13:03:22 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604202 13:03:22 01/17/2013 IN TraceC "DBG: performActivate: Starting RelayD for session STAB003_a_1.
1604203 13:03:22 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604204 13:03:22 01/17/2013 IN TraceC "DBG: RelayDManager::start() Control port selected: 58681
1604205 13:03:22 01/17/2013 IN TraceC "DBG: RelayDManager::start() Data port selected: 54813
1604206 13:03:22 01/17/2013 IN TraceC "DBG: RelayDManager::start() Pipe opened
1604207 13:03:22 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604208 13:03:22 01/17/2013 IN TraceC "DBG: RelayDManager::start() RelayD for "STAB003_a_1" pid: 4849 bound on 192.168.0.1:58681:54813
1604209 13:03:22 01/17/2013 IN TraceC "DBG: performActivate: Writing session into file
1604210 13:03:22 01/17/2013 IN TraceC "DBG: Done Activating
1604211 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB003_a_1 is being added to parent directory /storage/no-backup/tracecc-apr9010500
1604212 13:03:22 01/17/2013 IN TraceC "DBG: RelayD has been launch for STAB003_a_1 session after 1 tries to connect to free ports.
1604213 13:03:22 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604214 13:03:22 01/17/2013 IN TraceC "DBG: performActivateAfterRelayD: Sending commands to the trace_ps.
1604215 13:03:22 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 2, addr: 0x7F234C04B4B0
1604216 13:03:22 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 2, addr: 0x7F234C00EDE0
1604217 13:03:22 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 2, addr: 0x7F234C005010
1604218 13:03:22 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 2, addr: 0x7F234C06ECD0
1604219 13:03:22 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604220 13:03:22 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C04B4B0
1604221 13:03:22 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604222 13:03:22 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C00EDE0
1604223 13:03:22 01/17/2013 IN TraceP_PL-3 "Activating
1604224 13:03:22 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C005010
1604225 13:03:22 01/17/2013 IN TraceP_PL-4 "Activating
1604226 13:03:22 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C06ECD0
1604227 13:03:22 01/17/2013 IN TraceP_SC-1 "Activating
1604228 13:03:22 01/17/2013 IN TraceP_SC-2 "Activating
1604229 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: invoke lttng_create_session for session STAB003_a_1 with url net://192.168.0.1:58681:54813/./.
1604230 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_create_handle for session STAB003_a_1
1604231 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB003_a_1.
1604232 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_channel for session STAB003_a_1
1604233 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba:cba_domain_event, with cond ''
1604234 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace:trace_domain_event, with cond ''
1604235 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp:testapp_domain_event, with cond ''
1604236 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:OnePerSecA, with cond ''
1604237 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:OnePerSecB, with cond ''
1604238 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:TenPerSecA, with cond ''
1604239 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:TenPerSecB, with cond ''
1604240 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:OnePerSecA, with cond ''
1604241 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:OnePerSecB, with cond ''
1604242 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:TenPerSecA, with cond ''
1604243 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:TenPerSecB, with cond ''
1604244 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread_main:OnePerSecA, with cond ''
1604245 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:OnePerSecA, with cond ''
1604246 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:OnePerSecB, with cond ''
1604247 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA, with cond ''
1604248 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecB, with cond ''
1604249 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:OnePerSecA, with cond ''
1604250 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: invoke lttng_create_session for session STAB003_a_1 with url net://192.168.0.1:58681:54813/./.
1604251 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:OnePerSecB, with cond ''
1604252 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:TenPerSecA, with cond ''
1604253 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_create_handle for session STAB003_a_1
1604254 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB003_a_1.
1604255 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_channel for session STAB003_a_1
1604256 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:TenPerSecB, with cond ''
1604257 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:OnePerSecA, with cond ''
1604258 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:OnePerSecB, with cond ''
1604259 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:TenPerSecA, with cond ''
1604260 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:TenPerSecB, with cond ''
1604261 13:03:22 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB003_a_1
1604262 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba:cba_domain_event, with cond ''
1604263 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace:trace_domain_event, with cond ''
1604264 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp:testapp_domain_event, with cond ''
1604265 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: invoke lttng_create_session for session STAB003_a_1 with url net://192.168.0.1:58681:54813/./.
1604266 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:OnePerSecA, with cond ''
1604267 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_create_handle for session STAB003_a_1
1604268 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:OnePerSecB, with cond ''
1604269 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB003_a_1.
1604270 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_channel for session STAB003_a_1
1604271 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:TenPerSecA, with cond ''
1604272 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:TenPerSecB, with cond ''
1604273 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:OnePerSecA, with cond ''
1604274 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:OnePerSecB, with cond ''
1604275 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:TenPerSecA, with cond ''
1604276 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:TenPerSecB, with cond ''
1604277 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread_main:OnePerSecA, with cond ''
1604278 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:OnePerSecA, with cond ''
1604279 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba:cba_domain_event, with cond ''
1604280 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:OnePerSecB, with cond ''
1604281 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace:trace_domain_event, with cond ''
1604282 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA, with cond ''
1604283 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp:testapp_domain_event, with cond ''
1604284 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecB, with cond ''
1604285 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:OnePerSecA, with cond ''
1604286 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:OnePerSecA, with cond ''
1604287 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:OnePerSecB, with cond ''
1604288 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:OnePerSecB, with cond ''
1604289 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:TenPerSecA, with cond ''
1604290 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:TenPerSecA, with cond ''
1604291 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:TenPerSecB, with cond ''
1604292 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:OnePerSecA, with cond ''
1604293 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread1_lowtraf:TenPerSecB, with cond ''
1604294 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:OnePerSecB, with cond ''
1604295 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:OnePerSecA, with cond ''
1604296 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:TenPerSecA, with cond ''
1604297 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:OnePerSecB, with cond ''
1604298 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:TenPerSecB, with cond ''
1604299 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:TenPerSecA, with cond ''
1604300 13:03:22 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB003_a_1
1604301 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread2_lowtraf:TenPerSecB, with cond ''
1604302 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_thread_main:OnePerSecA, with cond ''
1604303 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:OnePerSecA, with cond ''
1604304 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:OnePerSecB, with cond ''
1604305 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA, with cond ''
1604306 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecB, with cond ''
1604307 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:OnePerSecA, with cond ''
1604308 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:OnePerSecB, with cond ''
1604309 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:TenPerSecA, with cond ''
1604310 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_child_lowtraf:TenPerSecB, with cond ''
1604311 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:OnePerSecA, with cond ''
1604312 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:OnePerSecB, with cond ''
1604313 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:TenPerSecA, with cond ''
1604314 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB003_a_1, event com_ericsson_cba_testapp_fork_parent_lowtraf:TenPerSecB, with cond ''
1604315 13:03:22 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB003_a_1
1604316 13:03:22 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604317 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-4 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1
1604318 13:03:22 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4
1604319 13:03:22 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4/ust
1604320 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4
1604321 13:03:22 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604322 13:03:22 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604323 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4
1604324 13:03:22 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4/ust
1604325 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22899-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4/ust
1604326 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-2 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1
1604327 13:03:22 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2
1604328 13:03:22 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2/ust
1604329 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2
1604330 13:03:22 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604331 13:03:22 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604332 13:03:22 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2
1604333 13:03:22 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2/ust
1604334 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22930-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4/ust
1604335 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-14430-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2/ust
1604336 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-14462-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2/ust
1604337 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22896-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-4/ust
1604338 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-3 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1
1604339 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3
1604340 13:03:23 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22886-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3/ust
1604341 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22886-20130117-130322 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3/ust
1604342 13:03:23 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting TestApp_Fork1-22886-20130117-130322
1604343 13:03:23 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory TestApp_Fork1-22886-20130117-130322 is being deleted
1604344 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22886-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3/ust
1604345 13:03:23 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB003_a_1.
1604346 13:03:23 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8286 value: 1, return code: 1 , SA_AIS_OK
1604347 13:03:23 01/17/2013 IN TraceP_PL-4 "Activation completed successfully for session traceSessionRecordingId=STAB003_a_1,traceMId=1
1604348 13:03:23 01/17/2013 IN TraceP_PL-4 "DBG: Jobs took a long time to execute: 1255044us
1604349 13:03:23 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604350 13:03:23 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604351 13:03:23 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604352 13:03:23 01/17/2013 NO TraceC "Session STAB003_a_1 activated.
1604353 13:03:23 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604354 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-14491-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-2/ust
1604355 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22883-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3/ust
1604356 13:03:23 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB003_a_1.
1604357 13:03:23 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8288 value: 1, return code: 1 , SA_AIS_OK
1604358 13:03:23 01/17/2013 IN TraceP_SC-2 "Activation completed successfully for session traceSessionRecordingId=STAB003_a_1,traceMId=1
1604359 13:03:23 01/17/2013 IN TraceP_SC-2 "DBG: Jobs took a long time to execute: 1473453us
1604360 13:03:23 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604361 13:03:23 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604362 13:03:23 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604363 13:03:23 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-22854-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3/ust
1604364 13:03:24 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22919-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/PL-3/ust
1604365 13:03:24 01/17/2013 IN TraceC "DBG: Cancelling
1604366 13:03:24 01/17/2013 NO TraceC "Cancelling session STAB002_1.
1604367 13:03:24 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604368 13:03:24 01/17/2013 IN TraceC "DBG: Requesting relay-d cancelation for session traceSessionRecordingId=STAB002_1,traceMId=1
1604369 13:03:24 01/17/2013 IN TraceC "DBG: Canceling relayD for session STAB002_1
1604370 13:03:24 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 4, addr: 0x7F234C2EBD10
1604371 13:03:24 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C2EBD10 for tracePId=PL-3,traceMId=1
1604372 13:03:24 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 4, addr: 0x7F234C080FD0
1604373 13:03:24 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C080FD0 for tracePId=PL-4,traceMId=1
1604374 13:03:24 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 4, addr: 0x7F234C081080
1604375 13:03:24 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C081080 for tracePId=SC-1,traceMId=1
1604376 13:03:24 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 4, addr: 0x7F234C04B260
1604377 13:03:24 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C04B260 for tracePId=SC-2,traceMId=1
1604378 13:03:24 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB002_1"
1604379 13:03:24 01/17/2013 IN TraceC "DBG: remove called to delete file /storage/no-backup/tracecc-apr9010500//.tmp/STAB002_1
1604380 13:03:24 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB002_1 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500
1604381 13:03:24 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting STAB002_1
1604382 13:03:24 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping: directoryDeleteHandler is deleting STAB002_1
1604383 13:03:24 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory STAB002_1 is being deleted
1604384 13:03:24 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-2/ust/TestApp_Thread1-14491-20130117-130315/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604385 13:03:24 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_1/SC-1/ust/TestApp_Thread1-32463-20130117-130315/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604386 13:03:24 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_1"
1604387 13:03:24 01/17/2013 IN TraceC "DBG: Dispatch: epoll_wait returned an error: 4
1604388 13:03:24 01/17/2013 IN TraceC "DBG: SigChildHandler: second half handling. death count: 1
1604389 13:03:24 01/17/2013 IN TraceC "DBG: Received death of pid 3164 with ret 9.
1604390 13:03:24 01/17/2013 IN TraceC "DBG: No handler for pid 3164.
1604391 13:03:24 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604392 13:03:24 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C2EBD10
1604393 13:03:24 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C080FD0
1604394 13:03:24 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C081080
1604395 13:03:24 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C04B260
1604396 13:03:24 01/17/2013 IN TraceP_PL-4 "Cancelling
1604397 13:03:24 01/17/2013 IN TraceP_PL-4 "DBG: hasSession: Invoke lttng_list_session.
1604398 13:03:24 01/17/2013 IN TraceP_PL-4 "DBG: hasSession: Reply recieved from lttng_list_session with count 2
1604399 13:03:24 01/17/2013 IN TraceP_PL-4 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB002_1
1604400 13:03:24 01/17/2013 IN TraceP_SC-2 "Cancelling
1604401 13:03:24 01/17/2013 IN TraceP_SC-2 "DBG: hasSession: Invoke lttng_list_session.
1604402 13:03:24 01/17/2013 IN TraceP_SC-2 "DBG: hasSession: Reply recieved from lttng_list_session with count 2
1604403 13:03:24 01/17/2013 IN TraceP_SC-2 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB002_1
1604404 13:03:24 01/17/2013 IN TraceP_PL-4 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB002_1.
1604405 13:03:24 01/17/2013 IN TraceP_SC-2 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB002_1.
1604406 13:03:24 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8290 value: 1, return code: 1 , SA_AIS_OK
1604407 13:03:24 01/17/2013 IN TraceP_PL-4 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1.
1604408 13:03:24 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8292 value: 1, return code: 1 , SA_AIS_OK
1604409 13:03:24 01/17/2013 IN TraceP_SC-2 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1.
1604410 13:03:24 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604411 13:03:24 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604412 13:03:24 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604413 13:03:24 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604414 13:03:24 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604415 13:03:24 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604416 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB003_a_1.
1604417 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8285 value: 1, return code: 1 , SA_AIS_OK
1604418 13:03:24 01/17/2013 IN TraceP_PL-3 "Activation completed successfully for session traceSessionRecordingId=STAB003_a_1,traceMId=1
1604419 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: Jobs took a long time to execute: 1955534us
1604420 13:03:24 01/17/2013 IN TraceP_PL-3 "Cancelling
1604421 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: hasSession: Invoke lttng_list_session.
1604422 13:03:24 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604423 13:03:24 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604424 13:03:24 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604425 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: hasSession: Reply recieved from lttng_list_session with count 2
1604426 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB002_1
1604427 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB002_1.
1604428 13:03:24 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_1" Deleted!
1604429 13:03:24 01/17/2013 IN TraceC "DBG: Completed deletion of "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_1"
1604430 13:03:24 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8289 value: 1, return code: 1 , SA_AIS_OK
1604431 13:03:24 01/17/2013 IN TraceP_PL-3 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1.
1604432 13:03:24 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604433 13:03:24 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604434 13:03:24 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604435 13:03:25 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-1 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1
1604436 13:03:25 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1
1604437 13:03:25 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604438 13:03:25 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1
1604439 13:03:25 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604440 13:03:25 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604441 13:03:25 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1
1604442 13:03:25 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130322 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604443 13:03:25 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-32352-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604444 13:03:25 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-32406-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604445 13:03:25 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-32463-20130117-130322 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604446 13:03:26 01/17/2013 IN TraceP_SC-1 "Activation completed successfully for session traceSessionRecordingId=STAB003_a_1,traceMId=1
1604447 13:03:26 01/17/2013 IN TraceP_SC-1 "Cancelling
1604448 13:03:26 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604449 13:03:26 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604450 13:03:26 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604451 13:03:26 01/17/2013 IN TraceP_SC-1 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_1,traceMId=1.
1604452 13:03:26 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604453 13:03:26 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604454 13:03:26 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604455 13:03:26 01/17/2013 IN TraceC "cancelSessionOnTracePsComplete
1604456 13:03:26 01/17/2013 IN TraceC "DBG: cancelSessionOnTracePsComplete deleting ConvertAsyncActionProgress if it exists traceSessionRecordingId=STAB002_1,traceMId=1
1604457 13:03:26 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604458 13:03:30 01/17/2013 IN TraceC "DBG: Activating
1604459 13:03:30 01/17/2013 IN TraceC "DBG: creating session traceSessionRecordingId=STAB002_2,traceMId=1 as a runtime object
1604460 13:03:30 01/17/2013 NO TraceC "Activating Session STAB002_2.
1604461 13:03:30 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB002_2 was created successfully!
1604462 13:03:30 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604463 13:03:30 01/17/2013 IN TraceC "DBG: performActivate: Starting RelayD for session STAB002_2.
1604464 13:03:30 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604465 13:03:30 01/17/2013 IN TraceC "DBG: RelayDManager::start() Control port selected: 59683
1604466 13:03:30 01/17/2013 IN TraceC "DBG: RelayDManager::start() Data port selected: 52499
1604467 13:03:30 01/17/2013 IN TraceC "DBG: RelayDManager::start() Pipe opened
1604468 13:03:30 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604469 13:03:30 01/17/2013 IN TraceC "DBG: RelayDManager::start() RelayD for "STAB002_2" pid: 5959 bound on 192.168.0.1:59683:52499
1604470 13:03:30 01/17/2013 IN TraceC "DBG: performActivate: Writing session into file
1604471 13:03:30 01/17/2013 IN TraceC "DBG: Done Activating
1604472 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB002_2 is being added to parent directory /storage/no-backup/tracecc-apr9010500
1604473 13:03:30 01/17/2013 IN TraceC "DBG: RelayD has been launch for STAB002_2 session after 1 tries to connect to free ports.
1604474 13:03:30 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604475 13:03:30 01/17/2013 IN TraceC "DBG: performActivateAfterRelayD: Sending commands to the trace_ps.
1604476 13:03:30 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 2, addr: 0x7F234C02F040
1604477 13:03:30 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 2, addr: 0x7F234C1849F0
1604478 13:03:30 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 2, addr: 0x7F234C0051C0
1604479 13:03:30 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 2, addr: 0x7F234C181F30
1604480 13:03:30 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604481 13:03:30 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C02F040
1604482 13:03:30 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604483 13:03:30 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C1849F0
1604484 13:03:30 01/17/2013 IN TraceP_PL-3 "Activating
1604485 13:03:30 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C0051C0
1604486 13:03:30 01/17/2013 IN TraceP_PL-4 "Activating
1604487 13:03:30 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C181F30
1604488 13:03:30 01/17/2013 IN TraceP_SC-1 "Activating
1604489 13:03:30 01/17/2013 IN TraceP_SC-2 "Activating
1604490 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: invoke lttng_create_session for session STAB002_2 with url net://192.168.0.1:59683:52499/./.
1604491 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_2
1604492 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_2.
1604493 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_2
1604494 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604495 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604496 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604497 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604498 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604499 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_2
1604500 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: invoke lttng_create_session for session STAB002_2 with url net://192.168.0.1:59683:52499/./.
1604501 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_2
1604502 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_2.
1604503 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_2
1604504 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-3 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2
1604505 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604506 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604507 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604508 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604509 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604510 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_2
1604511 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3
1604512 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22886-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust
1604513 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22886-20130117-130330 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust
1604514 13:03:30 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting TestApp_Fork1-22886-20130117-130330
1604515 13:03:30 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory TestApp_Fork1-22886-20130117-130330 is being deleted
1604516 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22886-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust
1604517 13:03:30 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604518 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: invoke lttng_create_session for session STAB002_2 with url net://192.168.0.1:59683:52499/./.
1604519 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_2
1604520 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_2.
1604521 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_2
1604522 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-1 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2
1604523 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604524 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604525 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604526 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604527 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_2, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604528 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_2
1604529 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1
1604530 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604531 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1
1604532 13:03:30 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604533 13:03:30 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604534 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1
1604535 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604536 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-2 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2
1604537 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2
1604538 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust
1604539 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2
1604540 13:03:30 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604541 13:03:30 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604542 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2
1604543 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust
1604544 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-4 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2
1604545 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4
1604546 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust
1604547 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4
1604548 13:03:30 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604549 13:03:30 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604550 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4
1604551 13:03:30 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130330 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust
1604552 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-14430-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust
1604553 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22883-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust
1604554 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-32352-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604555 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22899-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust
1604556 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-32406-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604557 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-22854-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust
1604558 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-14462-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust
1604559 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22930-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust
1604560 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22919-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust
1604561 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22896-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust
1604562 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-32463-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604563 13:03:30 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-14491-20130117-130330 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust
1604564 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_2.
1604565 13:03:30 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8293 value: 1, return code: 1 , SA_AIS_OK
1604566 13:03:30 01/17/2013 IN TraceP_PL-3 "Activation completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1
1604567 13:03:30 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604568 13:03:30 01/17/2013 IN TraceP_SC-1 "Activation completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1
1604569 13:03:30 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604570 13:03:30 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604571 13:03:30 01/17/2013 NO TraceC "Session STAB002_2 activated.
1604572 13:03:30 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604573 13:03:30 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604574 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_2.
1604575 13:03:30 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8296 value: 1, return code: 1 , SA_AIS_OK
1604576 13:03:30 01/17/2013 IN TraceP_SC-2 "Activation completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1
1604577 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_2.
1604578 13:03:30 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8294 value: 1, return code: 1 , SA_AIS_OK
1604579 13:03:30 01/17/2013 IN TraceP_PL-4 "Activation completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1
1604580 13:03:30 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604581 13:03:30 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604582 13:03:30 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604583 13:03:30 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604584 13:03:30 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604585 13:03:30 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604586 13:03:35 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6482-20130117-130335 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604587 13:03:35 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6482-20130117-130335 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604588 13:03:35 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6484-20130117-130335 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604589 13:03:36 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6484-20130117-130336 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604590 13:03:36 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6494-20130117-130336 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604591 13:03:37 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6494-20130117-130336 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604592 13:03:37 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6490-20130117-130337 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604593 13:03:37 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6490-20130117-130337 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604594 13:03:38 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6492-20130117-130338 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604595 13:03:39 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6492-20130117-130338 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604596 13:03:39 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6500-20130117-130339 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604597 13:03:39 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6500-20130117-130339 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604598 13:03:40 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6496-20130117-130339 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604599 13:03:40 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6496-20130117-130340 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604600 13:03:41 01/17/2013 IN TraceC "DBG: Deactivating
1604601 13:03:41 01/17/2013 IN TraceC "DBG: Getting Session "traceSessionRecordingId=STAB003_a_1,traceMId=1" from Registries
1604602 13:03:41 01/17/2013 IN TraceC "DBG: Checking if the current state of Session "traceSessionRecordingId=STAB003_a_1,traceMId=1" is valid
1604603 13:03:41 01/17/2013 NO TraceC "Deactivating session STAB003_a_1.
1604604 13:03:41 01/17/2013 IN TraceC "DBG: update Async for deactivate - first time
1604605 13:03:41 01/17/2013 IN TraceC "DBG: sending deactivate requests to all traceP's
1604606 13:03:41 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 3, addr: 0x69A520
1604607 13:03:41 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 3, addr: 0x6DB070
1604608 13:03:41 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 3, addr: 0x6FB3F0
1604609 13:03:41 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 3, addr: 0x69A3E0
1604610 13:03:41 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604611 13:03:41 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604612 13:03:41 01/17/2013 IN TraceC "DBG: Invoking admin op 0x69A520
1604613 13:03:41 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604614 13:03:41 01/17/2013 IN TraceC "DBG: Invoking admin op 0x6DB070
1604615 13:03:41 01/17/2013 IN TraceP_PL-3 "Deactivating
1604616 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: hasSession: Invoke lttng_list_session.
1604617 13:03:41 01/17/2013 IN TraceC "DBG: Invoking admin op 0x6FB3F0
1604618 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: hasSession: Reply recieved from lttng_list_session with count 2
1604619 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivateSession: Invoke lttng_stop_tracing_no_wait for session STAB003_a_1
1604620 13:03:41 01/17/2013 IN TraceP_PL-4 "Deactivating
1604621 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: hasSession: Invoke lttng_list_session.
1604622 13:03:41 01/17/2013 IN TraceC "DBG: Invoking admin op 0x69A3E0
1604623 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivateSession: Reply received for lttng_stop_tracing_no_wait for session STAB003_a_1
1604624 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604625 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: hasSession: Reply recieved from lttng_list_session with count 2
1604626 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivateSession: Invoke lttng_stop_tracing_no_wait for session STAB003_a_1
1604627 13:03:41 01/17/2013 IN TraceP_SC-1 "Deactivating
1604628 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivateSession: Reply received for lttng_stop_tracing_no_wait for session STAB003_a_1
1604629 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604630 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604631 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604632 13:03:41 01/17/2013 IN TraceP_SC-2 "Deactivating
1604633 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: hasSession: Invoke lttng_list_session.
1604634 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: hasSession: Reply recieved from lttng_list_session with count 2
1604635 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivateSession: Invoke lttng_stop_tracing_no_wait for session STAB003_a_1
1604636 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivateSession: Reply received for lttng_stop_tracing_no_wait for session STAB003_a_1
1604637 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604638 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604639 13:03:41 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6498-20130117-130340 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust
1604640 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604641 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604642 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604643 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604644 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604645 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604646 13:03:41 01/17/2013 IN TraceP_PL-3 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604647 13:03:41 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604648 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604649 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604650 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604651 13:03:41 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604652 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604653 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604654 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604655 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604656 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 1.
1604657 13:03:42 01/17/2013 IN TraceP_PL-3 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 0.
1604658 13:03:42 01/17/2013 IN TraceP_PL-3 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB003_a_1
1604659 13:03:42 01/17/2013 IN TraceP_PL-3 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB003_a_1.
1604660 13:03:42 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8297 value: 1, return code: 1 , SA_AIS_OK
1604661 13:03:42 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604662 13:03:42 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604663 13:03:42 01/17/2013 IN TraceC "receiveTracePDeactivateResult result: 1 op_result 1
1604664 13:03:42 01/17/2013 IN TraceP_PL-3 "Deactivation was completed successfully for session STAB003_a_1.
1604665 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604666 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Invoke lttng_data_pending for session STAB003_a_1
1604667 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 0.
1604668 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB003_a_1
1604669 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: deactivatingSessionInProgress: Reply recieved for lttng_data_pending for session STAB003_a_1: 0.
1604670 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB003_a_1
1604671 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB003_a_1.
1604672 13:03:42 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8298 value: 1, return code: 1 , SA_AIS_OK
1604673 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB003_a_1.
1604674 13:03:42 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604675 13:03:42 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8300 value: 1, return code: 1 , SA_AIS_OK
1604676 13:03:42 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604677 13:03:42 01/17/2013 IN TraceC "receiveTracePDeactivateResult result: 1 op_result 1
1604678 13:03:42 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604679 13:03:42 01/17/2013 IN TraceC "receiveTracePDeactivateResult result: 1 op_result 1
1604680 13:03:42 01/17/2013 IN TraceP_PL-4 "Deactivation was completed successfully for session STAB003_a_1.
1604681 13:03:42 01/17/2013 IN TraceP_SC-2 "Deactivation was completed successfully for session STAB003_a_1.
1604682 13:03:42 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Mini1-6498-20130117-130342 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB003_a_1/SC-1/ust
1604683 13:03:43 01/17/2013 IN TraceC "DBG: Deactivating
1604684 13:03:43 01/17/2013 IN TraceC "DBG: Getting Session "traceSessionRecordingId=STAB002_2,traceMId=1" from Registries
1604685 13:03:43 01/17/2013 IN TraceC "DBG: Checking if the current state of Session "traceSessionRecordingId=STAB002_2,traceMId=1" is valid
1604686 13:03:43 01/17/2013 NO TraceC "Deactivating session STAB002_2.
1604687 13:03:43 01/17/2013 IN TraceC "DBG: update Async for deactivate - first time
1604688 13:03:43 01/17/2013 IN TraceC "DBG: sending deactivate requests to all traceP's
1604689 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 3, addr: 0x7F234C0BDBD0
1604690 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 3, addr: 0x7F234C21F7F0
1604691 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 3, addr: 0x7F234C21BA80
1604692 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 3, addr: 0x7F234C21BB40
1604693 13:03:43 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604694 13:03:43 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604695 13:03:43 01/17/2013 IN TraceC "DBG: Cancelling
1604696 13:03:43 01/17/2013 NO TraceC "Cancelling session STAB002_2.
1604697 13:03:43 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604698 13:03:43 01/17/2013 IN TraceC "DBG: Requesting relay-d cancelation for session traceSessionRecordingId=STAB002_2,traceMId=1
1604699 13:03:43 01/17/2013 IN TraceC "DBG: Canceling relayD for session STAB002_2
1604700 13:03:43 01/17/2013 IN TraceC "DBG: Removed cancel async admin op: 0x7F234C0BDBD0
1604701 13:03:43 01/17/2013 IN TraceC "DBG: Removed cancel async admin op: 0x7F234C21BA80
1604702 13:03:43 01/17/2013 IN TraceC "DBG: Removed cancel async admin op: 0x7F234C21BB40
1604703 13:03:43 01/17/2013 IN TraceC "DBG: Removed cancel async admin op: 0x7F234C21F7F0
1604704 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 4, addr: 0x7F234C21F7F0
1604705 13:03:43 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C21F7F0 for tracePId=PL-3,traceMId=1
1604706 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 4, addr: 0x7F234C1EE080
1604707 13:03:43 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C1EE080 for tracePId=PL-4,traceMId=1
1604708 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 4, addr: 0x7F234C0BDBD0
1604709 13:03:43 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C0BDBD0 for tracePId=SC-1,traceMId=1
1604710 13:03:43 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 4, addr: 0x7F234C184940
1604711 13:03:43 01/17/2013 IN TraceC "DBG: Adding Cancel op 0x7F234C184940 for tracePId=SC-2,traceMId=1
1604712 13:03:43 01/17/2013 IN TraceC "DBG: Try to async-remove directory "/storage/no-backup/tracecc-apr9010500//STAB002_2"
1604713 13:03:43 01/17/2013 IN TraceC "DBG: remove called to delete file /storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2
1604714 13:03:43 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB002_2 has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500
1604715 13:03:43 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting STAB002_2
1604716 13:03:43 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping: directoryDeleteHandler is deleting STAB002_2
1604717 13:03:43 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory STAB002_2 is being deleted
1604718 13:03:43 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604719 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Fork1-32406-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604720 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Mini1-6498-20130117-130340/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604721 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_Fork1-14462-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604722 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_Thread1-22919-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604723 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Fork1-22899-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604724 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_type1-32352-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604725 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_Fork1-14459-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604726 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Fork1-22899-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604727 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Fork1-32409-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604728 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_Thread1-14491-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604729 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Thread1-22930-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604730 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Thread1-32463-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604731 13:03:43 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Thread1-22930-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604732 13:03:44 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C21F7F0
1604733 13:03:44 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604734 13:03:44 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C1EE080
1604735 13:03:44 01/17/2013 IN TraceP_PL-3 "Cancelling
1604736 13:03:44 01/17/2013 IN TraceP_PL-3 "DBG: hasSession: Invoke lttng_list_session.
1604737 13:03:44 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C0BDBD0
1604738 13:03:44 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C184940
1604739 13:03:44 01/17/2013 IN TraceP_PL-3 "DBG: hasSession: Reply recieved from lttng_list_session with count 1
1604740 13:03:44 01/17/2013 IN TraceP_PL-3 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB002_2
1604741 13:03:44 01/17/2013 IN TraceP_PL-4 "Cancelling
1604742 13:03:44 01/17/2013 IN TraceP_PL-4 "DBG: hasSession: Invoke lttng_list_session.
1604743 13:03:44 01/17/2013 IN TraceP_PL-4 "DBG: hasSession: Reply recieved from lttng_list_session with count 1
1604744 13:03:44 01/17/2013 IN TraceP_PL-4 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB002_2
1604745 13:03:44 01/17/2013 IN TraceP_PL-3 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB002_2.
1604746 13:03:44 01/17/2013 IN TraceP_SC-2 "Cancelling
1604747 13:03:44 01/17/2013 IN TraceP_SC-2 "DBG: hasSession: Invoke lttng_list_session.
1604748 13:03:44 01/17/2013 IN TraceP_SC-2 "DBG: hasSession: Reply recieved from lttng_list_session with count 1
1604749 13:03:44 01/17/2013 IN TraceP_SC-2 "DBG: cancelSession: Invoke lttng_destroy_session for session STAB002_2
1604750 13:03:44 01/17/2013 IN TraceP_PL-4 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB002_2.
1604751 13:03:44 01/17/2013 IN TraceP_SC-2 "DBG: cancelSession: Reply recieved for lttng_destroy_session for session STAB002_2.
1604752 13:03:44 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8302 value: 1, return code: 1 , SA_AIS_OK
1604753 13:03:44 01/17/2013 IN TraceP_PL-4 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1.
1604754 13:03:44 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8304 value: 1, return code: 1 , SA_AIS_OK
1604755 13:03:44 01/17/2013 IN TraceP_SC-2 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1.
1604756 13:03:44 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8301 value: 1, return code: 1 , SA_AIS_OK
1604757 13:03:44 01/17/2013 IN TraceP_PL-3 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1.
1604758 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Thread1-32463-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604759 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Mini1-6498-20130117-130340/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604760 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_Fork1-22886-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604761 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Thread1-22930-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604762 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Thread1-32463-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604763 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_Thread1-22919-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604764 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Fork1-32409-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604765 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_type1-22854-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604766 13:03:44 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604767 13:03:44 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604768 13:03:44 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604769 13:03:44 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604770 13:03:44 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604771 13:03:44 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604772 13:03:44 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604773 13:03:44 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604774 13:03:44 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604775 13:03:44 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604776 13:03:44 01/17/2013 IN TraceC "receiveTracePDeactivateResult result: 1 op_result 1
1604777 13:03:44 01/17/2013 IN TraceC "deactivateSessionOnTracePsComplete
1604778 13:03:44 01/17/2013 IN TraceC "DBG: Terminating relayD for session STAB003_a_1
1604779 13:03:44 01/17/2013 IN TraceP_SC-1 "Deactivation was completed successfully for session STAB003_a_1.
1604780 13:03:44 01/17/2013 IN TraceP_SC-1 "Cancelling
1604781 13:03:44 01/17/2013 IN TraceP_SC-1 "Cancellation was completed successfully for session traceSessionRecordingId=STAB002_2,traceMId=1.
1604782 13:03:44 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2"
1604783 13:03:44 01/17/2013 NO TraceC "Deactivate complete for session "STAB003_a_1"
1604784 13:03:44 01/17/2013 IN TraceC "DBG: deactivateSessionOnTracePsComplete calling TraceCHousekeeping::handleDelayedSessionWipes() for session traceSessionRecordingId=STAB003_a_1,traceMId=1
1604785 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Mini1-6494-20130117-130336/metadata. Stopped at /storage/no-backup/tracecc-apr9010500.
1604786 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_Thread1-14491-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604787 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_type1-22867-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604788 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Mini1-6498-20130117-130340/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604789 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Fork1-22896-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604790 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_Fork1-22883-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604791 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Fork1-32406-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604792 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Thread1-32463-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604793 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Mini1-6490-20130117-130337/metadata. Stopped at /storage/no-backup/tracecc-apr9010500.
1604794 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_type1-22854-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604795 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Fork1-22896-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604796 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_type1-32352-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604797 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_Thread1-14491-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604798 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_type1-14430-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604799 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Fork1-32409-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604800 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-1/ust/TestApp_Mini1-6492-20130117-130338/metadata. Stopped at /storage/no-backup/tracecc-apr9010500.
1604801 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_type1-14430-20130117-130330/channel0_1. Stopped at /storage/no-backup/tracecc-apr9010500.
1604802 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-3/ust/TestApp_Fork1-22886-20130117-130330/channel0_3. Stopped at /storage/no-backup/tracecc-apr9010500.
1604803 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/SC-2/ust/TestApp_Fork1-14459-20130117-130330/channel0_2. Stopped at /storage/no-backup/tracecc-apr9010500.
1604804 13:03:44 01/17/2013 IN TraceC "DBG: File Monitor seek: failed to find /storage/no-backup/tracecc-apr9010500/STAB002_2/PL-4/ust/TestApp_Fork1-22896-20130117-130330/channel0_0. Stopped at /storage/no-backup/tracecc-apr9010500.
1604805 13:03:44 01/17/2013 ER TraceC "Error: removing errno: 39
1604806 13:03:44 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2" Failure the first time!, with errno=39
1604807 13:03:44 01/17/2013 ER TraceC "Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2" failed even after 100 retries! errno=39
1604808 13:03:44 01/17/2013 IN TraceC "DBG: Dispatch: epoll_wait returned an error: 4
1604809 13:03:44 01/17/2013 IN TraceC "DBG: SigChildHandler: second half handling. death count: 1
1604810 13:03:44 01/17/2013 IN TraceC "DBG: Received death of pid 4849 with ret 9.
1604811 13:03:44 01/17/2013 IN TraceC "DBG: No handler for pid 4849.
1604812 13:03:44 01/17/2013 IN TraceC "DBG: Dispatch: epoll_wait returned an error: 4
1604813 13:03:44 01/17/2013 IN TraceC "DBG: SigChildHandler: second half handling. death count: 1
1604814 13:03:44 01/17/2013 IN TraceC "DBG: Received death of pid 5959 with ret 9.
1604815 13:03:44 01/17/2013 IN TraceC "DBG: No handler for pid 5959.
1604816 13:03:44 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604817 13:03:44 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB003_a,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604818 13:03:44 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604819 13:03:44 01/17/2013 IN TraceC "receiveTracePCancelSessionResult result: 1 op_result 1
1604820 13:03:44 01/17/2013 IN TraceC "cancelSessionOnTracePsComplete
1604821 13:03:44 01/17/2013 IN TraceC "DBG: cancelSessionOnTracePsComplete deleting ConvertAsyncActionProgress if it exists traceSessionRecordingId=STAB002_2,traceMId=1
1604822 13:03:44 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604823 13:03:49 01/17/2013 IN TraceC "DBG: Try to remove directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2"
1604824 13:03:49 01/17/2013 IN TraceC "DBG: Remove Directory "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2" Deleted!
1604825 13:03:49 01/17/2013 IN TraceC "DBG: Completed deletion of "/storage/no-backup/tracecc-apr9010500//.tmp/STAB002_2"
1604826 13:03:52 01/17/2013 IN TraceC "DBG: Activating
1604827 13:03:52 01/17/2013 IN TraceC "DBG: creating session traceSessionRecordingId=STAB002_3,traceMId=1 as a runtime object
1604828 13:03:52 01/17/2013 NO TraceC "Activating Session STAB002_3.
1604829 13:03:52 01/17/2013 IN TraceC "DBG: Directory /storage/no-backup/tracecc-apr9010500//STAB002_3 was created successfully!
1604830 13:03:52 01/17/2013 IN TraceC "DBG: Return for invocation 1 value: 1, return code: 1 , SA_AIS_OK
1604831 13:03:52 01/17/2013 IN TraceC "DBG: performActivate: Starting RelayD for session STAB002_3.
1604832 13:03:52 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604833 13:03:52 01/17/2013 IN TraceC "DBG: RelayDManager::start() Control port selected: 58977
1604834 13:03:52 01/17/2013 IN TraceC "DBG: RelayDManager::start() Data port selected: 54535
1604835 13:03:52 01/17/2013 IN TraceC "DBG: RelayDManager::start() Pipe opened
1604836 13:03:52 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604837 13:03:52 01/17/2013 IN TraceC "DBG: RelayDManager::start() RelayD for "STAB002_3" pid: 7273 bound on 192.168.0.1:58977:54535
1604838 13:03:52 01/17/2013 IN TraceC "DBG: performActivate: Writing session into file
1604839 13:03:52 01/17/2013 IN TraceC "DBG: Done Activating
1604840 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory STAB002_3 is being added to parent directory /storage/no-backup/tracecc-apr9010500
1604841 13:03:52 01/17/2013 IN TraceC "DBG: RelayD has been launch for STAB002_3 session after 1 tries to connect to free ports.
1604842 13:03:52 01/17/2013 IN TraceC "DBG: relayD ip address is found, IP address: 192.168.0.1 for host: SC-1
1604843 13:03:52 01/17/2013 IN TraceC "DBG: performActivateAfterRelayD: Sending commands to the trace_ps.
1604844 13:03:52 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-3,traceMId=1, op: 2, addr: 0x7F234C2228E0
1604845 13:03:52 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=PL-4,traceMId=1, op: 2, addr: 0x7F234C09B890
1604846 13:03:52 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-1,traceMId=1, op: 2, addr: 0x7F234C09B910
1604847 13:03:52 01/17/2013 IN TraceC "DBG: Creating admin op: dn tracePId=SC-2,traceMId=1, op: 2, addr: 0x7F234C09C440
1604848 13:03:52 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604849 13:03:52 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C2228E0
1604850 13:03:52 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604851 13:03:52 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C09B890
1604852 13:03:52 01/17/2013 IN TraceP_PL-3 "Activating
1604853 13:03:52 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C09B910
1604854 13:03:52 01/17/2013 IN TraceP_PL-4 "Activating
1604855 13:03:52 01/17/2013 IN TraceC "DBG: Invoking admin op 0x7F234C09C440
1604856 13:03:52 01/17/2013 IN TraceP_SC-1 "Activating
1604857 13:03:52 01/17/2013 IN TraceP_SC-2 "Activating
1604858 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: invoke lttng_create_session for session STAB002_3 with url net://192.168.0.1:58977:54535/./.
1604859 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_3
1604860 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_3.
1604861 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_3
1604862 13:03:52 01/17/2013 IN TraceP_SC-1 "Activation completed successfully for session traceSessionRecordingId=STAB002_3,traceMId=1
1604863 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604864 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604865 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604866 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604867 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604868 13:03:52 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_3
1604869 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: invoke lttng_create_session for session STAB002_3 with url net://192.168.0.1:58977:54535/./.
1604870 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_3
1604871 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_3.
1604872 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_3
1604873 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604874 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604875 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604876 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604877 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604878 13:03:52 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_3
1604879 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-3 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3
1604880 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: invoke lttng_create_session for session STAB002_3 with url net://192.168.0.1:58977:54535/./.
1604881 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_create_handle for session STAB002_3
1604882 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_set_default_attr for session STAB002_3.
1604883 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_channel for session STAB002_3
1604884 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_thread1_hightraf:KiloPerSec, with cond ''
1604885 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_thread2_hightraf:KiloPerSec, with cond ''
1604886 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_trace_testapp_hightraf:KiloPerSec, with cond ''
1604887 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_testapp_fork_child_hightraf:KiloPerSec, with cond ''
1604888 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_enable_event_with_filter for session STAB002_3, event com_ericsson_cba_testapp_fork_parent_hightraf:KiloPerSec, with cond ''
1604889 13:03:52 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Invoking lttng_start_tracing, session name STAB002_3
1604890 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3
1604891 13:03:52 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604892 13:03:52 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604893 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22886-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3/ust
1604894 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3
1604895 13:03:52 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604896 13:03:52 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604897 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3
1604898 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-22886-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3/ust
1604899 13:03:52 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604900 13:03:52 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604901 13:03:52 01/17/2013 NO TraceC "Session STAB002_3 activated.
1604902 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-2 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3
1604903 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2
1604904 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2/ust
1604905 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2
1604906 13:03:52 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604907 13:03:52 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604908 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2
1604909 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-14459-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2/ust
1604910 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory PL-4 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3
1604911 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4
1604912 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4/ust
1604913 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4
1604914 13:03:52 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604915 13:03:52 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604916 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4
1604917 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_type1-22867-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4/ust
1604918 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22883-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3/ust
1604919 13:03:52 01/17/2013 IN TraceC "DBG: Update AsyncActionProgress "id=1,traceProfileId=STAB002,traceMId=1". Saf ErrorCode: SA_AIS_OK
1604920 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-14430-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2/ust
1604921 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory SC-1 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3
1604922 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory ust is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1
1604923 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1/ust
1604924 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust has been deleted, moved, replaced or a delayed creation notification has been received in /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1
1604925 13:03:52 01/17/2013 IN TraceC "DBG: TraceCHouseKeeping:directoryDeleteHandler is deleting ust
1604926 13:03:52 01/17/2013 IN TraceC "DBG: directoryDeleteHandler : directory ust is being deleted
1604927 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory ust is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1
1604928 13:03:52 01/17/2013 IN TraceC "DBG: synchronizeDirectory : directory TestApp_Fork1-32409-20130117-130352 is being added by sync to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1/ust
1604929 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22899-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4/ust
1604930 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-22854-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3/ust
1604931 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22930-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4/ust
1604932 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_type1-32352-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1/ust
1604933 13:03:52 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-14462-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2/ust
1604934 13:03:53 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-32406-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1/ust
1604935 13:03:53 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-14491-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-2/ust
1604936 13:03:53 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-22919-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-3/ust
1604937 13:03:53 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Fork1-22896-20130117-130352 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/PL-4/ust
1604938 13:03:53 01/17/2013 IN TraceC "DBG: processMostQueuedEvents : directory TestApp_Thread1-32463-20130117-130353 is being added to parent directory /storage/no-backup/tracecc-apr9010500/STAB002_3/SC-1/ust
1604939 13:03:53 01/17/2013 IN TraceP_SC-2 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_3.
1604940 13:03:53 01/17/2013 IN TraceP_SC-2 "DBG: Return for invocation -8308 value: 1, return code: 1 , SA_AIS_OK
1604941 13:03:53 01/17/2013 IN TraceP_SC-2 "Activation completed successfully for session traceSessionRecordingId=STAB002_3,traceMId=1
1604942 13:03:53 01/17/2013 IN TraceP_PL-3 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_3.
1604943 13:03:53 01/17/2013 IN TraceP_PL-3 "DBG: Return for invocation -8305 value: 1, return code: 1 , SA_AIS_OK
1604944 13:03:53 01/17/2013 IN TraceP_PL-3 "Activation completed successfully for session traceSessionRecordingId=STAB002_3,traceMId=1
1604945 13:03:53 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604946 13:03:53 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604947 13:03:53 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604948 13:03:53 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604949 13:03:53 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1
1604950 13:03:53 01/17/2013 IN TraceP_PL-4 "DBG: activateSession: Reply recieved for lttng_start_tracing for session STAB002_3.
1604951 13:03:53 01/17/2013 IN TraceP_PL-4 "DBG: Return for invocation -8306 value: 1, return code: 1 , SA_AIS_OK
1604952 13:03:53 01/17/2013 IN TraceP_PL-4 "Activation completed successfully for session traceSessionRecordingId=STAB002_3,traceMId=1
1604953 13:03:53 01/17/2013 IN TraceC "DBG: adminOperationInvokeAsyncCallback() operationReturnValue: 1 error: 1
1604954 13:03:53 01/17/2013 IN TraceC "DBG: saImmOmDispatch Succeeded
1604955 13:03:53 01/17/2013 IN TraceC "receiveTracePActivateResult result: 1 op_result 1

######################################################################################
######################################################################################
######################################################################################

####################################### USER 1 #######################################

####################################### USER 2 #######################################

{ematbai:dellcc5-12} StabilityRunLog_from_JenkinJobs > cat Stability_user2_ThuJan1712:11:53EST2013.log | grep -C 10 "Jan 17 13:03"
Thu Jan 17 13:01:04 EST 2013: Activate Profile again (2nd)
Thu Jan 17 13:01:07 EST 2013: 2nd Activate completed, sleep for 10 sec.
Thu Jan 17 13:01:18 EST 2013: Deactivate Profile
Thu Jan 17 13:01:18 EST 2013: Cancel during DEACTIVATE
checkState seems to be ok
Thu Jan 17 13:01:55 EST 2013: Activate Profile again (3rd)
Thu Jan 17 13:01:58 EST 2013: 3rd Activate completed, start sleeping for 50 sec
Thu Jan 17 13:02:48 EST 2013: Deactivate
Thu Jan 17 13:02:58 EST 2013: Deactivation completed, now try to convert....
Thu Jan 17 13:02:58 EST 2013: Cancel during CONVERT
Thu Jan 17 13:03:02 EST 2013: TC ends
trace_FTest/TraceTestOperator.cc:1414: Failure
Value of: newnew
Actual: "25426"
Expected: sessiondPids[i]
Which is: "29457"
[ FAILED ] StabilityST.STAB002_User2 (143725 ms)
[----------] 1 test from StabilityST (143725 ms total)

[----------] Global test environment tear-down
[==========] 1 test from 1 test case ran. (143725 ms total)
--
YOU HAVE 45 DISABLED TESTS


Repeating all tests (iteration 25) . . .

Note: Google Test filter = *STAB002_User2*
[==========] Running 1 test from 1 test case.
[----------] Global test environment set-up.
[----------] 1 test from StabilityST
[ RUN ] StabilityST.STAB002_User2
Thu Jan 17 13:03:15 EST 2013: TC starts
Thu Jan 17 13:03:15 EST 2013: Activate profile
Thu Jan 17 13:03:18 EST 2013: Activate completed
Thu Jan 17 13:03:23 EST 2013: Cancel during ACTIVE
Thu Jan 17 13:03:29 EST 2013: Activate Profile again (2nd)
Thu Jan 17 13:03:32 EST 2013: 2nd Activate completed, sleep for 10 sec.
Thu Jan 17 13:03:43 EST 2013: Deactivate Profile
Thu Jan 17 13:03:43 EST 2013: Cancel during DEACTIVATE
checkState seems to be ok
Thu Jan 17 13:03:52 EST 2013: Activate Profile again (3rd)
Thu Jan 17 13:03:55 EST 2013: 3rd Activate completed, start sleeping for 50 sec
Thu Jan 17 13:04:45 EST 2013: Deactivate
Thu Jan 17 13:04:57 EST 2013: Deactivation completed, now try to convert....
Thu Jan 17 13:04:57 EST 2013: Cancel during CONVERT
Thu Jan 17 13:05:02 EST 2013: TC ends
trace_FTest/TraceTestOperator.cc:1414: Failure
Value of: newnew
Actual: "6855"
Expected: sessiondPids[i]
Which is: "25426"
[ FAILED ] StabilityST.STAB002_User2 (121158 ms)

####################################### USER 3 #######################################

{ematbai:dellcc5-12} StabilityRunLog_from_JenkinJobs > cat Stability_user3_ThuJan1712:11:48EST2013.log | grep "Jan 17 13:03" -C 10
Thu Jan 17 13:02:08 EST 2013: Deactivating complete
Thu Jan 17 13:02:09 EST 2013: Start Converting and checkConverting per node (except SC-1)...
Thu Jan 17 13:02:11 EST 2013: Convert and checkConvert done for SC-2,....
Thu Jan 17 13:02:13 EST 2013: Convert and checkConvert done for PL-3,....
Thu Jan 17 13:02:15 EST 2013: Convert and checkConvert done for PL-4.
Thu Jan 17 13:02:18 EST 2013: Activate Profile...
Thu Jan 17 13:02:22 EST 2013: Activate completed, wait for 3 sec
Thu Jan 17 13:02:26 EST 2013: Deactivate
Thu Jan 17 13:02:57 EST 2013: Deactivate is completed, now copy the session dir to a temp loc and delete session dir.
Thu Jan 17 13:02:58 EST 2013: Remove session dir from /storage/no-backup/tracecc-apr9010500 :
Thu Jan 17 13:03:00 EST 2013: Session dir has been removed.
Thu Jan 17 13:03:00 EST 2013: Copy session dir back to /storage/no-backup/tracecc-apr9010500 :
Thu Jan 17 13:03:01 EST 2013: Start Converting and checkConverting per node (except SC-1)...
Thu Jan 17 13:03:03 EST 2013: Convert and checkConvert done for SC-2,....
Thu Jan 17 13:03:05 EST 2013: Convert and checkConvert done for PL-3,....
Thu Jan 17 13:03:07 EST 2013: Convert and checkConvert done for PL-4.
Thu Jan 17 13:03:07 EST 2013: TC ends
trace_FTest/TraceTestOperator.cc:1414: Failure
Value of: newnew
Actual: "25426"
Expected: sessiondPids[i]
Which is: "29457"
[ FAILED ] StabilityST.STAB003_User3 (142161 ms)
[----------] 1 test from StabilityST (142161 ms total)

[----------] Global test environment tear-down
[==========] 1 test from 1 test case ran. (142161 ms total)
--
YOU HAVE 45 DISABLED TESTS


Repeating all tests (iteration 28) . . .

Note: Google Test filter = *STAB003_User3*
[==========] Running 1 test from 1 test case.
[----------] Global test environment set-up.
[----------] 1 test from StabilityST
[ RUN ] StabilityST.STAB003_User3
Thu Jan 17 13:03:21 EST 2013: Activate Profile...
Thu Jan 17 13:03:26 EST 2013: Activation completed
Thu Jan 17 13:03:41 EST 2013: Start Deactivating
Thu Jan 17 13:04:00 EST 2013: checking completion of Deactivating
Thu Jan 17 13:04:01 EST 2013: Deactivating complete
Thu Jan 17 13:04:02 EST 2013: Start Converting and checkConverting per node (except SC-1)...
Thu Jan 17 13:04:04 EST 2013: Convert and checkConvert done for SC-2,....
Thu Jan 17 13:04:06 EST 2013: Convert and checkConvert done for PL-3,....
Thu Jan 17 13:04:08 EST 2013: Convert and checkConvert done for PL-4.
Thu Jan 17 13:04:11 EST 2013: Activate Profile...
Thu Jan 17 13:04:15 EST 2013: Activate completed, wait for 3 sec
Thu Jan 17 13:04:18 EST 2013: Deactivate
Thu Jan 17 13:04:57 EST 2013: Deactivate is completed, now copy the session dir to a temp loc and delete session dir.
--
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22466.SC-1.core
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22460.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:01 TestApp_Mini1.30514.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30480.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30490.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:09 TestApp_Mini1.18320.SC-1.core
-rw------- 1 root root 17620992 Jan 17 12:40 TestApp_Mini1.3149.SC-1.core
-rw------- 1 root root 7806976 Jan 17 12:57 trace_p.16828.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10165.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10163.SC-1.core
-rw------- 1 root root 37310464 Jan 17 13:03 lttng-consumerd.25821.SC-1.core

ulimit -Sa | grep core
core file size (blocks, -c) 0
Checking for process ID TestApp_*:
----------------------------------------------------
ssh SC-1 'ps -ef|grep TestApp_'
root 6498 1 0 13:03 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 19468 1 0 13:05 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 21807 15679 9 13:06 ? 00:00:00 bash -c echo "ssh SC-1 'ps -ef|grep TestApp_'"; ssh SC-1 "ps -ef|grep TestApp_"
root 21832 21807 5 13:06 ? 00:00:00 ssh SC-1 ps -ef|grep TestApp_
--
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22466.SC-1.core
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22460.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:01 TestApp_Mini1.30514.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30480.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30490.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:09 TestApp_Mini1.18320.SC-1.core
-rw------- 1 root root 17620992 Jan 17 12:40 TestApp_Mini1.3149.SC-1.core
-rw------- 1 root root 7806976 Jan 17 12:57 trace_p.16828.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10165.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10163.SC-1.core
-rw------- 1 root root 37310464 Jan 17 13:03 lttng-consumerd.25821.SC-1.core

ulimit -Sa | grep core
core file size (blocks, -c) 0
Checking for process ID TestApp_*:
----------------------------------------------------
ssh SC-1 'ps -ef|grep TestApp_'
root 6498 1 0 13:03 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 19468 1 0 13:05 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 29299 1 0 12:22 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 30575 20355 4 13:13 ? 00:00:00 bash -c echo "ssh SC-1 'ps -ef|grep TestApp_'"; ssh SC-1 "ps -ef|grep TestApp_"
--
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22466.SC-1.core
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22460.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:01 TestApp_Mini1.30514.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30480.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30490.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:09 TestApp_Mini1.18320.SC-1.core
-rw------- 1 root root 17620992 Jan 17 12:40 TestApp_Mini1.3149.SC-1.core
-rw------- 1 root root 7806976 Jan 17 12:57 trace_p.16828.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10165.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10163.SC-1.core
-rw------- 1 root root 37310464 Jan 17 13:03 lttng-consumerd.25821.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13330.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13324.SC-1.core

ulimit -Sa | grep core
core file size (blocks, -c) 0
Checking for process ID TestApp_*:
----------------------------------------------------
ssh SC-1 'ps -ef|grep TestApp_'
root 4437 31114 5 13:23 ? 00:00:00 bash -c echo "ssh SC-1 'ps -ef|grep TestApp_'"; ssh SC-1 "ps -ef|grep TestApp_"
root 4462 4437 0 13:23 ? 00:00:00 ssh SC-1 ps -ef|grep TestApp_
--
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22466.SC-1.core
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22460.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:01 TestApp_Mini1.30514.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30480.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30490.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:09 TestApp_Mini1.18320.SC-1.core
-rw------- 1 root root 17620992 Jan 17 12:40 TestApp_Mini1.3149.SC-1.core
-rw------- 1 root root 7806976 Jan 17 12:57 trace_p.16828.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10165.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10163.SC-1.core
-rw------- 1 root root 37310464 Jan 17 13:03 lttng-consumerd.25821.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13330.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13324.SC-1.core

ulimit -Sa | grep core
core file size (blocks, -c) 0
Checking for process ID TestApp_*:
----------------------------------------------------
ssh SC-1 'ps -ef|grep TestApp_'
root 6498 1 0 13:03 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 18065 12024 4 13:47 ? 00:00:00 bash -c echo "ssh SC-1 'ps -ef|grep TestApp_'"; ssh SC-1 "ps -ef|grep TestApp_"
--
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22466.SC-1.core
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22460.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:01 TestApp_Mini1.30514.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30480.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30490.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:09 TestApp_Mini1.18320.SC-1.core
-rw------- 1 root root 17620992 Jan 17 12:40 TestApp_Mini1.3149.SC-1.core
-rw------- 1 root root 7806976 Jan 17 12:57 trace_p.16828.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10165.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10163.SC-1.core
-rw------- 1 root root 37310464 Jan 17 13:03 lttng-consumerd.25821.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13330.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13324.SC-1.core

ulimit -Sa | grep core
core file size (blocks, -c) 0
Checking for process ID TestApp_*:
----------------------------------------------------
ssh SC-1 'ps -ef|grep TestApp_'
root 6498 1 0 13:03 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 12384 6892 9 13:51 ? 00:00:00 bash -c echo "ssh SC-1 'ps -ef|grep TestApp_'"; ssh SC-1 "ps -ef|grep TestApp_"
--
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22466.SC-1.core
-rw------- 1 root root 17620992 Jan 17 09:57 TestApp_Mini1.22460.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:01 TestApp_Mini1.30514.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30480.SC-1.core
-rw------- 1 root root 17739776 Jan 17 10:01 TestApp_Mini1.30490.SC-1.core
-rw------- 1 root root 17620992 Jan 17 10:09 TestApp_Mini1.18320.SC-1.core
-rw------- 1 root root 17620992 Jan 17 12:40 TestApp_Mini1.3149.SC-1.core
-rw------- 1 root root 7806976 Jan 17 12:57 trace_p.16828.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10165.SC-1.core
-rw------- 1 root root 17764352 Jan 17 12:59 TestApp_Mini1.10163.SC-1.core
-rw------- 1 root root 37310464 Jan 17 13:03 lttng-consumerd.25821.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13330.SC-1.core
-rw------- 1 root root 17620992 Jan 17 13:14 TestApp_Mini1.13324.SC-1.core

ulimit -Sa | grep core
core file size (blocks, -c) 0
Checking for process ID TestApp_*:
----------------------------------------------------
ssh SC-1 'ps -ef|grep TestApp_'
root 6498 1 0 13:03 ? 00:00:00 /home/test_apps/TestApp_Mini1 5
root 6697 953 9 13:57 ? 00:00:00 bash -c echo "ssh SC-1 'ps -ef|grep TestApp_'"; ssh SC-1 "ps -ef|grep TestApp_"
(1-1/2)