DB2 - Problem description
| Problem IC72210 | Status: Closed |
HIGH LATCH CONTENTION ON RUNNING SETI ON EACH STATEMENT IN SQLE_ADD_SETINFO_FIELD | |
| product: | |
DB2 FOR LUW / DB2FORLUW / 970 - DB2 | |
| Problem description: | |
If application is setting client information frequently using
sqleseti api, server can hit latch contention.
The latch trace does show high contention as following:
XLATCH:ACQUIRE: 0x0780000000000cd8
(SMemPool::MemLatchType::latch) ; Conflicts: 96486 ; Waits:
77902
Wait Times: usecs (Min/Max/Avg/Total): 1.98 / 4670948.42
/ 341207.13 / 26580717804.82
Non Wait Times: usecs (Min/Max/Avg/Total): 0.64 /
109600.25 / 379.96 / 36660446.32
Stack Tracebacks (26454)
captureLatch__12SMemBasePoolFv + 0x64
sqlofmblkEx + 0x19C
sqlofmblkEx@glue7BA + 0x78
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x208
Stack Tracebacks (19514)
captureLatch__12SMemBasePoolFv + 0x64
sqlogmblkEx + 0x69C
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x1C4
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26@glueB40 +
0x8C
Stack Tracebacks (17978)
captureLatch__12SMemBasePoolFv + 0x64
sqlofmblkEx + 0x19C
sqlofmblkEx@glue7BA + 0x78
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x284
Stack Tracebacks (17857)
captureLatch__12SMemBasePoolFv + 0x64
sqlogmblkEx + 0x69C
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x13C
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26@glueB40 +
0x8C
XLATCH:RELEASE: 0x0780000000000cd8
(SMemPool::MemLatchType::latch) ; Conflicts: 136988
Latencies: usecs (Min/Max/Avg/Total): 4.06 / 1183332.31
/ 46327.26 / 6346278578.70
Stack Tracebacks (34414)
sqloSpinLockReleaseConflict + 0x160
sqloSpinLockReleaseConflict@glue74 + 0x78
releaseLatch__12SMemBasePoolFv + 0xC
sqlofmblkEx + 0x298
sqlofmblkEx@glue7BA + 0x78
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x284
Stack Tracebacks (34159)
sqloSpinLockReleaseConflict + 0x160
sqloSpinLockReleaseConflict@glue74 + 0x78
releaseLatch__12SMemBasePoolFv + 0xC
sqlofmblkEx + 0x298
sqlofmblkEx@glue7BA + 0x78
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x208
Stack Tracebacks (24525)
sqloSpinLockReleaseConflict + 0x160
sqloSpinLockReleaseConflict@glue74 + 0x78
releaseLatch__12SMemBasePoolFv + 0xC
sqlogmblkEx + 0xB8
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x13C
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26@glueB40 +
0x8C
Here is one of the complete stack:
</POFDisassembly>
<StackTrace>
-------Frame------ ------Function + Offset------
0x090000000679C15C sqloSpinLockReleaseConflict + 0x9C
0x090000000679C37C sqloSpinLockReleaseConflict@glue74 + 0x78
0x090000000679C2BC releaseLatch__12SMemBasePoolFv + 0xC
0x09000000067A3ABC sqlofmblkEx + 0x298
0x09000000067F5C3C sqlofmblkEx@glue7BA + 0x78
0x0900000003231B18
sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + 0x284
0x09000000069B78AC sqle_add_setinfo__FUiPcT1 + 0x3A0
0x0900000006918960 sqlrr_shortcut_excsqlset__FP8sqlrr_cbPcUiPb +
0x388
0x0900000006917C58 sqlrr_excsqlset__FP14db2UCinterface + 0x16C
0x0900000006917050
sqljs_ddm_excsqlset__FP14db2UCinterfaceP13sqljDDMObject + 0x7A4
0x090000000691683C
sqljsParseRdbAccessed__FP13sqljsDrdaAsCbP13sqljDDMObjectP14db2UC
interface
+ 0xB8
0x0900000006735E44
.sqljsParse.fdpr.clone.29__FP13sqljsDrdaAsCbP14db2UCinterfaceP8s
qeAgentb
+ 0x248
0x0900000006730804 @64@sqljsSqlam__FP14db2UCinterfaceP8sqeAgentb
+ 0x3CC
0x0900000006598324
@64@sqljsDriveRequests__FP8sqeAgentP14db2UCconHandle + 0xB0
0x0900000006597FEC
@64@sqljsDrdaAsInnerDriver__FP18SQLCC_INITSTRUCT_Tb + 0x258
0x0900000006597AEC sqljsDrdaAsDriver__FP18SQLCC_INITSTRUCT_T +
0xEC
0x0900000006896EE8 RunEDU__8sqeAgentFv + 0x234
0x0900000006895FB0 EDUDriver__9sqzEDUObjFv + 0xDC
0x0900000006891F10 sqloEDUEntry + 0x260
</StackTrace> | |
| Problem Summary: | |
**************************************************************** * USERS AFFECTED: * * ALL * **************************************************************** * PROBLEM DESCRIPTION: * * If application is setting client information frequently * * using sqleseti api, server can hit latch contention. * * The latch trace does show high contention as following: * * * * XLATCH:ACQUIRE: 0x0780000000000cd8 * * (SMemPool::MemLatchType::latch) ; Conflicts: 96486 ; Waits: * * 77902 * * Wait Times: usecs (Min/Max/Avg/Total): 1.98 / * * 4670948.42 / 341207.13 / 26580717804.82 * * Non Wait Times: usecs (Min/Max/Avg/Total): 0.64 / * * 109600.25 / 379.96 / 36660446.32 * * * * Stack Tracebacks (26454) * * captureLatch__12SMemBasePoolFv + 0x64 * * sqlofmblkEx + 0x19C * * sqlofmblkEx@glue7BA + 0x78 * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x208 * * * * Stack Tracebacks (19514) * * captureLatch__12SMemBasePoolFv + 0x64 * * sqlogmblkEx + 0x69C * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x1C4 * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26@glueB40 * + 0x8C * * * * Stack Tracebacks (17978) * * captureLatch__12SMemBasePoolFv + 0x64 * * sqlofmblkEx + 0x19C * * sqlofmblkEx@glue7BA + 0x78 * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x284 * * * * Stack Tracebacks (17857) * * captureLatch__12SMemBasePoolFv + 0x64 * * sqlogmblkEx + 0x69C * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x13C * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26@glueB40 * + 0x8C * * * * XLATCH:RELEASE: 0x0780000000000cd8 * * (SMemPool::MemLatchType::latch) ; Conflicts: 136988 * * Latencies: usecs (Min/Max/Avg/Total): 4.06 / * * 1183332.31 / 46327.26 / 6346278578.70 * * * * Stack Tracebacks (34414) * * sqloSpinLockReleaseConflict + 0x160 * * sqloSpinLockReleaseConflict@glue74 + 0x78 * * releaseLatch__12SMemBasePoolFv + 0xC * * sqlofmblkEx + 0x298 * * sqlofmblkEx@glue7BA + 0x78 * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x284 * * * * Stack Tracebacks (34159) * * sqloSpinLockReleaseConflict + 0x160 * * sqloSpinLockReleaseConflict@glue74 + 0x78 * * releaseLatch__12SMemBasePoolFv + 0xC * * sqlofmblkEx + 0x298 * * sqlofmblkEx@glue7BA + 0x78 * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x208 * * * * Stack Tracebacks (24525) * * sqloSpinLockReleaseConflict + 0x160 * * sqloSpinLockReleaseConflict@glue74 + 0x78 * * releaseLatch__12SMemBasePoolFv + 0xC * * sqlogmblkEx + 0xB8 * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x13C * * * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26@glueB40 * + 0x8C * * * * Here is one of the complete stack: * * </POFDisassembly> * * <StackTrace> * * -------Frame------ ------Function + Offset------ * * 0x090000000679C15C sqloSpinLockReleaseConflict + 0x9C * * 0x090000000679C37C sqloSpinLockReleaseConflict@glue74 + 0x78 * * 0x090000000679C2BC releaseLatch__12SMemBasePoolFv + 0xC * * 0x09000000067A3ABC sqlofmblkEx + 0x298 * * 0x09000000067F5C3C sqlofmblkEx@glue7BA + 0x78 * * 0x0900000003231B18 * * sqle_add_setinfo_field__FP8sqeAgentPcUiT3PPcPUiT6T5N26 + * * 0x284 * * 0x09000000069B78AC sqle_add_setinfo__FUiPcT1 + 0x3A0 * * 0x0900000006918960 * * sqlrr_shortcut_excsqlset__FP8sqlrr_cbPcUiPb + 0x388 * * 0x0900000006917C58 sqlrr_excsqlset__FP14db2UCinterface + * * 0x16C * * 0x0900000006917050 * * sqljs_ddm_excsqlset__FP14db2UCinterfaceP13sqljDDMObject + * * 0x7A4 * * 0x090000000691683C * * sqljsParseRdbAccessed__FP13sqljsDrdaAsCbP13sqljDDMObjectP14db2 * + 0xB8 * * 0x0900000006735E44 * * .sqljsParse.fdpr.clone.29__FP13sqljsDrdaAsCbP14db2UCinterfaceP * + 0x248 * * 0x0900000006730804 * * @64@sqljsSqlam__FP14db2UCinterfaceP8sqeAgentb + 0x3CC * * 0x0900000006598324 * * @64@sqljsDriveRequests__FP8sqeAgentP14db2UCconHandle + 0xB0 * * 0x0900000006597FEC * * @64@sqljsDrdaAsInnerDriver__FP18SQLCC_INITSTRUCT_Tb + 0x258 * * 0x0900000006597AEC sqljsDrdaAsDriver__FP18SQLCC_INITSTRUCT_T * * + 0xEC * * 0x0900000006896EE8 RunEDU__8sqeAgentFv + 0x234 * * 0x0900000006895FB0 EDUDriver__9sqzEDUObjFv + 0xDC * * 0x0900000006891F10 sqloEDUEntry + 0x260 * * </StackTrace> * **************************************************************** * RECOMMENDATION: * * Upgrade DB2 LUW server to v97.7.4 * **************************************************************** | |
| Local Fix: | |
| available fix packs: | |
DB2 Version 9.7 Fix Pack 4 for Linux, UNIX, and Windows | |
| Solution | |
| Workaround | |
not known / see Local fix | |
| BUG-Tracking | |
forerunner : APAR is sysrouted TO one or more of the following: IC72212 follow-up : | |
| Timestamps | |
Date - problem reported : Date - problem closed : Date - last modified : | 26.10.2010 28.04.2011 28.04.2011 |
| Problem solved at the following versions (IBM BugInfos) | |
9.7.7.4 | |
| Problem solved according to the fixlist(s) of the following version(s) | |
| 9.7.0.4 |
|