Logging region out of memory

Harms Consulting IT support desk support at harmsconsulting.com
Wed Sep 2 19:39:05 EDT 2009


G'day Marc,

Marc Patermann wrote:
> Hi,
>
> I have IMAPd 2.2.12 and BDB 4.2.52:
>
> When I got:
>
> Sep  2 11:28:39 rzhs199 local6:warn|warning lmtpunix[1171642]: DBERROR
> db4: Logging region out of memory; you may need to increase its size
>   

I'm not good for a lot of help in this mailing list, but whenever 
DBERROR appears in the logs, the recommended solution is to change 
database formats away from Berkeley DB. Search this mail list for 
DBERROR and see this page in the wiki for more info:

http://cyrusimap.web.cmu.edu/twiki/bin/view/Cyrus/WhatDatabaseBackend

HTH,
Josh
> Sep  2 11:28:39 rzhs199 local6:err|error lmtpunix[1171642]: DBERROR:
> opening /mail/imap/ptclient/ptscache.db: Not enough space
> Sep  2 11:28:39 rzhs199 local6:err|error lmtpunix[1171642]: DBERROR:
> opening /mail/imap/ptclient/ptscache.db: cyrusdb error
>
> Sep  2 11:28:39 rzhs199 local6:warn|warning lmtpunix[4227234]: DBERROR
> db4: Logging region out of memory; you may need to increase its size
> Sep  2 11:28:39 rzhs199 local6:err|error lmtpunix[4227234]: DBERROR:
> opening /mail/imap/deliver.db: Not enough space
> Sep  2 11:28:39 rzhs199 local6:err|error lmtpunix[4227234]: DBERROR:
> opening /mail/imap/deliver.db: cyrusdb error
> Sep  2 11:28:39 rzhs199 local6:err|error lmtpunix[4227234]: FATAL:
> lmtpd: unable to init duplicate delivery database
>
> Mass mail could not be delivered in time because LMTP had errors.
>
> I found DB_CONFIG in /mail/imap/
>
> :/mail/imap # cat DB_CONFIG
> set_cachesize 0 8388608 8
> set_lg_regionmax 524288
> set_lg_bsize 2097152
>
> and these files
>
> :/mail/imap # l
> 45888 insgesamt
> drwxr-xr-x  12 cyrus    cyrus          4096 02 Sep 12:00 .
> drwxr-xr-x   6 cyrus    cyrus           256 28 Jun 2007  ..
> -rw-------   1 cyrus    cyrus           144 02 Sep 12:03 annotations.db
> drwxrws---   2 cyrus    cyrus          4096 02 Sep 04:14 db
> drwx------   2 cyrus    cyrus           256 02 Sep 11:44 db.backup1
> drwx------   2 cyrus    cyrus           256 02 Sep 11:14 db.backup2
> -rw-r--r--   1 cyrus    cyrus            72 08 Jan 2009  DB_CONFIG
> -rw-------   1 cyrus    cyrus      21336064 02 Sep 12:03 deliver.db
> drwxr-xr-x   2 root     system          256 29 Nov 2007  lost+found
> -rw-------   1 cyrus    cyrus       1106000 02 Sep 12:03 mailboxes.db
> -rw-rw----   1 cyrus    cyrus        689810 02 Sep 11:37 mailboxes.tsm
> -rw-r-----   1 root     system            8 20 Apr 10:45 master.pid
> drwxrws---   2 cyrus    cyrus           256 29 Nov 2007  msg
> drwxrws---   2 cyrus    cyrus        102400 02 Sep 12:04 proc
> drwxrws---   2 cyrus    cyrus           256 20 Apr 10:45 ptclient
> drwxrws---  26 cyrus    cyrus          4096 29 Nov 2007  quota
> drwxrws---   2 cyrus    cyrus           256 20 Apr 10:45 socket
> -rw-------   1 cyrus    cyrus        139264 02 Sep 12:03 tls_sessions.db
> drwx------  26 cyrus    cyrus          4096 30 Nov 2007  user
>
> But the DB_CONFIG setting seemed not to be active.
>
> :/mail/imap # db_stat -m -h db
> 641KB 604B      Total cache size.
> 1       Number of caches.
> 648KB   Pool individual cache size.
> 0       Requested pages mapped into the process' address space.
> 53M     Requested pages found in the cache (96%).
> 2318503 Requested pages not found in the cache.
> 23      Pages created in the cache.
> 2318494 Pages read into the cache.
> 1311629 Pages written from the cache to the backing file.
> 1479063 Clean pages forced from the cache.
> 839315  Dirty pages forced from the cache.
> 0       Dirty pages written by trickle-sync thread.
> 158     Current total page count.
> 89      Current clean page count.
> 69      Current dirty page count.
> 67      Number of hash buckets used for page location.
> 57M     Total number of times hash chains searched for a page.
> 15      The longest hash chain searched for a page.
> 177M    Total number of hash buckets examined for page location.
> 128M    The number of hash bucket locks granted without waiting.
> 1030    The number of hash bucket locks granted after waiting.
> 297     The maximum number of times any hash bucket lock was waited for.
> 12M     The number of region locks granted without waiting.
> 1747    The number of region locks granted after waiting.
> 2318893 The number of page allocations.
> 4713896 The number of hash buckets examined during allocations
> 5       The max number of hash buckets examined for an allocation
> 2318377 The number of pages examined during allocations
> 2       The max number of pages examined for an allocation
> =-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
> Pool File: /mail/imap/ptclient/ptscache.db
> 4096    Page size.
> 0       Requested pages mapped into the process' address space.
> 9465518 Requested pages found in the cache (92%).
> 809878  Requested pages not found in the cache.
> 23      Pages created in the cache.
> 809878  Pages read into the cache.
> 279900  Pages written from the cache to the backing file.
> =-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
> Pool File: /mail/imap/deliver.db
> 4096    Page size.
> 0       Requested pages mapped into the process' address space.
> 41M     Requested pages found in the cache (97%).
> 1443266 Requested pages not found in the cache.
> 0       Pages created in the cache.
> 1443257 Pages read into the cache.
> 957015  Pages written from the cache to the backing file.
> =-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
> Pool File: /mail/imap/tls_sessions.db
> 4096    Page size.
> 0       Requested pages mapped into the process' address space.
> 1780221 Requested pages found in the cache (96%).
> 65359   Requested pages not found in the cache.
> 0       Pages created in the cache.
> 65359   Pages read into the cache.
> 74714   Pages written from the cache to the backing file.
>
> # db_stat -l -h .
> 40988   Log magic number.
> 8       Log version number.
> 32KB    Log record cache size.
> 0644    Log file mode.
> 10Mb    Current log file size.
>          Log bytes written.
>          Log bytes written since last checkpoint.
> 0       Total log file writes.
> 0       Total log file write due to overflow.
> 0       Total log file flushes.
> 1311    Current log file number.
> 2653252 Current log file offset.
> 1311    On-disk log file number.
> 2653252 On-disk log file offset.
> 0       Max commits in a log flush.
> 0       Min commits in a log flush.
> 96KB    Log region size.
> 0       The number of region locks granted after waiting.
> 0       The number of region locks granted without waiting.
>
> I moved DB_CONFIG to db/ made "db_recover -h" and it looked much better.
>
> After that change ptloader (against openLDAP) complained:
>
> Sep  2 13:42:28 rzhs199 local6:debug ptloader[2212060]: accepted connection
> Sep  2 13:42:28 rzhs199 local6:err|error ptloader[2212060]: Unable to 
> set LDAP_OPT_X_SASL_SECPROPS.
> Sep  2 13:42:28 rzhs199 local6:err|error imap[3440844]: ptload(): bad 
> response from ptloader server: ptsmodule_connect() failed
>
> Whereas some user were still be able to log in others don't.
>
> I removed DB_CONFIG from db, did a db_recover again.
> I have the much smaller standard values again active, but the ptloader 
> errors are gone.
>
> Where is the configuration fault?
>
>
> Marc
>
> ----
> Cyrus Home Page: http://cyrusimap.web.cmu.edu/
> Cyrus Wiki/FAQ: http://cyrusimap.web.cmu.edu/twiki
> List Archives/Info: http://asg.web.cmu.edu/cyrus/mailing-list.html
>   


More information about the Info-cyrus mailing list