Post processing taking long for a specific request id

[satish]

We have a request id which is taking 5 and half hours to get post processing completed.Output file is not having huge data.Below is the logfile for the request.Could you please let us know what would be the reasons for this and any suggestions we can speed up the post processing

apps version:12.1.3
db version:11.2.0.1(non rac)

Post processing started at 12-JUL-2019 17:59:19
Post processing ended   at 12-JUL-2019 23:43:37

Logfile:
========

+---------------------------------------------------------------------------+
MOTTech Customizations: Version : UNKNOWN
Copyright (c) 1979, 1999, Oracle Corporation. All rights reserved.
SSSCSTRAIVR_XML module: SSS All Inventory Value Report (EXCEL)
+---------------------------------------------------------------------------+
Current system time is 12-JUL-2019 17:58:53
+---------------------------------------------------------------------------+
XDO Data Engine Version No: 5.6.3
Resp: 20634
Org ID : 81
Request ID: 15285629
All Parameters: P_TITLE=:P_ORG_ID=83:P_GL_NUM=101:P_COST_TYPE_ID=5:P_SORT_OPTION=1:P_RPT_MODE=1:P_AS_OF_DATE="2019/03/31 23:59:59":P_ITEM_FROM=:P_ITEM_TO=:P_Data Template Code: SSSCSTRAIVR_XML
Data Template Application Short Name: XXMOT
Debug Flag: N
{P_TRACE=N, P_VIEW_COST=, P_EXCHANGE_RATE_CHAR=1, P_ITEM_TO=, P_TITLE=, P_EXP_SUBINV=1, P_CAT_TO=, P_COST_TYPE_ID=5, P_INVERSE_RATE=N, P_RATE_TYPE=2, P_AS_OF_Calling XDO Data Engine...
Scalable mode on...
+---------------------------------------------------------------------------+
Start of log messages from FND_FILE
+---------------------------------------------------------------------------+
1-17: Inserted 6116 items into CILT - include costing_enabled items only in Package CST_Inventory_PVT Procedure Populate_ItemList
2-10: Inserted 3 cost groups from organization 83 into CCLT in Package CST_Inventory_PVT Procedure Populate_CostGroupList
3-10: Inserted 33 subinventories into CSLT in Package CST_Inventory_PVT Procedure Populate_SubinventoryList
4-10: Calculated 2432 current onhand quantities in Package CST_Inventory_PVT Procedure Calculate_OnhandQty
5-20: Calculated 1 uncosted onhand quantities in Package CST_Inventory_PVT Procedure Calculate_OnhandQty
6-30: Calculated 495 rolled back onhand quantities in Package CST_Inventory_PVT Procedure Calculate_OnhandQty
7-110: Calculated 0 current intransit quantities coming into the current organization in Package CST_Inventory_PVT Procedure Calculate_IntransitQty
8-140: Calculated 0 rolled back intransit shipment quantities coming into the current org in Package CST_Inventory_PVT Procedure Calculate_IntransitQty
9-150: Calculated 0 rolled back intransit shipment quantities coming into the current organization in Package CST_Inventory_PVT Procedure Calculate_IntransitQty
10-60: Calculated 0 current intransit quantities going out of the current organization in Package CST_Inventory_PVT Procedure Calculate_IntransitQty
11-90: Calculated 0 rolled back intransit shipment quantities going out of the current organization in Package CST_Inventory_PVT Procedure Calculate_IntransitQty
12-200: Calculated 0 rolled back intransit shipment quantities going out of the current organization in Package CST_Inventory_PVT Procedure Calculate_IntransitQty
13-10: Calculated 195 current receiving quantities in Package CST_Inventory_PVT Procedure Calculate_ReceivingQty
14-30: Calculated 70 rollback receiving quantities in Package CST_Inventory_PVT Procedure Calculate_ReceivingQty
15-40: Calculated 0 past standard costs in Package CST_Inventory_PVT Procedure Calculate_InventoryCost
16-50: Calculated 11 expense items in Package CST_Inventory_PVT Procedure Calculate_InventoryCost
17-60: Calculated 241 past actual costs from MCACD in Package CST_Inventory_PVT Procedure Calculate_InventoryCost
18-70: Calculated 1752 actual costs from CQL in Package CST_Inventory_PVT Procedure Calculate_InventoryCost
19-90: Calculated 242 receiving costs in Package CST_Inventory_PVT Procedure Calculate_InventoryCost
20-80: Finished calculating inventory value in Package CST_Inventory_PUB Procedure Calculate_InventoryValue
+---------------------------------------------------------------------------+
End of log messages from FND_FILE
+---------------------------------------------------------------------------+
+---------------------------------------------------------------------------+
Executing request completion options...
Output file size:
1931837
+------------- 1) PUBLISH -------------+
Beginning post-processing of request 15285629 on node XXXMOTDB02 at 12-JUL-2019 17:59:19.
Post-processing of request 15285629 completed at 12-JUL-2019 23:43:37.
+--------------------------------------+
+------------- 2) PRINT -------------+
Printing output file.
Request ID : 15285629
Number of copies : 0
Printer : noprint
+--------------------------------------+
Finished executing request completion options.
+---------------------------------------------------------------------------+
Concurrent request completed successfully
Current system time is 12-JUL-2019 23:43:38
+---------------------------------------------------------------------------+

Thank you for the support

[ErmanArslansOracleBlog]

I would say -> Probably, it is spending its time in the database.
and I would say ->
enable trace and check the trace file.. You will the sqls executed by this request and you will be able to understand the problematic sqls that you need to be focused on..
Check it with your development team, as this seems a custom one.

But I don't say that:)
* It seems it is spending its time in OPP...

You have sufficient OPP process right?
anyways;

Check this MOS note -> Tuning Output Post Processor (OPP) to Improve Performance (Doc ID 1399454.1) and send me the OPP logs if you can't fix it after reviewing the note above.