IBM Integration Bus, Version 9.0.0.8 Operating Systems: AIX, HP-Itanium, Linux, Solaris, Windows, z/OS

See information about the latest product version

Example of user trace entries for message flow accounting and statistics

This example shows a user trace that contains message flow accounting and statistics data.

The following example shows what is generated for a snapshot report. The messages that are written to the trace show that the message flow is called myExampleFlow, and that it is running in an integration server named default on broker MQ01BRK. The message flow contains the following nodes:
  • An MQInput node called inNode
  • A Compute node called First1
  • An MQOutput node called outNode

The nodes are connected together (Out terminal to In terminal for each connection).

During the interval for which statistics have been collected, this message flow processed 150 input messages.

The records show that two threads are assigned to this message flow. One thread is assigned when the message flow is deployed (the default number); an additional thread (thread 0) listens on the input queue. The listening thread starts additional threads to process input messages that are dependent on the number of instances that you have configured for the message flow, and on the rate of arrival of the input messages on the input queue.

The following command has been issued to achieve these results:
mqsichangeflowstats MQ01BRK -s -c active -e default -f myExampleFlow -n advanced -t basic -b basic

The trace entries have been retrieved with the mqsireadlog command and formatted using the mqsiformatlog command. The output from mqsiformatlog is shown in the following example. Line breaks have been added to aid readability.

The broker takes information about statistics and accounting from the operating system. On some operating systems, such as Windows, UNIX, and Linux, rounding can occur because the system calls that are used to determine the processor times are not sufficiently granular. This rounding might affect the accuracy of the data.

BIP2380I: WMQI message flow statistics. ProcessID='328467', Key='6', Type='SnapShot', Reason='Snapshot', 
BrokerLabel='MQ01BRK', BrokerUUID='18792e66-e100-0000-0080-f197e5ed81bd', 
ExecutionGroupName='default', ExecutionGroupUUID='15d4314a-3607-11d4-8000-09140f7b0000', 
MessageFlowName='myExampleFlow', 
StartDate='2003-05-20', StartTime='13:44:31.885862', 
EndDate='2003-05-20', EndTime='13:44:51.310080', 
TotalElapsedTime='9414843', MaximumElapsedTime='1143442', MinimumElapsedTime='35154', 
TotalCPUTime='760147', MaximumCPUTime='70729', MinimumCPUTime='3124', 
CPUTimeWaitingForInputMessage='45501', ElapsedTimeWaitingForInputMessage='11106438', 
TotalInputMessages='150', TotalSizeOfInputMessages='437250', 
MaximumSizeOfInputMessages='2915', MinimumSizeOfInputMessages='2915', 
NumberOfThreadsInPool='1', TimesMaximumNumberOfThreadsReached='150', 
TotalNumberOfMQErrors='0', TotalNumberOfMessagesWithErrors='0', 
TotalNumberOfErrorsProcessingMessages='0', TotalNumberOfTimeOuts='0', 
TotalNumberOfCommits='150', TotalNumberOfBackouts='0', AccountingOrigin="DEPT2". 
Statistical information for message flow 'myExampleFlow' in broker 'MQ01BRK'. 
This is an information message produced by WMQI statistics. 

BIP2381I: WMQI thread statistics. ProcessID='328467', Key='6', Number='0', 
TotalNumberOfInputMessages='0', 
TotalElapsedTime='0', TotalCPUTime='0', CPUTimeWaitingForInputMessage='110', 
ElapsedTimeWaitingForInputMessage='5000529', TotalSizeOfInputMessages='0', 
MaximumSizeOfInputMessages='0', MinimumSizeOfInputMessages='0'. 
Statistical information for thread '0'. 
This is an information message produced by WMQI statistics. 

BIP2381I: WMQI thread statistics. ProcessID='328467', Key='6', Number='18', 
TotalNumberOfInputMessages='150', 
TotalElapsedTime='9414843', TotalCPUTime='760147', CPUTimeWaitingForInputMessage='45391', 
ElapsedTimeWaitingForInputMessage='6105909', TotalSizeOfInputMessages='437250', 
MaximumSizeOfInputMessages='2915', MinimumSizeOfInputMessages='2915'. 
Statistical information for thread '18'. 
This is an information message produced by WMQI statistics.
BIP2382I: WMQI node statistics. ProcessID='328467', Key='6', 
Label='First1', Type='ComputeNode', 
TotalElapsedTime='6428815', MaximumElapsedTime='138261', MinimumElapsedTime='28367', 
TotalCPUTime='604060', MaximumCPUTime='69645', MinimumCPUTime='2115', 
CountOfInvocations='150', NumberOfInputTerminals='1', NumberOfOutputTerminals='2'. 
Statistical information for node 'First1'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='failure', Type='Output', CountOfInvocations='0', 
Statistical information for terminal 'failure'. 
This is an information message produced by WMQI statistics.  

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='in', Type='Input', CountOfInvocations='150', 
Statistical information for terminal 'in'. 
This is an information message produced by WMQI statistics.

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='out', Type='Output', CountOfInvocations='150', 
Statistical information for terminal 'out'. 
This is an information message produced by WMQI statistics. 
BIP2382I: WMQI node statistics. ProcessID='328467', Key='6', 
Label='inNode', Type='MQInputNode', 
TotalElapsedTime='1813446', MaximumElapsedTime='1040209', MinimumElapsedTime='1767', 
TotalCPUTime='70565', MaximumCPUTime='686', MinimumCPUTime='451', 
CountOfInvocations='150', NumberOfInputTerminals='0', NumberOfOutputTerminals='3'. 
Statistical information for node 'inNode'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='catch', Type='Output', CountOfInvocations='0', 
Statistical information for terminal 'catch'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='failure', Type='Output', CountOfInvocations='0', 
Statistical information for terminal 'failure'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='out', Type='Output', CountOfInvocations='150', 
Statistical information for terminal 'out'. 
This is an information message produced by WMQI statistics. 

BIP2382I: WMQI node statistics. ProcessID='328467', Key='6', 
Label='outNode', Type='MQOutputNode', 
TotalElapsedTime='1172582', MaximumElapsedTime='177516', MinimumElapsedTime='3339', 
TotalCPUTime='85522', MaximumCPUTime='762', MinimumCPUTime='536', 
CountOfInvocations='150', NumberOfInputTerminals='1', NumberOfOutputTerminals='2'. 
Statistical information for node 'outNode'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='failure', Type='Output', CountOfInvocations='0', 
Statistical information for terminal 'failure'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='in', Type='Input', CountOfInvocations='150', 
Statistical information for terminal 'in'. 
This is an information message produced by WMQI statistics. 

BIP2383I: WMQI terminal statistics. ProcessID='328467', Key='6', 
Label='out', Type='Output', CountOfInvocations='0', 
Statistical information for terminal 'out'. 
This is an information message produced by WMQI statistics.

ac19070_.htm | Last updated Friday, 21 July 2017