WARNING in online.log
Posted in 2007
A user on IDS 10.00.UC5 (AIX 5.3) with Enterprise Replication kept seeing online.log warnings that log space was too small for ER (risking DDRBLOCK/replay position wrap) plus "buffer pool too small for read ahead", despite having 30 logical logs of 100MB. Respondents (including Madison Pruet) noted the server was filling a log roughly every 30 seconds, so logs wrapped about every 15 minutes, and transactions were spooling to disk — the warnings were genuine. The advice: the system is under-configured for its workload; add more logical log space and substantially more buffers. No follow-up confirming the result is recorded.
Auto-generated by DrWatson from the posts below — may be imperfect; read the full thread.
Topics: High Availability & Replication, Server Administration, Logging & Checkpoints, Platform-Specific Issues
Hi All,
I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logical Logs of
100 MB each.
#############
# ONCONFIG
#############
# The following parameters are related to the buffer pool
#BUFFERPOOL default,buffers=1000,lrus=8,lru_min_dirty=50,lru_max_dirty=60
BUFFERPOOL
size=4K,buffers=8000,lrus=8,lru_min_dirty=50.000000,lru_max_dirty=60.000000
> onstat -l
IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:34 --546576 Kbytes
Physical Logging
Buffer bufused bufsize numpages numwrits pages/io
P-1 5 8 63118 9137 6.91
phybegin physize phypos phyused %used
1:263 51200 39828 69 0.13
Logical Logging
Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
L-2 0 8 14281455 692904 177238 20.6 3.9
Subsystem numrecs Log Space used
OLDRSAM 14105016 2122952988
SBLOB 171649 344336368
CDR 4790 194620
address number flags uniqid begin size used %used
5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
30 active, 30 total
But still I am receivng following WARNING in online.log. Please advice what
should I do.
06:30:23 Warning - The log space appears to be configured too small
for use with Enterprise Replication (ER). ER may require
additional logical logs to avoid a DDRBLOCK state
and/or replay position log wrap. It is recommended that the
logical log configuration be expanded.
06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
06:32:24 WARNING: Buffer pool size is too small for read ahead operation
06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421 buffers not
flushed.
06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp: 0x224750b
06:32:57 Maximum server connections 23
06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
06:34:44 WARNING: Buffer pool size is too small for read ahead operation
06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
06:35:09 CDR Spool transaction queue completed
Regards,
Navaid Arif
I would try following the advice and add more log space and some more
buffers.
There is a small chance that the Warnings are false but that would mean the
IBM dev guys have a sense of humour :-)
Cheers
Paul
Paul Watson
Tel: +1 913-400-2620
Mob: +1 913-387-7529
Web: www.oninit.com
Failure is not as frightening as regret.
If you want to improve, be content to be thought foolish and stupid.
> -----Original Message-----
> From: ids-bounces@iiug.org [mailto:ids-bounces@iiug.org] On Behalf Of
> Navaid Arif
> Sent: 16 November 2007 19:50
> To: ids@iiug.org
> Subject: WARNING in online.log [10395]
>
> Hi All,
>
> I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logical
> Logs of
> 100 MB each.
>
> #############
> # ONCONFIG
> #############
> # The following parameters are related to the buffer pool
> #BUFFERPOOL
> default,buffers=1000,lrus=8,lru_min_dirty=50,lru_max_dirty=60
> BUFFERPOOL
> size=4K,buffers=8000,lrus=8,lru_min_dirty=50.000000,lru_max_dirty=60.00> 0000
>
> > onstat -l>
> IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:34
> --> 546576 Kbytes
>
> Physical Logging
>
> Buffer bufused bufsize numpages numwrits pages/io
>
> P-1 5 8 63118 9137 6.91
>
> phybegin physize phypos phyused %used
>
> 1:263 51200 39828 69 0.13
>
> Logical Logging
>
> Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
>
> L-2 0 8 14281455 692904 177238 20.6 3.9
>
> Subsystem numrecs Log Space used
>
> OLDRSAM 14105016 2122952988
>
> SBLOB 171649 344336368
>
> CDR 4790 194620
>
> address number flags uniqid begin size used %used
>
> 5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
>
> 5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
>
> 5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
>
> 5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
>
> 5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
>
> 5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
>
> 5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
>
> 5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
>
> 5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
>
> 5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
>
> 5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
>
> 5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
>
> 5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
>
> 5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
>
> 5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
>
> 5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
>
> 5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
>
> 5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
>
> 5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
>
> 5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
>
> 5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
>
> 5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
>
> 5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
>
> 5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
>
> 5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
>
> 5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
>
> 5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
>
> 5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
>
> 5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
>
> 5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
>
> 30 active, 30 total
> But still I am receivng following WARNING in online.log. Please advice
> what
> should I do.
>
> 06:30:23 Warning - The log space appears to be configured too small
>
> for use with Enterprise Replication (ER). ER may require
>
> additional logical logs to avoid a DDRBLOCK state
>
> and/or replay position log wrap. It is recommended that the
>
> logical log configuration be expanded.
>
> 06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
>
> 06:32:24 WARNING: Buffer pool size is too small for read ahead
> operation
>
> 06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
>
> 06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421
> buffers not
> flushed.
>
> 06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp:
> 0x224750b
>
> 06:32:57 Maximum server connections 23
>
> 06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
>
> 06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
>
> 06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
>
> 06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
>
> 06:34:44 WARNING: Buffer pool size is too small for read ahead
> operation
>
> 06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
>
> 06:35:09 CDR Spool transaction queue completed
>
> Regards,
> Navaid Arif
>
>
> ***********************************************************************
> ********
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
> No virus found in this incoming message.
> Checked by AVG Free Edition.
> Version: 7.5.503 / Virus Database: 269.15.33/1132 - Release Date:
> 15/11/2007 09:34
>
No virus found in this outgoing message.
Checked by AVG Free Edition.
Version: 7.5.503 / Virus Database: 269.15.33/1132 - Release Date: 15/11/2007
09:34
With the current logs that you have, can you sustain an outage or batch
process long enough before the logs wrap around to the first log in the unit
of work or when the outage began?
If you overlap your logs before the data is migrated to the other site(s),
then you may lose data or you may not have enough logs.
You use to have to have a send and receive queue dbspaces large enough for the
same reasons as above.
We haven't used ER in a while, so I wait to hear from the more experienced.
Thanks,
**************************************
Ernie Knox
Sears Holding Co.
IT Database Administrator Specialist
IT Service Management, Strategy & Architecture
3333 Beverly Rd., B4-266A
Hoffman Estates, IL. 60179
Office: (847) 286-5735
Fax: (847) 645-3874
Pager: (800) 759-8352 Pin#: 7271042
Email: eknox@sears.com
" It's always a great day to watch Football ! "
**************************************
-----Original Message-----
From: ids-bounces@iiug.org [mailto:ids-bounces@iiug.org] On Behalf Of Paul
Watson
Sent: Friday, November 16, 2007 9:25 PM
To: ids@iiug.org
Subject: RE: WARNING in online.log [10396]
I would try following the advice and add more log space and some more
buffers.
There is a small chance that the Warnings are false but that would mean the
IBM dev guys have a sense of humour :-)
Cheers
Paul
Paul Watson
Tel: +1 913-400-2620
Mob: +1 913-387-7529
Web: www.oninit.com
Failure is not as frightening as regret.
If you want to improve, be content to be thought foolish and stupid.
> -----Original Message-----
> From: ids-bounces@iiug.org [mailto:ids-bounces@iiug.org] On Behalf Of
> Navaid Arif
> Sent: 16 November 2007 19:50
> To: ids@iiug.org
> Subject: WARNING in online.log [10395]
>
> Hi All,
>
> I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logical
> Logs of
> 100 MB each.
>
> #############
> # ONCONFIG
> #############
> # The following parameters are related to the buffer pool
> #BUFFERPOOL
> default,buffers=1000,lrus=8,lru_min_dirty=50,lru_max_dirty=60
> BUFFERPOOL
> size=4K,buffers=8000,lrus=8,lru_min_dirty=50.000000,lru_max_dirty=60.00> 0000
>
> > onstat -l>
> IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:34
> --> 546576 Kbytes
>
> Physical Logging
>
> Buffer bufused bufsize numpages numwrits pages/io
>
> P-1 5 8 63118 9137 6.91
>
> phybegin physize phypos phyused %used
>
> 1:263 51200 39828 69 0.13
>
> Logical Logging
>
> Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
>
> L-2 0 8 14281455 692904 177238 20.6 3.9
>
> Subsystem numrecs Log Space used
>
> OLDRSAM 14105016 2122952988
>
> SBLOB 171649 344336368
>
> CDR 4790 194620
>
> address number flags uniqid begin size used %used
>
> 5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
>
> 5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
>
> 5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
>
> 5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
>
> 5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
>
> 5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
>
> 5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
>
> 5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
>
> 5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
>
> 5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
>
> 5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
>
> 5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
>
> 5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
>
> 5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
>
> 5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
>
> 5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
>
> 5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
>
> 5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
>
> 5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
>
> 5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
>
> 5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
>
> 5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
>
> 5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
>
> 5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
>
> 5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
>
> 5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
>
> 5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
>
> 5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
>
> 5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
>
> 5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
>
> 30 active, 30 total
> But still I am receivng following WARNING in online.log. Please advice
> what
> should I do.
>
> 06:30:23 Warning - The log space appears to be configured too small
>
> for use with Enterprise Replication (ER). ER may require
>
> additional logical logs to avoid a DDRBLOCK state
>
> and/or replay position log wrap. It is recommended that the
>
> logical log configuration be expanded.
>
> 06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
>
> 06:32:24 WARNING: Buffer pool size is too small for read ahead
> operation
>
> 06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
>
> 06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421
> buffers not
> flushed.
>
> 06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp:
> 0x224750b
>
> 06:32:57 Maximum server connections 23
>
> 06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
>
> 06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
>
> 06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
>
> 06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
>
> 06:34:44 WARNING: Buffer pool size is too small for read ahead
> operation
>
> 06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
>
> 06:35:09 CDR Spool transaction queue completed
>
> Regards,
> Navaid Arif
>
>
> ***********************************************************************
> ********
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
> No virus found in this incoming message.
> Checked by AVG Free Edition.
> Version: 7.5.503 / Virus Database: 269.15.33/1132 - Release Date:
> 15/11/2007 09:34
>
No virus found in this outgoing message.
Checked by AVG Free Edition.
Version: 7.5.503 / Virus Database: 269.15.33/1132 - Release Date: 15/11/2007
09:34
*******************************************************************************
Forum Note: Use "Reply" to post a response in the discussion forum.
You're going through the logs at the rate of one log file every 30 seco=
nds.
Given that you have 30 log files, that means that it would be expected =
that
you will have a log wrap about every 15 minutes. Also since it appears=
that you are having to spool transactions to disk, then it appears that=
the
message is probably correct and the system is underconfigured for the
workload it is performing.
M.P.
=
"Navaid Arif" =
<navaid.arif@acce =
ss.net.pk> =
To
Sent by: ids@iiug.org =
ids-bounces@iiug. =
cc
org =
Subj=
ect
WARNING in online.log [10395] =
11/16/2007 07:50 =
PM =
=
=
Please respond to =
ids@iiug.org =
=
=
Hi All,
I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logical =
Logs
of
100 MB each.
#############
# ONCONFIG
#############
# The following parameters are related to the buffer pool
#BUFFERPOOL default,buffers=3D1000,lrus=3D8,lru_min_dirty=3D50,lru_max_=
dirty=3D60
BUFFERPOOL
size=3D4K,buffers=3D8000,lrus=3D8,lru_min_dirty=3D50.000000,lru_max_dir=
ty=3D60.000000
> onstat -l
IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:34=
--546576 Kbytes
Physical Logging
Buffer bufused bufsize numpages numwrits pages/io
P-1 5 8 63118 9137 6.91
phybegin physize phypos phyused %used
1:263 51200 39828 69 0.13
Logical Logging
Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
L-2 0 8 14281455 692904 177238 20.6 3.9
Subsystem numrecs Log Space used
OLDRSAM 14105016 2122952988
SBLOB 171649 344336368
CDR 4790 194620
address number flags uniqid begin size used %used
5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
30 active, 30 total
But still I am receivng following WARNING in online.log. Please advice =
what
should I do.
06:30:23 Warning - The log space appears to be configured too small
for use with Enterprise Replication (ER). ER may require
additional logical logs to avoid a DDRBLOCK state
and/or replay position log wrap. It is recommended that the
logical log configuration be expanded.
06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
06:32:24 WARNING: Buffer pool size is too small for read ahead operatio=
n
06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421 buffe=
rs
not
flushed.
06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp: 0x224750=
b
06:32:57 Maximum server connections 23
06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
06:34:44 WARNING: Buffer pool size is too small for read ahead operatio=
n
06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
06:35:09 CDR Spool transaction queue completed
Regards,
Navaid Arif
***********************************************************************=
********
Forum Note: Use "Reply" to post a response in the discussion forum.
=
Hi M.P.,
Please advice what to do to avoid these messages.
Regards,
Navaid Arif
----- Original Message -----
From: "Madison Pruet" <mpruet@us.ibm.com>
To: <ids@iiug.org>
Sent: Saturday, November 17, 2007 9:28 AM
Subject: Re: WARNING in online.log [10398]
> You're going through the logs at the rate of one log file every 30 seco=
> nds.
> Given that you have 30 log files, that means that it would be expected =
> that
> you will have a log wrap about every 15 minutes. Also since it appears=
>
> that you are having to spool transactions to disk, then it appears that=
> the
> message is probably correct and the system is underconfigured for the
> workload it is performing.
>
> M.P.
>
> =
>
> "Navaid Arif" =
>
> <navaid.arif@acce =
>
> ss.net.pk> =
> To
>
> Sent by: ids@iiug.org =
>
> ids-bounces@iiug. =
> cc
>
> org =
>
> Subj=
> ect
>
> WARNING in online.log [10395] =
>
> 11/16/2007 07:50 =
>
> PM =
>
> =
>
> =
>
> Please respond to =
>
> ids@iiug.org =
>
> =
>
> =
>
> Hi All,
>
> I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logical =
> Logs
> of
> 100 MB each.
>
> #############
> # ONCONFIG
> #############
> # The following parameters are related to the buffer pool
> #BUFFERPOOL default,buffers=3D1000,lrus=3D8,lru_min_dirty=3D50,lru_max_=
> dirty=3D60
> BUFFERPOOL
> size=3D4K,buffers=3D8000,lrus=3D8,lru_min_dirty=3D50.000000,lru_max_dir=
> ty=3D60.000000>
>> onstat -l>
> IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:34=
> --> 546576 Kbytes
>
> Physical Logging
>
> Buffer bufused bufsize numpages numwrits pages/io
>
> P-1 5 8 63118 9137 6.91
>
> phybegin physize phypos phyused %used
>
> 1:263 51200 39828 69 0.13
>
> Logical Logging
>
> Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
>
> L-2 0 8 14281455 692904 177238 20.6 3.9
>
> Subsystem numrecs Log Space used
>
> OLDRSAM 14105016 2122952988
>
> SBLOB 171649 344336368
>
> CDR 4790 194620
>
> address number flags uniqid begin size used %used
>
> 5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
>
> 5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
>
> 5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
>
> 5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
>
> 5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
>
> 5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
>
> 5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
>
> 5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
>
> 5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
>
> 5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
>
> 5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
>
> 5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
>
> 5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
>
> 5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
>
> 5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
>
> 5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
>
> 5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
>
> 5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
>
> 5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
>
> 5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
>
> 5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
>
> 5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
>
> 5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
>
> 5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
>
> 5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
>
> 5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
>
> 5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
>
> 5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
>
> 5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
>
> 5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
>
> 30 active, 30 total
> But still I am receivng following WARNING in online.log. Please advice =
> what
>
> should I do.
>
> 06:30:23 Warning - The log space appears to be configured too small
>
> for use with Enterprise Replication (ER). ER may require
>
> additional logical logs to avoid a DDRBLOCK state
>
> and/or replay position log wrap. It is recommended that the
>
> logical log configuration be expanded.
>
> 06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
>
> 06:32:24 WARNING: Buffer pool size is too small for read ahead operatio=
> n
>
> 06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
>
> 06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421 buffe=
> rs
> not
> flushed.
>
> 06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp: 0x224750=
> b
>
> 06:32:57 Maximum server connections 23
>
> 06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
>
> 06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
>
> 06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
>
> 06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
>
> 06:34:44 WARNING: Buffer pool size is too small for read ahead operatio=
> n
>
> 06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
>
> 06:35:09 CDR Spool transaction queue completed
>
> Regards,
> Navaid Arif
>
> ***********************************************************************=
> ********
>
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
> =
>
>
>
*******************************************************************************
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
As Madison stated, add more logical logs and probably far more buffers.
Art S. Kagel
On Nov 19, 2007 4:20 AM, Navaid Arif <navaid.arif@access.net.pk> wrote:
> Hi M.P.,
>
> Please advice what to do to avoid these messages.
>
> Regards,
> Navaid Arif
>
> ----- Original Message -----
> From: "Madison Pruet" <mpruet@us.ibm.com>
> To: <ids@iiug.org>
> Sent: Saturday, November 17, 2007 9:28 AM
> Subject: Re: WARNING in online.log [10398]
>
> > You're going through the logs at the rate of one log file every 30 seco=
> > nds.
> > Given that you have 30 log files, that means that it would be expected =
> > that
> > you will have a log wrap about every 15 minutes. Also since it appears=
> >
> > that you are having to spool transactions to disk, then it appears that=
> > the
> > message is probably correct and the system is underconfigured for the
> > workload it is performing.
> >
> > M.P.
> >
> > =
> >
> > "Navaid Arif" =
> >
> > <navaid.arif@acce =
> >
> > ss.net.pk> =
> > To
> >
> > Sent by: ids@iiug.org =
> >
> > ids-bounces@iiug. =
> > cc
> >
> > org =
> >
> > Subj=
> > ect
> >
> > WARNING in online.log [10395] =
> >
> > 11/16/2007 07:50 =
> >
> > PM =
> >
> > =
> >
> > =
> >
> > Please respond to =
> >
> > ids@iiug.org =
> >
> > =
> >
> > =
> >
> > Hi All,
> >
> > I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logical =
> > Logs
> > of
> > 100 MB each.
> >
> > #############
> > # ONCONFIG
> > #############
> > # The following parameters are related to the buffer pool
> > #BUFFERPOOL default,buffers=3D1000,lrus=3D8,lru_min_dirty=3D50,lru_max_=
> > dirty=3D60
> > BUFFERPOOL
> > size=3D4K,buffers=3D8000,lrus=3D8,lru_min_dirty=3D50.000000,lru_max_dir=
> > ty=3D60.000000> >
> >> onstat -l> >
> > IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:34=
> > --> > 546576 Kbytes
> >
> > Physical Logging
> >
> > Buffer bufused bufsize numpages numwrits pages/io
> >
> > P-1 5 8 63118 9137 6.91
> >
> > phybegin physize phypos phyused %used
> >
> > 1:263 51200 39828 69 0.13
> >
> > Logical Logging
> >
> > Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
> >
> > L-2 0 8 14281455 692904 177238 20.6 3.9
> >
> > Subsystem numrecs Log Space used
> >
> > OLDRSAM 14105016 2122952988
> >
> > SBLOB 171649 344336368
> >
> > CDR 4790 194620
> >
> > address number flags uniqid begin size used %used
> >
> > 5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
> >
> > 5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
> >
> > 5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
> >
> > 5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
> >
> > 5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
> >
> > 5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
> >
> > 5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
> >
> > 5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
> >
> > 5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
> >
> > 5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
> >
> > 5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
> >
> > 5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
> >
> > 5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
> >
> > 5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
> >
> > 5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
> >
> > 5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
> >
> > 5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
> >
> > 5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
> >
> > 5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
> >
> > 5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
> >
> > 5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
> >
> > 5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
> >
> > 5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
> >
> > 5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
> >
> > 5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
> >
> > 5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
> >
> > 5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
> >
> > 5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
> >
> > 5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
> >
> > 5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
> >
> > 30 active, 30 total
> > But still I am receivng following WARNING in online.log. Please advice =
> > what
> >
> > should I do.
> >
> > 06:30:23 Warning - The log space appears to be configured too small
> >
> > for use with Enterprise Replication (ER). ER may require
> >
> > additional logical logs to avoid a DDRBLOCK state
> >
> > and/or replay position log wrap. It is recommended that the
> >
> > logical log configuration be expanded.
> >
> > 06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
> >
> > 06:32:24 WARNING: Buffer pool size is too small for read ahead operatio=
> > n
> >
> > 06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
> >
> > 06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421 buffe=
> > rs
> > not
> > flushed.
> >
> > 06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp: 0x224750=
> > b
> >
> > 06:32:57 Maximum server connections 23
> >
> > 06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
> >
> > 06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
> >
> > 06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
> >
> > 06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
> >
> > 06:34:44 WARNING: Buffer pool size is too small for read ahead operatio=
> > n
> >
> > 06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
> >
> > 06:35:09 CDR Spool transaction queue completed
> >
> > Regards,
> > Navaid Arif
> >
> > ***********************************************************************=
> > ********
> >
> > Forum Note: Use "Reply" to post a response in the discussion forum.
> >
> > =
> >
> >
> >
>
>
*******************************************************************************
> > Forum Note: Use "Reply" to post a response in the discussion forum.
> >
>
>
>
>
*******************************************************************************
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
>
Increase your log files.
=
"Navaid Arif" =
<navaid.arif@acce =
ss.net.pk> =
To
Sent by: ids@iiug.org =
ids-bounces@iiug. =
cc
org =
Subj=
ect
Re: WARNING in online.log [1040=
6]
11/19/2007 03:20 =
AM =
=
=
Please respond to =
ids@iiug.org =
=
=
Hi M.P.,
Please advice what to do to avoid these messages.
Regards,
Navaid Arif
----- Original Message -----
From: "Madison Pruet" <mpruet@us.ibm.com>
To: <ids@iiug.org>
Sent: Saturday, November 17, 2007 9:28 AM
Subject: Re: WARNING in online.log [10398]
> You're going through the logs at the rate of one log file every 30 se=
co=3D
> nds.
> Given that you have 30 log files, that means that it would be expecte=
d =3D
> that
> you will have a log wrap about every 15 minutes. Also since it appear=
s=3D
>
> that you are having to spool transactions to disk, then it appears th=
at=3D
> the
> message is probably correct and the system is underconfigured for the=
> workload it is performing.
>
> M.P.
>
> =3D
>
> "Navaid Arif" =3D
>
> <navaid.arif@acce =3D
>
> ss.net.pk> =3D
> To
>
> Sent by: ids@iiug.org =3D
>
> ids-bounces@iiug. =3D
> cc
>
> org =3D
>
> Subj=3D
> ect
>
> WARNING in online.log [10395] =3D
>
> 11/16/2007 07:50 =3D
>
> PM =3D
>
> =3D
>
> =3D
>
> Please respond to =3D
>
> ids@iiug.org =3D
>
> =3D
>
> =3D
>
> Hi All,
>
> I am using IDS10 UC5 on AIX 5.3 with ER Replication. I have 30 Logica=
l =3D
> Logs
> of
> 100 MB each.
>
> #############
> # ONCONFIG
> #############
> # The following parameters are related to the buffer pool
> #BUFFERPOOL default,buffers=3D3D1000,lrus=3D3D8,lru_min_dirty=3D3D50,=
lru_max_=3D
> dirty=3D3D60
> BUFFERPOOL
> size=3D3D4K,buffers=3D3D8000,lrus=3D3D8,lru_min_dirty=3D3D50.000000,l=
ru_max_dir=3D
> ty=3D3D60.000000>
>> onstat -l>
> IBM Informix Dynamic Server Version 10.00.UC5 -- On-Line -- Up 03:40:=
34=3D
> --> 546576 Kbytes
>
> Physical Logging
>
> Buffer bufused bufsize numpages numwrits pages/io
>
> P-1 5 8 63118 9137 6.91
>
> phybegin physize phypos phyused %used
>
> 1:263 51200 39828 69 0.13
>
> Logical Logging
>
> Buffer bufused bufsize numrecs numpages numwrits recs/pages pages/io
>
> L-2 0 8 14281455 692904 177238 20.6 3.9
>
> Subsystem numrecs Log Space used
>
> OLDRSAM 14105016 2122952988
>
> SBLOB 171649 344336368
>
> CDR 4790 194620
>
> address number flags uniqid begin size used %used
>
> 5023a4b0 101 U-B---- 5071 3:3 25600 25600 100.00
>
> 5023a4f8 102 U-B---- 5072 3:25603 25600 25600 100.00
>
> 5023a540 103 U-B---- 5073 3:51203 25600 25600 100.00
>
> 5023a588 104 U-B---- 5074 3:76803 25600 25600 100.00
>
> 5023a5d0 105 U-B---- 5075 3:102403 25600 25600 100.00
>
> 5023a618 106 U-B---- 5076 3:128003 25600 25600 100.00
>
> 5023a660 107 U-B---- 5077 3:153603 25600 25600 100.00
>
> 5023a6a8 108 U-B---- 5078 3:179203 25600 25600 100.00
>
> 5023a6f0 109 U-B---- 5079 3:204803 25600 25600 100.00
>
> 5023a738 110 U---C-L 5080 3:230403 25600 10194 39.82
>
> 5023a780 1 U-B---- 5051 4:3 25600 25600 100.00
>
> 5023a7c8 2 U-B---- 5052 4:25603 25600 25600 100.00
>
> 5023a810 3 U-B---- 5053 4:51203 25600 25600 100.00
>
> 5023a858 4 U-B---- 5054 4:76803 25600 25600 100.00
>
> 5023a8a0 5 U-B---- 5055 4:102403 25600 25600 100.00
>
> 5023a8e8 6 U-B---- 5056 4:128003 25600 25600 100.00
>
> 5023a930 7 U-B---- 5057 4:153603 25600 25600 100.00
>
> 5023a978 8 U-B---- 5058 4:179203 25600 25600 100.00
>
> 5023a9c0 9 U-B---- 5059 4:204803 25600 25600 100.00
>
> 5023aa08 10 U-B---- 5060 4:230403 25600 25600 100.00
>
> 5023aa50 11 U-B---- 5061 8:3 25600 25600 100.00
>
> 5023aa98 12 U-B---- 5062 8:25603 25600 25600 100.00
>
> 5023aae0 13 U-B---- 5063 8:51203 25600 25600 100.00
>
> 5023ab28 14 U-B---- 5064 8:76803 25600 25600 100.00
>
> 5023ab70 15 U-B---- 5065 8:102403 25600 25600 100.00
>
> 5023abb8 16 U-B---- 5066 8:128003 25600 25600 100.00
>
> 5023ac00 17 U-B---- 5067 8:153603 25600 25600 100.00
>
> 5023ac48 18 U-B---- 5068 8:179203 25600 25600 100.00
>
> 5023ac90 19 U-B---- 5069 8:204803 25600 25600 100.00
>
> 5023acd8 20 U-B---- 5070 8:230403 25600 25600 100.00
>
> 30 active, 30 total
> But still I am receivng following WARNING in online.log. Please advic=
e =3D
> what
>
> should I do.
>
> 06:30:23 Warning - The log space appears to be configured too small
>
> for use with Enterprise Replication (ER). ER may require
>
> additional logical logs to avoid a DDRBLOCK state
>
> and/or replay position log wrap. It is recommended that the
>
> logical log configuration be expanded.
>
> 06:32:18 Logical Log 5069 Complete, timestamp: 0x215d6c4.
>
> 06:32:24 WARNING: Buffer pool size is too small for read ahead operat=
io=3D
> n
>
> 06:32:38 Logical Log 5070 Complete, timestamp: 0x21e19c1.
>
> 06:32:57 Fuzzy Checkpoint Completed: duration was 2 seconds, 3421 buf=
fe=3D
> rs
> not
> flushed.
>
> 06:32:57 Checkpoint loguniq 5071, logpos 0x4b4a7bc, timestamp: 0x2247=
50=3D
> b
>
> 06:32:57 Maximum server connections 23
>
> 06:33:03 Logical Log 5071 Complete, timestamp: 0x226b56a.
>
> 06:33:53 Logical Log 5072 Complete, timestamp: 0x2302172.
>
> 06:34:20 Logical Log 5073 Complete, timestamp: 0x2321f60.
>
> 06:34:37 Logical Log 5074 Complete, timestamp: 0x233f4ba.
>
> 06:34:44 WARNING: Buffer pool size is too small for read ahead operat=
io=3D
> n
>
> 06:34:55 Logical Log 5075 Complete, timestamp: 0x23988fd.
>
> 06:35:09 CDR Spool transaction queue completed
>
> Regards,
> Navaid Arif
>
> *********************************************************************=
**=3D
> ********
>
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
> =3D
>
>
>
***********************************************************************=
********
> Forum Note: Use "Reply" to post a response in the discussion forum.
>
***********************************************************************=
********
Forum Note: Use "Reply" to post a response in the discussion forum.
=
modify the buffers to 30000 . it equal 600M mem, if your mem less than 600M,
then allocate 50% of the mem.
onstat -p monitor the ovbuffer.