Long Transaction Despite DYNAMIC_LOGS = 2
Posted in 2009
A DBA on IDS 11.50 (AIX) was puzzled that a transaction was flagged and aborted as a long transaction (LTXHWM 70 / LTXEHWM 80, 100 logs of 33 MB) even though DYNAMIC_LOGS was set to 2, with no new logs added despite free dbspace. Replies explained this is expected behaviour, not a bug: DYNAMIC_LOGS doesn't prevent long transactions; it only adds logical logs if the server would otherwise run out of log space during the rollback, to stop the instance hanging. Here the rollback finished within the ~28 remaining logs, so no dynamic logs were needed. To avoid the abort, the transaction must be made smaller or the log space/LTXHWM raised.
Auto-generated by DrWatson from the posts below — may be imperfect; read the full thread.
Topics: Server Administration, Logging & Checkpoints, Platform-Specific Issues
IDS 11.50.FC5 AIX 5.3 (4K Page Size)
The following $ONCONFIG parameters were established:
LTXHWM 70 # Long Transaction Low Water Mark
LTXEHWM 80 # Long Transaction High Water Mark
LOGFILES 100 # Number of logical log files
LOGSIZE 33000 # Logical log size (Kbytes)
DYNAMIC_LOGS 2
However, instead of dynamically creating more logical logs to prevent a
longtx, we got the following in the online.log:
12:05:41 Logical Log 48 Complete, timestamp: 0x741c81.
12:05:45 Logical Log 49 Complete, timestamp: 0x7807fd.
12:05:49 Logical Log 50 Complete, timestamp: 0x7b5f00.
12:05:56 Logical Log 51 Complete, timestamp: 0x7ee4e6.
12:06:05 Logical Log 52 Complete, timestamp: 0x8359d7.
12:06:12 Logical Log 53 Complete, timestamp: 0x86575e.
12:06:21 Logical Log 54 Complete, timestamp: 0x8ad1bd.
12:06:29 Logical Log 55 Complete, timestamp: 0x8e92f6.
12:06:37 Logical Log 56 Complete, timestamp: 0x923297.
12:06:45 Logical Log 57 Complete, timestamp: 0x95a621.
12:06:53 Logical Log 58 Complete, timestamp: 0x9968ee.
12:06:59 Logical Log 59 Complete, timestamp: 0x9cb08e.
12:07:06 Logical Log 60 Complete, timestamp: 0xa05975.
12:07:13 Logical Log 61 Complete, timestamp: 0xa413d9.
12:07:21 Logical Log 62 Complete, timestamp: 0xa81edf.
12:07:28 Logical Log 63 Complete, timestamp: 0xab874a.
12:07:36 Logical Log 64 Complete, timestamp: 0xaf3295.
12:07:44 Logical Log 65 Complete, timestamp: 0xb300ed.
12:07:52 Logical Log 66 Complete, timestamp: 0xb6e40b.
12:08:00 Logical Log 67 Complete, timestamp: 0xbab834.
12:08:08 Logical Log 68 Complete, timestamp: 0xbe787e.
12:08:15 Logical Log 69 Complete, timestamp: 0xc1fccd.
12:08:22 Logical Log 70 Complete, timestamp: 0xc5c303.
12:08:29 Logical Log 71 Complete, timestamp: 0xc97cd0.
12:08:36 Logical Log 72 Complete, timestamp: 0xcd2c43.
12:08:44 Logical Log 73 Complete, timestamp: 0xd125b2.
12:08:52 Logical Log 74 Complete, timestamp: 0xd503b1.
12:09:00 Checkpoint Completed: duration was 1 seconds.
12:09:00 Wed Dec 2 - loguniq 75, logpos 0x193c164, timestamp: 0xd7a85c
Interval: 162
12:09:00 Maximum server connections 16
12:09:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
Plog used 845, Llog used 222322
12:09:00 Logical Log 75 Complete, timestamp: 0xd83dbc.
12:09:03 Logical Log 76 Complete, timestamp: 0xdcfc73.
12:09:06 Logical Log 77 Complete, timestamp: 0xdfa011.
12:09:11 Logical Log 78 Complete, timestamp: 0xe35a21.
12:09:17 Logical Log 79 Complete, timestamp: 0xe7b091.
12:09:23 Logical Log 80 Complete, timestamp: 0xebfd9b.
12:09:28 Logical Log 81 Complete, timestamp: 0xeed9b5.
12:09:34 Logical Log 82 Complete, timestamp: 0xf28d3d.
12:09:40 Logical Log 83 Complete, timestamp: 0xf6e0e9.
12:09:45 Logical Log 84 Complete, timestamp: 0xfa2924.
12:09:51 Logical Log 85 Complete, timestamp: 0xfe6f02.
12:09:54 Logical Log 86 Complete, timestamp: 0x1011839.
12:09:59 Logical Log 87 Complete, timestamp: 0x10515ee.
12:10:04 Logical Log 88 Complete, timestamp: 0x108fffc.
12:10:09 Logical Log 89 Complete, timestamp: 0x10c4242.
12:10:15 Logical Log 90 Complete, timestamp: 0x1107c30.
12:10:21 Logical Log 91 Complete, timestamp: 0x114d2fe.
12:10:26 Logical Log 92 Complete, timestamp: 0x117cdc7.
12:10:31 Logical Log 93 Complete, timestamp: 0x11b1aa1.
12:10:37 Logical Log 94 Complete, timestamp: 0x11f8043.
12:10:43 Logical Log 95 Complete, timestamp: 0x124199b.
12:10:47 Logical Log 96 Complete, timestamp: 0x1267e0b.
12:10:51 Logical Log 97 Complete, timestamp: 0x12a4ebd.
12:10:56 Logical Log 98 Complete, timestamp: 0x12e3b6e.
12:11:01 Logical Log 99 Complete, timestamp: 0x1322551.
12:11:06 Logical Log 100 Complete, timestamp: 0x1353242.
12:11:12 Logical Log 101 Complete, timestamp: 0x139e427.
12:11:17 Checkpoint Completed: duration was 3 seconds.
12:11:17 Wed Dec 2 - loguniq 102, logpos 0x11e03e8, timestamp: 0x13dbb55
Interval: 163
12:11:17 Maximum server connections 16
12:11:17 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
Plog used 79, Llog used 227035
12:11:18 Logical Log 102 Complete, timestamp: 0x13ecaaa.
12:11:19 Logical Log 103 Complete, timestamp: 0x14064e1.
12:11:25 Logical Log 104 Complete, timestamp: 0x1443ae1.
12:11:30 Logical Log 105 Complete, timestamp: 0x147d5c2.
12:11:35 Logical Log 106 Complete, timestamp: 0x14bb483.
12:11:40 Logical Log 107 Complete, timestamp: 0x14f9fca.
12:11:45 Logical Log 108 Complete, timestamp: 0x1531fec.
12:11:51 Logical Log 109 Complete, timestamp: 0x157b981.
12:11:56 Logical Log 110 Complete, timestamp: 0x15aec37.
12:12:02 Logical Log 111 Complete, timestamp: 0x15f917c.
12:12:07 Logical Log 112 Complete, timestamp: 0x162484e.
12:12:13 Logical Log 113 Complete, timestamp: 0x1668f47.
12:12:18 Logical Log 114 Complete, timestamp: 0x16997af.
12:12:23 Logical Log 115 Complete, timestamp: 0x16d1b79.
12:12:27 Logical Log 116 Complete, timestamp: 0x170bb34.
12:12:32 Logical Log 117 Complete, timestamp: 0x1747ea3.
-----> 12:12:32 Aborting Long Transaction: tx 0x700000060799fd0 username:
ifxcmgt uid: 204
12:12:35 Checkpoint Completed: duration was 2 seconds.
12:12:35 Wed Dec 2 - loguniq 118, logpos 0xd3794, timestamp: 0x176bf6a
Interval: 164
12:12:35 Maximum server connections 16
12:12:35 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 3,
Plog used 60, Llog used 128855
12:12:50 Logical Log 118 Complete, timestamp: 0x184259f.
12:13:14 Logical Log 119 Complete, timestamp: 0x19357bd.
12:13:47 Logical Log 120 Complete, timestamp: 0x1a2569f.
12:14:23 Logical Log 121 Complete, timestamp: 0x1b10f96.
12:14:59 Logical Log 122 Complete, timestamp: 0x1c09e42.
12:15:34 Logical Log 123 Complete, timestamp: 0x1cf5408.
12:16:11 Logical Log 124 Complete, timestamp: 0x1de7ba2.
12:16:48 Logical Log 125 Complete, timestamp: 0x1ee0ab1.
12:17:24 Logical Log 126 Complete, timestamp: 0x1fce87b.
12:18:01 Logical Log 127 Complete, timestamp: 0x20c5ce7.
12:18:36 Logical Log 128 Complete, timestamp: 0x21b35fb.
12:18:47 Checkpoint Completed: duration was 2 seconds.
12:18:47 Wed Dec 2 - loguniq 129, logpos 0x81a1f8, timestamp: 0x21f4fd0
Interval: 165
12:19:07 Logical Log 129 Complete, timestamp: 0x22a8c39.
12:19:43 Logical Log 130 Complete, timestamp: 0x239b3a4.
12:20:19 Logical Log 131 Complete, timestamp: 0x2491af7.
12:20:55 Logical Log 132 Complete, timestamp: 0x257f6bc.
-----> 12:21:21 Long Transaction 0x700000060799fd0 Aborted. Rollback Duration:
0 Seconds
There is plenty of space for more logical logs to be created elsewhere in the
instance, but no attempt, that I can tell, was made to do so.
Any ideas? Thanks in advance.
Clifton
_________________________________________________________________
Windows Live Hotmail is faster and more secure than ever.
http://www.microsoft.com/windows/windowslive/hotmail_bl1/hotmail_bl1.aspx?ocid=P
ID23879::T:WLMTAGL:ON:WL:en-ww:WM_IMHM_1:092009
Dynamic-log file allocation prevents "long transaction rollbacks from
hanging the system", I don't think it prevents longtx itself.
- Nilesh -
ids-bounces@iiug.org wrote on 12/02/2009 12:13:12 PM:
> From:
>
> "Clifton Bean" <clifton_bean@hotmail.com>:
>
> To:
>
> ids@iiug.org
>
> Date:
>
> 12/02/2009 12:14 PM
>
> Subject:
>
> Long Transaction Despite DYNAMIC_LOGS = 2 [18245]>
>
> Sent by:
>
> ids-bounces@iiug.org
>
> IDS 11.50.FC5 AIX 5.3 (4K Page Size)
>
> The following $ONCONFIG parameters were established:
>
> LTXHWM 70 # Long Transaction Low Water Mark
> LTXEHWM 80 # Long Transaction High Water Mark
>
> LOGFILES 100 # Number of logical log files
> LOGSIZE 33000 # Logical log size (Kbytes)
>
> DYNAMIC_LOGS 2>
> However, instead of dynamically creating more logical logs to prevent a
> longtx, we got the following in the online.log:
>
> 12:05:41 Logical Log 48 Complete, timestamp: 0x741c81.
> 12:05:45 Logical Log 49 Complete, timestamp: 0x7807fd.
> 12:05:49 Logical Log 50 Complete, timestamp: 0x7b5f00.
> 12:05:56 Logical Log 51 Complete, timestamp: 0x7ee4e6.
> 12:06:05 Logical Log 52 Complete, timestamp: 0x8359d7.
> 12:06:12 Logical Log 53 Complete, timestamp: 0x86575e.
> 12:06:21 Logical Log 54 Complete, timestamp: 0x8ad1bd.
> 12:06:29 Logical Log 55 Complete, timestamp: 0x8e92f6.
> 12:06:37 Logical Log 56 Complete, timestamp: 0x923297.
> 12:06:45 Logical Log 57 Complete, timestamp: 0x95a621.
> 12:06:53 Logical Log 58 Complete, timestamp: 0x9968ee.
> 12:06:59 Logical Log 59 Complete, timestamp: 0x9cb08e.
> 12:07:06 Logical Log 60 Complete, timestamp: 0xa05975.
> 12:07:13 Logical Log 61 Complete, timestamp: 0xa413d9.
> 12:07:21 Logical Log 62 Complete, timestamp: 0xa81edf.
> 12:07:28 Logical Log 63 Complete, timestamp: 0xab874a.
> 12:07:36 Logical Log 64 Complete, timestamp: 0xaf3295.
> 12:07:44 Logical Log 65 Complete, timestamp: 0xb300ed.
> 12:07:52 Logical Log 66 Complete, timestamp: 0xb6e40b.
> 12:08:00 Logical Log 67 Complete, timestamp: 0xbab834.
> 12:08:08 Logical Log 68 Complete, timestamp: 0xbe787e.
> 12:08:15 Logical Log 69 Complete, timestamp: 0xc1fccd.
> 12:08:22 Logical Log 70 Complete, timestamp: 0xc5c303.
> 12:08:29 Logical Log 71 Complete, timestamp: 0xc97cd0.
> 12:08:36 Logical Log 72 Complete, timestamp: 0xcd2c43.
> 12:08:44 Logical Log 73 Complete, timestamp: 0xd125b2.
> 12:08:52 Logical Log 74 Complete, timestamp: 0xd503b1.
> 12:09:00 Checkpoint Completed: duration was 1 seconds.
> 12:09:00 Wed Dec 2 - loguniq 75, logpos 0x193c164, timestamp: 0xd7a85c
> Interval: 162
>
> 12:09:00 Maximum server connections 16
> 12:09:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns
blocked 1,
> Plog used 845, Llog used 222322
>
> 12:09:00 Logical Log 75 Complete, timestamp: 0xd83dbc.
> 12:09:03 Logical Log 76 Complete, timestamp: 0xdcfc73.
> 12:09:06 Logical Log 77 Complete, timestamp: 0xdfa011.
> 12:09:11 Logical Log 78 Complete, timestamp: 0xe35a21.
> 12:09:17 Logical Log 79 Complete, timestamp: 0xe7b091.
> 12:09:23 Logical Log 80 Complete, timestamp: 0xebfd9b.
> 12:09:28 Logical Log 81 Complete, timestamp: 0xeed9b5.
> 12:09:34 Logical Log 82 Complete, timestamp: 0xf28d3d.
> 12:09:40 Logical Log 83 Complete, timestamp: 0xf6e0e9.
> 12:09:45 Logical Log 84 Complete, timestamp: 0xfa2924.
> 12:09:51 Logical Log 85 Complete, timestamp: 0xfe6f02.
> 12:09:54 Logical Log 86 Complete, timestamp: 0x1011839.
> 12:09:59 Logical Log 87 Complete, timestamp: 0x10515ee.
> 12:10:04 Logical Log 88 Complete, timestamp: 0x108fffc.
> 12:10:09 Logical Log 89 Complete, timestamp: 0x10c4242.
> 12:10:15 Logical Log 90 Complete, timestamp: 0x1107c30.
> 12:10:21 Logical Log 91 Complete, timestamp: 0x114d2fe.
> 12:10:26 Logical Log 92 Complete, timestamp: 0x117cdc7.
> 12:10:31 Logical Log 93 Complete, timestamp: 0x11b1aa1.
> 12:10:37 Logical Log 94 Complete, timestamp: 0x11f8043.
> 12:10:43 Logical Log 95 Complete, timestamp: 0x124199b.
> 12:10:47 Logical Log 96 Complete, timestamp: 0x1267e0b.
> 12:10:51 Logical Log 97 Complete, timestamp: 0x12a4ebd.
> 12:10:56 Logical Log 98 Complete, timestamp: 0x12e3b6e.
> 12:11:01 Logical Log 99 Complete, timestamp: 0x1322551.
> 12:11:06 Logical Log 100 Complete, timestamp: 0x1353242.
> 12:11:12 Logical Log 101 Complete, timestamp: 0x139e427.
> 12:11:17 Checkpoint Completed: duration was 3 seconds.
> 12:11:17 Wed Dec 2 - loguniq 102, logpos 0x11e03e8, timestamp: 0x13dbb55
> Interval: 163
>
> 12:11:17 Maximum server connections 16
> 12:11:17 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns
blocked 1,
> Plog used 79, Llog used 227035
>
> 12:11:18 Logical Log 102 Complete, timestamp: 0x13ecaaa.
> 12:11:19 Logical Log 103 Complete, timestamp: 0x14064e1.
> 12:11:25 Logical Log 104 Complete, timestamp: 0x1443ae1.
> 12:11:30 Logical Log 105 Complete, timestamp: 0x147d5c2.
> 12:11:35 Logical Log 106 Complete, timestamp: 0x14bb483.
> 12:11:40 Logical Log 107 Complete, timestamp: 0x14f9fca.
> 12:11:45 Logical Log 108 Complete, timestamp: 0x1531fec.
> 12:11:51 Logical Log 109 Complete, timestamp: 0x157b981.
> 12:11:56 Logical Log 110 Complete, timestamp: 0x15aec37.
> 12:12:02 Logical Log 111 Complete, timestamp: 0x15f917c.
> 12:12:07 Logical Log 112 Complete, timestamp: 0x162484e.
> 12:12:13 Logical Log 113 Complete, timestamp: 0x1668f47.
> 12:12:18 Logical Log 114 Complete, timestamp: 0x16997af.
> 12:12:23 Logical Log 115 Complete, timestamp: 0x16d1b79.
> 12:12:27 Logical Log 116 Complete, timestamp: 0x170bb34.
> 12:12:32 Logical Log 117 Complete, timestamp: 0x1747ea3.
>
> -----> 12:12:32 Aborting Long Transaction: tx 0x700000060799fd0 username:
> ifxcmgt uid: 204
>
> 12:12:35 Checkpoint Completed: duration was 2 seconds.
> 12:12:35 Wed Dec 2 - loguniq 118, logpos 0xd3794, timestamp: 0x176bf6a
> Interval: 164
>
> 12:12:35 Maximum server connections 16
> 12:12:35 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns
blocked 3,
> Plog used 60, Llog used 128855
>
> 12:12:50 Logical Log 118 Complete, timestamp: 0x184259f.
> 12:13:14 Logical Log 119 Complete, timestamp: 0x19357bd.
> 12:13:47 Logical Log 120 Complete, timestamp: 0x1a2569f.
> 12:14:23 Logical Log 121 Complete, timestamp: 0x1b10f96.
> 12:14:59 Logical Log 122 Complete, timestamp: 0x1c09e42.
> 12:15:34 Logical Log 123 Complete, timestamp: 0x1cf5408.
> 12:16:11 Logical Log 124 Complete, timestamp: 0x1de7ba2.
> 12:16:48 Logical Log 125 Complete, timestamp: 0x1ee0ab1.
> 12:17:24 Logical Log 126 Complete, timestamp: 0x1fce87b.
> 12:18:01 Logical Log 127 Complete, timestamp: 0x20c5ce7.
> 12:18:36 Logical Log 128 Complete, timestamp: 0x21b35fb.
> 12:18:47 Checkpoint Completed: duration was 2 seconds.
> 12:18:47 Wed Dec 2 - loguniq 129, logpos 0x81a1f8, timestamp: 0x21f4fd0
> Interval: 165
>
> 12:19:07 Logical Log 129 Complete, timestamp: 0x22a8c39.
> 12:19:43 Logical Log 130 Complete, timestamp: 0x239b3a4.
> 12:20:19 Logical Log 131 Complete, timestamp: 0x2491af7.
> 12:20:55 Logical Log 132 Complete, timestamp: 0x257f6bc.
>
> -----> 12:21:21 Long Transaction 0x700000060799fd0 Aborted.
RollbackDuration:
> 0 Seconds
>
> T
It only helped us during rollback to create additional logs, but not for
forward logs during long tx.
Thanks,
*******************************************************************
Ernie Knox
IT Database Administrator Specialist
Sears Holdings
3333 Beverly Rd., B4-266A
Hoffman Estates, IL. 60179
Office: (847) 286-5735
Email: Ernest.Knox@searshc.com
Blackberry: 2244650553@messaging.sprintpcs.com
Page via Skytel: 2244650553@sprint.skytel.com
Informix or MySQL Primary: 9110210@skytel.com
Informix or MySQL Secondary: 7276872@skytel.com
" Yes we can make a Change! "
" It's always a great day to watch Sports - GO LIONS, TIGERS, and BEARS!
"
" Lets not forget - GO Pistons and Red Wings! "
GSU
*******************************************************************
-----Original Message-----
From: ids-bounces@iiug.org [mailto:ids-bounces@iiug.org] On Behalf Of
Nilesh Ozarkar
Sent: Wednesday, December 02, 2009 12:51 PM
To: ids@iiug.org
Subject: Re: Long Transaction Despite DYNAMIC_LOGS = 2 [18246]
Dynamic-log file allocation prevents "long transaction rollbacks from
hanging the system", I don't think it prevents longtx itself.
- Nilesh -
ids-bounces@iiug.org wrote on 12/02/2009 12:13:12 PM:
> From:
>
> "Clifton Bean" <clifton_bean@hotmail.com>:
>
> To:
>
> ids@iiug.org
>
> Date:
>
> 12/02/2009 12:14 PM
>
> Subject:
>
> Long Transaction Despite DYNAMIC_LOGS = 2 [18245]>
>
> Sent by:
>
> ids-bounces@iiug.org
>
> IDS 11.50.FC5 AIX 5.3 (4K Page Size)
>
> The following $ONCONFIG parameters were established:
>
> LTXHWM 70 # Long Transaction Low Water Mark
> LTXEHWM 80 # Long Transaction High Water Mark
>
> LOGFILES 100 # Number of logical log files
> LOGSIZE 33000 # Logical log size (Kbytes)
>
> DYNAMIC_LOGS 2>
> However, instead of dynamically creating more logical logs to prevent
a
> longtx, we got the following in the online.log:
>
> 12:05:41 Logical Log 48 Complete, timestamp: 0x741c81.
> 12:05:45 Logical Log 49 Complete, timestamp: 0x7807fd.
> 12:05:49 Logical Log 50 Complete, timestamp: 0x7b5f00.
> 12:05:56 Logical Log 51 Complete, timestamp: 0x7ee4e6.
> 12:06:05 Logical Log 52 Complete, timestamp: 0x8359d7.
> 12:06:12 Logical Log 53 Complete, timestamp: 0x86575e.
> 12:06:21 Logical Log 54 Complete, timestamp: 0x8ad1bd.
> 12:06:29 Logical Log 55 Complete, timestamp: 0x8e92f6.
> 12:06:37 Logical Log 56 Complete, timestamp: 0x923297.
> 12:06:45 Logical Log 57 Complete, timestamp: 0x95a621.
> 12:06:53 Logical Log 58 Complete, timestamp: 0x9968ee.
> 12:06:59 Logical Log 59 Complete, timestamp: 0x9cb08e.
> 12:07:06 Logical Log 60 Complete, timestamp: 0xa05975.
> 12:07:13 Logical Log 61 Complete, timestamp: 0xa413d9.
> 12:07:21 Logical Log 62 Complete, timestamp: 0xa81edf.
> 12:07:28 Logical Log 63 Complete, timestamp: 0xab874a.
> 12:07:36 Logical Log 64 Complete, timestamp: 0xaf3295.
> 12:07:44 Logical Log 65 Complete, timestamp: 0xb300ed.
> 12:07:52 Logical Log 66 Complete, timestamp: 0xb6e40b.
> 12:08:00 Logical Log 67 Complete, timestamp: 0xbab834.
> 12:08:08 Logical Log 68 Complete, timestamp: 0xbe787e.
> 12:08:15 Logical Log 69 Complete, timestamp: 0xc1fccd.
> 12:08:22 Logical Log 70 Complete, timestamp: 0xc5c303.
> 12:08:29 Logical Log 71 Complete, timestamp: 0xc97cd0.
> 12:08:36 Logical Log 72 Complete, timestamp: 0xcd2c43.
> 12:08:44 Logical Log 73 Complete, timestamp: 0xd125b2.
> 12:08:52 Logical Log 74 Complete, timestamp: 0xd503b1.
> 12:09:00 Checkpoint Completed: duration was 1 seconds.
> 12:09:00 Wed Dec 2 - loguniq 75, logpos 0x193c164, timestamp: 0xd7a85c
> Interval: 162
>
> 12:09:00 Maximum server connections 16
> 12:09:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns
blocked 1,
> Plog used 845, Llog used 222322
>
> 12:09:00 Logical Log 75 Complete, timestamp: 0xd83dbc.
> 12:09:03 Logical Log 76 Complete, timestamp: 0xdcfc73.
> 12:09:06 Logical Log 77 Complete, timestamp: 0xdfa011.
> 12:09:11 Logical Log 78 Complete, timestamp: 0xe35a21.
> 12:09:17 Logical Log 79 Complete, timestamp: 0xe7b091.
> 12:09:23 Logical Log 80 Complete, timestamp: 0xebfd9b.
> 12:09:28 Logical Log 81 Complete, timestamp: 0xeed9b5.
> 12:09:34 Logical Log 82 Complete, timestamp: 0xf28d3d.
> 12:09:40 Logical Log 83 Complete, timestamp: 0xf6e0e9.
> 12:09:45 Logical Log 84 Complete, timestamp: 0xfa2924.
> 12:09:51 Logical Log 85 Complete, timestamp: 0xfe6f02.
> 12:09:54 Logical Log 86 Complete, timestamp: 0x1011839.
> 12:09:59 Logical Log 87 Complete, timestamp: 0x10515ee.
> 12:10:04 Logical Log 88 Complete, timestamp: 0x108fffc.
> 12:10:09 Logical Log 89 Complete, timestamp: 0x10c4242.
> 12:10:15 Logical Log 90 Complete, timestamp: 0x1107c30.
> 12:10:21 Logical Log 91 Complete, timestamp: 0x114d2fe.
> 12:10:26 Logical Log 92 Complete, timestamp: 0x117cdc7.
> 12:10:31 Logical Log 93 Complete, timestamp: 0x11b1aa1.
> 12:10:37 Logical Log 94 Complete, timestamp: 0x11f8043.
> 12:10:43 Logical Log 95 Complete, timestamp: 0x124199b.
> 12:10:47 Logical Log 96 Complete, timestamp: 0x1267e0b.
> 12:10:51 Logical Log 97 Complete, timestamp: 0x12a4ebd.
> 12:10:56 Logical Log 98 Complete, timestamp: 0x12e3b6e.
> 12:11:01 Logical Log 99 Complete, timestamp: 0x1322551.
> 12:11:06 Logical Log 100 Complete, timestamp: 0x1353242.
> 12:11:12 Logical Log 101 Complete, timestamp: 0x139e427.
> 12:11:17 Checkpoint Completed: duration was 3 seconds.
> 12:11:17 Wed Dec 2 - loguniq 102, logpos 0x11e03e8, timestamp:
0x13dbb55
> Interval: 163
>
> 12:11:17 Maximum server connections 16
> 12:11:17 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns
blocked 1,
> Plog used 79, Llog used 227035
>
> 12:11:18 Logical Log 102 Complete, timestamp: 0x13ecaaa.
> 12:11:19 Logical Log 103 Complete, timestamp: 0x14064e1.
> 12:11:25 Logical Log 104 Complete, timestamp: 0x1443ae1.
> 12:11:30 Logical Log 105 Complete, timestamp: 0x147d5c2.
> 12:11:35 Logical Log 106 Complete, timestamp: 0x14bb483.
> 12:11:40 Logical Log 107 Complete, timestamp: 0x14f9fca.
> 12:11:45 Logical Log 108 Complete, timestamp: 0x1531fec.
> 12:11:51 Logical Log 109 Complete, timestamp: 0x157b981.
> 12:11:56 Logical Log 110 Complete, timestamp: 0x15aec37.
> 12:12:02 Logical Log 111 Complete, timestamp: 0x15f917c.
> 12:12:07 Logical Log 112 Complete, timestamp: 0x162484e.
> 12:12:13 Logical Log 113 Complete, timestamp: 0x1668f47.
> 12:12:18 Logical Log 114 Complete, timestamp: 0x16997af.
> 12:12:23 Logical Log 115 Complete, timestamp: 0x16d1b79.
> 12:12:27 Logical Log 116 Complete, timestamp: 0x170bb34.
> 12:12:32 Logical Log 117 Complete, timestamp: 0x1747ea3.
>
> -----> 12:12:32 Aborting Long Transaction: tx 0x700000060799fd0
username:
> ifxcmgt uid: 204
>
> 12:12:35 Checkpoint Completed: duration was 2 seconds.
> 12:12:35 Wed Dec 2 - loguniq 118, logpos 0xd3794, timestamp: 0x176bf6a
> Interval: 164
>
> 12:12:35 Maximum server connections 16
> 12:12:35 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns
blocked 3,
> Plog used 60, Llog used 128855
>
> 12:12:50 Logical Log 118 Complete, time
Hi Clifton,
I believe you misunderstand the intent of dynamic logs.
Back in the day , it was possible to fill all your logical logs with a long
transaction, and hang the instance. The only solution was to contact technical
support to basically add enough logical logs so that you could rollback the
transaction.
DYNAMIC_LOGS was created to eliminate the possibility of a long transaction
from filling all logs and hanging the instance. DYNAMIC_LOGS does not mean you
cannot get a long transaction, as the logs only get added if you run out of
logs during the rollback of a transaction.
Hope that helps,
Mark
________________________________
From: Clifton Bean <clifton_bean@hotmail.com>
To: ids@iiug.org
Sent: Wed, December 2, 2009 12:13:12 PM
Subject: Long Transaction Despite DYNAMIC_LOGS = 2 [18245]
IDS 11.50.FC5 AIX 5.3 (4K Page Size)
The following $ONCONFIG parameters were established:
LTXHWM 70 # Long Transaction Low Water Mark
LTXEHWM 80 # Long Transaction High Water Mark
LOGFILES 100 # Number of logical log files
LOGSIZE 33000 # Logical log size (Kbytes)
DYNAMIC_LOGS 2
However, instead of dynamically creating more logical logs to prevent a
longtx, we got the following in the online.log:
12:05:41 Logical Log 48 Complete, timestamp: 0x741c81.
12:05:45 Logical Log 49 Complete, timestamp: 0x7807fd.
12:05:49 Logical Log 50 Complete, timestamp: 0x7b5f00.
12:05:56 Logical Log 51 Complete, timestamp: 0x7ee4e6.
12:06:05 Logical Log 52 Complete, timestamp: 0x8359d7.
12:06:12 Logical Log 53 Complete, timestamp: 0x86575e.
12:06:21 Logical Log 54 Complete, timestamp: 0x8ad1bd.
12:06:29 Logical Log 55 Complete, timestamp: 0x8e92f6.
12:06:37 Logical Log 56 Complete, timestamp: 0x923297.
12:06:45 Logical Log 57 Complete, timestamp: 0x95a621.
12:06:53 Logical Log 58 Complete, timestamp: 0x9968ee.
12:06:59 Logical Log 59 Complete, timestamp: 0x9cb08e.
12:07:06 Logical Log 60 Complete, timestamp: 0xa05975.
12:07:13 Logical Log 61 Complete, timestamp: 0xa413d9.
12:07:21 Logical Log 62 Complete, timestamp: 0xa81edf.
12:07:28 Logical Log 63 Complete, timestamp: 0xab874a.
12:07:36 Logical Log 64 Complete, timestamp: 0xaf3295.
12:07:44 Logical Log 65 Complete, timestamp: 0xb300ed.
12:07:52 Logical Log 66 Complete, timestamp: 0xb6e40b.
12:08:00 Logical Log 67 Complete, timestamp: 0xbab834.
12:08:08 Logical Log 68 Complete, timestamp: 0xbe787e.
12:08:15 Logical Log 69 Complete, timestamp: 0xc1fccd.
12:08:22 Logical Log 70 Complete, timestamp: 0xc5c303.
12:08:29 Logical Log 71 Complete, timestamp: 0xc97cd0.
12:08:36 Logical Log 72 Complete, timestamp: 0xcd2c43.
12:08:44 Logical Log 73 Complete, timestamp: 0xd125b2.
12:08:52 Logical Log 74 Complete, timestamp: 0xd503b1.
12:09:00 Checkpoint Completed: duration was 1 seconds.
12:09:00 Wed Dec 2 - loguniq 75, logpos 0x193c164, timestamp: 0xd7a85c
Interval: 162
12:09:00 Maximum server connections 16
12:09:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
Plog used 845, Llog used 222322
12:09:00 Logical Log 75 Complete, timestamp: 0xd83dbc.
12:09:03 Logical Log 76 Complete, timestamp: 0xdcfc73.
12:09:06 Logical Log 77 Complete, timestamp: 0xdfa011.
12:09:11 Logical Log 78 Complete, timestamp: 0xe35a21.
12:09:17 Logical Log 79 Complete, timestamp: 0xe7b091.
12:09:23 Logical Log 80 Complete, timestamp: 0xebfd9b.
12:09:28 Logical Log 81 Complete, timestamp: 0xeed9b5.
12:09:34 Logical Log 82 Complete, timestamp: 0xf28d3d.
12:09:40 Logical Log 83 Complete, timestamp: 0xf6e0e9.
12:09:45 Logical Log 84 Complete, timestamp: 0xfa2924.
12:09:51 Logical Log 85 Complete, timestamp: 0xfe6f02.
12:09:54 Logical Log 86 Complete, timestamp: 0x1011839.
12:09:59 Logical Log 87 Complete, timestamp: 0x10515ee.
12:10:04 Logical Log 88 Complete, timestamp: 0x108fffc.
12:10:09 Logical Log 89 Complete, timestamp: 0x10c4242.
12:10:15 Logical Log 90 Complete, timestamp: 0x1107c30.
12:10:21 Logical Log 91 Complete, timestamp: 0x114d2fe.
12:10:26 Logical Log 92 Complete, timestamp: 0x117cdc7.
12:10:31 Logical Log 93 Complete, timestamp: 0x11b1aa1.
12:10:37 Logical Log 94 Complete, timestamp: 0x11f8043.
12:10:43 Logical Log 95 Complete, timestamp: 0x124199b.
12:10:47 Logical Log 96 Complete, timestamp: 0x1267e0b.
12:10:51 Logical Log 97 Complete, timestamp: 0x12a4ebd.
12:10:56 Logical Log 98 Complete, timestamp: 0x12e3b6e.
12:11:01 Logical Log 99 Complete, timestamp: 0x1322551.
12:11:06 Logical Log 100 Complete, timestamp: 0x1353242.
12:11:12 Logical Log 101 Complete, timestamp: 0x139e427.
12:11:17 Checkpoint Completed: duration was 3 seconds.
12:11:17 Wed Dec 2 - loguniq 102, logpos 0x11e03e8, timestamp: 0x13dbb55
Interval: 163
12:11:17 Maximum server connections 16
12:11:17 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
Plog used 79, Llog used 227035
12:11:18 Logical Log 102 Complete, timestamp: 0x13ecaaa.
12:11:19 Logical Log 103 Complete, timestamp: 0x14064e1.
12:11:25 Logical Log 104 Complete, timestamp: 0x1443ae1.
12:11:30 Logical Log 105 Complete, timestamp: 0x147d5c2.
12:11:35 Logical Log 106 Complete, timestamp: 0x14bb483.
12:11:40 Logical Log 107 Complete, timestamp: 0x14f9fca.
12:11:45 Logical Log 108 Complete, timestamp: 0x1531fec.
12:11:51 Logical Log 109 Complete, timestamp: 0x157b981.
12:11:56 Logical Log 110 Complete, timestamp: 0x15aec37.
12:12:02 Logical Log 111 Complete, timestamp: 0x15f917c.
12:12:07 Logical Log 112 Complete, timestamp: 0x162484e.
12:12:13 Logical Log 113 Complete, timestamp: 0x1668f47.
12:12:18 Logical Log 114 Complete, timestamp: 0x16997af.
12:12:23 Logical Log 115 Complete, timestamp: 0x16d1b79.
12:12:27 Logical Log 116 Complete, timestamp: 0x170bb34.
12:12:32 Logical Log 117 Complete, timestamp: 0x1747ea3.
-----> 12:12:32 Aborting Long Transaction: tx 0x700000060799fd0 username:
ifxcmgt uid: 204
12:12:35 Checkpoint Completed: duration was 2 seconds.
12:12:35 Wed Dec 2 - loguniq 118, logpos 0xd3794, timestamp: 0x176bf6a
Interval: 164
12:12:35 Maximum server connections 16
12:12:35 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 3,
Plog used 60, Llog used 128855
12:12:50 Logical Log 118 Complete, timestamp: 0x184259f.
12:13:14 Logical Log 119 Complete, timestamp: 0x19357bd.
12:13:47 Logical Log 120 Complete, timestamp: 0x1a2569f.
12:14:23 Logical Log 121 Complete, timestamp: 0x1b10f96.
12:14:59 Logical Log 122 Complete, timestamp: 0x1c09e42.
12:15:34 Logical Log 123 Complete, timestamp: 0x1cf5408.
12:16:11 Logical Log 124 Complete, timestamp: 0x1de7ba2.
12:16:48 Logical Log 125 Complete, timestamp: 0x1ee0ab1.
12:17:24 Logical Log 126 Complete, timestamp: 0x1fce87b.
12:18:01 Logical Log 127 Complete, timestamp: 0x20c5ce7.
12:18:36 Logical Log 128 Complete, timestamp: 0x21b35fb.
12:18:47 Checkpoint Completed: duration was 2 seconds.
12:18:47 Wed Dec 2 - loguniq 129, logpos 0x81a1f8, timestamp: 0x21f4fd0
Interval: 165
12:19:07 Logical Log 129 Complete, timestamp: 0x22a8c39.
12:19:43 Logical Log 130 Complete, timestamp: 0x239b3a4.
12:20:19 Logical Log 131 Complete, timestamp: 0x2491af7.
12:20:55 Logical Log 132 Complete, timestamp: 0x257f6bc.
-----> 12:21:21 Long Transaction 0x700000
Clifton, my inputs are as followings:
The transaction by the user "ifxcmgt" spanned 2.2 GB (LTXHWM=70%) out of 3.1
GB total logical log dbspace (~33000 KBx100 or 3.1 GB); therefore, it was
defined as a long transaction and was rolled back.
Transaction rollback and other processes also generate logical-log records and
your instance had about 920 MB left (3.1 GB - 2.2 GB) in logical log space or
about 28 logical logs left.
Based on your onlinelog file, the aborting of this long transaction was done
after using up another 15 more logical logs; therefore, no dynamic log was
added.
Hope this helps.
Kern --
----- Original Message ----
From: Clifton Bean <clifton_bean@hotmail.com>
To: ids@iiug.org
Sent: Wed, December 2, 2009 1:13:12 PM
Subject: Long Transaction Despite DYNAMIC_LOGS = 2 [18245]
IDS 11.50.FC5 AIX 5.3 (4K Page Size)
The following $ONCONFIG parameters were established:
LTXHWM 70 # Long Transaction Low Water Mark
LTXEHWM 80 # Long Transaction High Water Mark
LOGFILES 100 # Number of logical log files
LOGSIZE 33000 # Logical log size (Kbytes)
DYNAMIC_LOGS 2
However, instead of dynamically creating more logical logs to prevent a
longtx, we got the following in the online.log:
12:05:41 Logical Log 48 Complete, timestamp: 0x741c81.
12:05:45 Logical Log 49 Complete, timestamp: 0x7807fd.
12:05:49 Logical Log 50 Complete, timestamp: 0x7b5f00.
12:05:56 Logical Log 51 Complete, timestamp: 0x7ee4e6.
12:06:05 Logical Log 52 Complete, timestamp: 0x8359d7.
12:06:12 Logical Log 53 Complete, timestamp: 0x86575e.
12:06:21 Logical Log 54 Complete, timestamp: 0x8ad1bd.
12:06:29 Logical Log 55 Complete, timestamp: 0x8e92f6.
12:06:37 Logical Log 56 Complete, timestamp: 0x923297.
12:06:45 Logical Log 57 Complete, timestamp: 0x95a621.
12:06:53 Logical Log 58 Complete, timestamp: 0x9968ee.
12:06:59 Logical Log 59 Complete, timestamp: 0x9cb08e.
12:07:06 Logical Log 60 Complete, timestamp: 0xa05975.
12:07:13 Logical Log 61 Complete, timestamp: 0xa413d9.
12:07:21 Logical Log 62 Complete, timestamp: 0xa81edf.
12:07:28 Logical Log 63 Complete, timestamp: 0xab874a.
12:07:36 Logical Log 64 Complete, timestamp: 0xaf3295.
12:07:44 Logical Log 65 Complete, timestamp: 0xb300ed.
12:07:52 Logical Log 66 Complete, timestamp: 0xb6e40b.
12:08:00 Logical Log 67 Complete, timestamp: 0xbab834.
12:08:08 Logical Log 68 Complete, timestamp: 0xbe787e.
12:08:15 Logical Log 69 Complete, timestamp: 0xc1fccd.
12:08:22 Logical Log 70 Complete, timestamp: 0xc5c303.
12:08:29 Logical Log 71 Complete, timestamp: 0xc97cd0.
12:08:36 Logical Log 72 Complete, timestamp: 0xcd2c43.
12:08:44 Logical Log 73 Complete, timestamp: 0xd125b2.
12:08:52 Logical Log 74 Complete, timestamp: 0xd503b1.
12:09:00 Checkpoint Completed: duration was 1 seconds.
12:09:00 Wed Dec 2 - loguniq 75, logpos 0x193c164, timestamp: 0xd7a85c
Interval: 162
12:09:00 Maximum server connections 16
12:09:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
Plog used 845, Llog used 222322
12:09:00 Logical Log 75 Complete, timestamp: 0xd83dbc.
12:09:03 Logical Log 76 Complete, timestamp: 0xdcfc73.
12:09:06 Logical Log 77 Complete, timestamp: 0xdfa011.
12:09:11 Logical Log 78 Complete, timestamp: 0xe35a21.
12:09:17 Logical Log 79 Complete, timestamp: 0xe7b091.
12:09:23 Logical Log 80 Complete, timestamp: 0xebfd9b.
12:09:28 Logical Log 81 Complete, timestamp: 0xeed9b5.
12:09:34 Logical Log 82 Complete, timestamp: 0xf28d3d.
12:09:40 Logical Log 83 Complete, timestamp: 0xf6e0e9.
12:09:45 Logical Log 84 Complete, timestamp: 0xfa2924.
12:09:51 Logical Log 85 Complete, timestamp: 0xfe6f02.
12:09:54 Logical Log 86 Complete, timestamp: 0x1011839.
12:09:59 Logical Log 87 Complete, timestamp: 0x10515ee.
12:10:04 Logical Log 88 Complete, timestamp: 0x108fffc.
12:10:09 Logical Log 89 Complete, timestamp: 0x10c4242.
12:10:15 Logical Log 90 Complete, timestamp: 0x1107c30.
12:10:21 Logical Log 91 Complete, timestamp: 0x114d2fe.
12:10:26 Logical Log 92 Complete, timestamp: 0x117cdc7.
12:10:31 Logical Log 93 Complete, timestamp: 0x11b1aa1.
12:10:37 Logical Log 94 Complete, timestamp: 0x11f8043.
12:10:43 Logical Log 95 Complete, timestamp: 0x124199b.
12:10:47 Logical Log 96 Complete, timestamp: 0x1267e0b.
12:10:51 Logical Log 97 Complete, timestamp: 0x12a4ebd.
12:10:56 Logical Log 98 Complete, timestamp: 0x12e3b6e.
12:11:01 Logical Log 99 Complete, timestamp: 0x1322551.
12:11:06 Logical Log 100 Complete, timestamp: 0x1353242.
12:11:12 Logical Log 101 Complete, timestamp: 0x139e427.
12:11:17 Checkpoint Completed: duration was 3 seconds.
12:11:17 Wed Dec 2 - loguniq 102, logpos 0x11e03e8, timestamp: 0x13dbb55
Interval: 163
12:11:17 Maximum server connections 16
12:11:17 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
Plog used 79, Llog used 227035
12:11:18 Logical Log 102 Complete, timestamp: 0x13ecaaa.
12:11:19 Logical Log 103 Complete, timestamp: 0x14064e1.
12:11:25 Logical Log 104 Complete, timestamp: 0x1443ae1.
12:11:30 Logical Log 105 Complete, timestamp: 0x147d5c2.
12:11:35 Logical Log 106 Complete, timestamp: 0x14bb483.
12:11:40 Logical Log 107 Complete, timestamp: 0x14f9fca.
12:11:45 Logical Log 108 Complete, timestamp: 0x1531fec.
12:11:51 Logical Log 109 Complete, timestamp: 0x157b981.
12:11:56 Logical Log 110 Complete, timestamp: 0x15aec37.
12:12:02 Logical Log 111 Complete, timestamp: 0x15f917c.
12:12:07 Logical Log 112 Complete, timestamp: 0x162484e.
12:12:13 Logical Log 113 Complete, timestamp: 0x1668f47.
12:12:18 Logical Log 114 Complete, timestamp: 0x16997af.
12:12:23 Logical Log 115 Complete, timestamp: 0x16d1b79.
12:12:27 Logical Log 116 Complete, timestamp: 0x170bb34.
12:12:32 Logical Log 117 Complete, timestamp: 0x1747ea3.
-----> 12:12:32 Aborting Long Transaction: tx 0x700000060799fd0 username:
ifxcmgt uid: 204
12:12:35 Checkpoint Completed: duration was 2 seconds.
12:12:35 Wed Dec 2 - loguniq 118, logpos 0xd3794, timestamp: 0x176bf6a
Interval: 164
12:12:35 Maximum server connections 16
12:12:35 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 3,
Plog used 60, Llog used 128855
12:12:50 Logical Log 118 Complete, timestamp: 0x184259f.
12:13:14 Logical Log 119 Complete, timestamp: 0x19357bd.
12:13:47 Logical Log 120 Complete, timestamp: 0x1a2569f.
12:14:23 Logical Log 121 Complete, timestamp: 0x1b10f96.
12:14:59 Logical Log 122 Complete, timestamp: 0x1c09e42.
12:15:34 Logical Log 123 Complete, timestamp: 0x1cf5408.
12:16:11 Logical Log 124 Complete, timestamp: 0x1de7ba2.
12:16:48 Logical Log 125 Complete, timestamp: 0x1ee0ab1.
12:17:24 Logical Log 126 Complete, timestamp: 0x1fce87b.
12:18:01 Logical Log 127 Complete, timestamp: 0x20c5ce7.
12:18:36 Logical Log 128 Complete, timestamp: 0x21b35fb.
12:18:47 Checkpoint Completed: duration was 2 seconds.
12:18:47 Wed Dec 2 - loguniq 129, logpos 0x81a1f8, timestamp: 0x21f4fd0
Interval: 165
12:19:07 Logical Log 129 Complete, timestamp: 0x22a8c39.
12:19:43 Logical Log 130 Complete, timestamp: 0x239b3a4.
12:20:19 Logical Log 131 Complete, timestamp: 0x2491af7.
12:20:55 Logical Log 132 Complete, timestamp: 0x257f6bc.
-----> 12:21:21 Long Transaction 0x7
Thanks for the explanation. I know that. I must have been having a "blonde
hair" day ... gotta remember to not post questions when tired.
Take care.
Clifton
> To: ids@iiug.org
> From: majp51@yahoo.com
> Subject: Re: Long Transaction Despite DYNAMIC_LOGS = 2 [18250]
> Date: Wed, 2 Dec 2009 16:55:39 -0500
>
> Hi Clifton,
>
> I believe you misunderstand the intent of dynamic logs.
> Back in the day , it was possible to fill all your logical logs with a long
> transaction, and hang the instance. The only solution was to contact
technical
> support to basically add enough logical logs so that you could rollback the
> transaction.
>
> DYNAMIC_LOGS was created to eliminate the possibility of a long transaction
> from filling all logs and hanging the instance. DYNAMIC_LOGS does not mean
you
> cannot get a long transaction, as the logs only get added if you run out of
> logs during the rollback of a transaction.
>
> Hope that helps,
>
> Mark
>
> ________________________________
> From: Clifton Bean <clifton_bean@hotmail.com>
> To: ids@iiug.org
> Sent: Wed, December 2, 2009 12:13:12 PM
> Subject: Long Transaction Despite DYNAMIC_LOGS = 2 [18245]
>
> IDS 11.50.FC5 AIX 5.3 (4K Page Size)
>
> The following $ONCONFIG parameters were established:
>
> LTXHWM 70 # Long Transaction Low Water Mark
> LTXEHWM 80 # Long Transaction High Water Mark
>
> LOGFILES 100 # Number of logical log files
> LOGSIZE 33000 # Logical log size (Kbytes)
>
> DYNAMIC_LOGS 2>
> However, instead of dynamically creating more logical logs to prevent a
> longtx, we got the following in the online.log:
>
> 12:05:41 Logical Log 48 Complete, timestamp: 0x741c81.
> 12:05:45 Logical Log 49 Complete, timestamp: 0x7807fd.
> 12:05:49 Logical Log 50 Complete, timestamp: 0x7b5f00.
> 12:05:56 Logical Log 51 Complete, timestamp: 0x7ee4e6.
> 12:06:05 Logical Log 52 Complete, timestamp: 0x8359d7.
> 12:06:12 Logical Log 53 Complete, timestamp: 0x86575e.
> 12:06:21 Logical Log 54 Complete, timestamp: 0x8ad1bd.
> 12:06:29 Logical Log 55 Complete, timestamp: 0x8e92f6.
> 12:06:37 Logical Log 56 Complete, timestamp: 0x923297.
> 12:06:45 Logical Log 57 Complete, timestamp: 0x95a621.
> 12:06:53 Logical Log 58 Complete, timestamp: 0x9968ee.
> 12:06:59 Logical Log 59 Complete, timestamp: 0x9cb08e.
> 12:07:06 Logical Log 60 Complete, timestamp: 0xa05975.
> 12:07:13 Logical Log 61 Complete, timestamp: 0xa413d9.
> 12:07:21 Logical Log 62 Complete, timestamp: 0xa81edf.
> 12:07:28 Logical Log 63 Complete, timestamp: 0xab874a.
> 12:07:36 Logical Log 64 Complete, timestamp: 0xaf3295.
> 12:07:44 Logical Log 65 Complete, timestamp: 0xb300ed.
> 12:07:52 Logical Log 66 Complete, timestamp: 0xb6e40b.
> 12:08:00 Logical Log 67 Complete, timestamp: 0xbab834.
> 12:08:08 Logical Log 68 Complete, timestamp: 0xbe787e.
> 12:08:15 Logical Log 69 Complete, timestamp: 0xc1fccd.
> 12:08:22 Logical Log 70 Complete, timestamp: 0xc5c303.
> 12:08:29 Logical Log 71 Complete, timestamp: 0xc97cd0.
> 12:08:36 Logical Log 72 Complete, timestamp: 0xcd2c43.
> 12:08:44 Logical Log 73 Complete, timestamp: 0xd125b2.
> 12:08:52 Logical Log 74 Complete, timestamp: 0xd503b1.
> 12:09:00 Checkpoint Completed: duration was 1 seconds.
> 12:09:00 Wed Dec 2 - loguniq 75, logpos 0x193c164, timestamp: 0xd7a85c
> Interval: 162
>
> 12:09:00 Maximum server connections 16
> 12:09:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
> Plog used 845, Llog used 222322
>
> 12:09:00 Logical Log 75 Complete, timestamp: 0xd83dbc.
> 12:09:03 Logical Log 76 Complete, timestamp: 0xdcfc73.
> 12:09:06 Logical Log 77 Complete, timestamp: 0xdfa011.
> 12:09:11 Logical Log 78 Complete, timestamp: 0xe35a21.
> 12:09:17 Logical Log 79 Complete, timestamp: 0xe7b091.
> 12:09:23 Logical Log 80 Complete, timestamp: 0xebfd9b.
> 12:09:28 Logical Log 81 Complete, timestamp: 0xeed9b5.
> 12:09:34 Logical Log 82 Complete, timestamp: 0xf28d3d.
> 12:09:40 Logical Log 83 Complete, timestamp: 0xf6e0e9.
> 12:09:45 Logical Log 84 Complete, timestamp: 0xfa2924.
> 12:09:51 Logical Log 85 Complete, timestamp: 0xfe6f02.
> 12:09:54 Logical Log 86 Complete, timestamp: 0x1011839.
> 12:09:59 Logical Log 87 Complete, timestamp: 0x10515ee.
> 12:10:04 Logical Log 88 Complete, timestamp: 0x108fffc.
> 12:10:09 Logical Log 89 Complete, timestamp: 0x10c4242.
> 12:10:15 Logical Log 90 Complete, timestamp: 0x1107c30.
> 12:10:21 Logical Log 91 Complete, timestamp: 0x114d2fe.
> 12:10:26 Logical Log 92 Complete, timestamp: 0x117cdc7.
> 12:10:31 Logical Log 93 Complete, timestamp: 0x11b1aa1.
> 12:10:37 Logical Log 94 Complete, timestamp: 0x11f8043.
> 12:10:43 Logical Log 95 Complete, timestamp: 0x124199b.
> 12:10:47 Logical Log 96 Complete, timestamp: 0x1267e0b.
> 12:10:51 Logical Log 97 Complete, timestamp: 0x12a4ebd.
> 12:10:56 Logical Log 98 Complete, timestamp: 0x12e3b6e.
> 12:11:01 Logical Log 99 Complete, timestamp: 0x1322551.
> 12:11:06 Logical Log 100 Complete, timestamp: 0x1353242.
> 12:11:12 Logical Log 101 Complete, timestamp: 0x139e427.
> 12:11:17 Checkpoint Completed: duration was 3 seconds.
> 12:11:17 Wed Dec 2 - loguniq 102, logpos 0x11e03e8, timestamp: 0x13dbb55
> Interval: 163
>
> 12:11:17 Maximum server connections 16
> 12:11:17 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1,
> Plog used 79, Llog used 227035
>
> 12:11:18 Logical Log 102 Complete, timestamp: 0x13ecaaa.
> 12:11:19 Logical Log 103 Complete, timestamp: 0x14064e1.
> 12:11:25 Logical Log 104 Complete, timestamp: 0x1443ae1.
> 12:11:30 Logical Log 105 Complete, timestamp: 0x147d5c2.
> 12:11:35 Logical Log 106 Complete, timestamp: 0x14bb483.
> 12:11:40 Logical Log 107 Complete, timestamp: 0x14f9fca.
> 12:11:45 Logical Log 108 Complete, timestamp: 0x1531fec.
> 12:11:51 Logical Log 109 Complete, timestamp: 0x157b981.
> 12:11:56 Logical Log 110 Complete, timestamp: 0x15aec37.
> 12:12:02 Logical Log 111 Complete, timestamp: 0x15f917c.
> 12:12:07 Logical Log 112 Complete, timestamp: 0x162484e.
> 12:12:13 Logical Log 113 Complete, timestamp: 0x1668f47.
> 12:12:18 Logical Log 114 Complete, timestamp: 0x16997af.
> 12:12:23 Logical Log 115 Complete, timestamp: 0x16d1b79.
> 12:12:27 Logical Log 116 Complete, timestamp: 0x170bb34.
> 12:12:32 Logical Log 117 Complete, timestamp: 0x1747ea3.
>
> -----> 12:12:32 Aborting Long Transaction: tx 0x700000060799fd0 username:
> ifxcmgt uid: 204
>
> 12:12:35 Checkpoint Completed: duration was 2 seconds.
> 12:12:35 Wed Dec 2 - loguniq 118, logpos 0xd3794, timestamp: 0x176bf6a
> Interval: 164
>
> 12:12:35 Maximum server connections 16
> 12:12:35 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 3,
> Plog used 60, Llog used 128855
>
> 12:12:50 Logical Log 118 Complete, timestamp: 0x184259f.
> 12:13:14 Logical Log 119 Complete, timestamp: 0x19357bd.
> 12:13:47 Logical Log 120 Complete, timestamp: 0x1a2569f.
> 12:14:23 Logical Log 121 Complete, timestamp: 0x1b10f96.
> 12:14:59 Logical Log 122 Complete, timestamp: 0x1c09e42.
> 12:15:34 Logical Log 123 Complete, timestamp: 0x1cf5408.
> 12:16:11 Logical Log 124 Complete, timestamp: 0x1de7ba2.
> 12:16:48 Logical Log 125 Complete, timestamp: 0