VERIFIED SOLUTION i
X

Vault error 11815 in e2serverd log

Issue

Render is taking over than 700% machine processor when it formatting documents pages (GIF or PDF). 

Cause

Render is taking over than 700% machine processor when it formatting documents pages (GIF or PDF). 
 
Router Log 
 
10:01:31 <connection4> ERROR 70316: timeout waiting for response from the server 
10:01:31 127.0.0.1:50711 <connection4> timeout waiting for response from the server 
10:01:31 127.0.0.1:52547 <connection4> timeout waiting for response from the server 
10:01:31 127.0.0.1:52547 <connection4> render.transform failed, status [70316] 
10:01:31 127.0.0.1:52777 <connection4> timeout waiting for response from the server 
10:01:31 127.0.0.1:52777 <connection4> render.transform failed, status [70316] 
10:01:31 127.0.0.1:51214 <connection4> timeout waiting for response from the server 
10:01:31 127.0.0.1:52796 <connection4> timeout waiting for response from the server 
10:01:31 127.0.0.1:52796 <connection4> render.transform failed, status [70316] 
 
Render Log 
 
10:01:57 10.128.14.97:51375 <server1> ERROR 71521: request cancelled 
 
 
Server - log 
10:19:44 ERROR 11815: unable to allocate compressed file I/O buffers, requested block size [99999999] 
10:19:44 10.128.14.83:22593 <storage1> ERROR 70110: unable to open the page data file [/coldata_online/pagedata/vivo-sirs_20_20130520-178.drp], error [0] 
10:19:44 10.128.14.83:22593 <storage1> storage.filepage failed, status [70110] 
10:19:44 10.128.14.83:22593 <storage1> storage.docpage failed, status [70110] 
10:19:44 10.128.14.83:22593 <storage1> storage.docpage request, file [vivo-sirs_25_20131024-02522], offset [0000005000089E85], page [1] 
10:19:44 10.128.14.83:22593 <storage1> storage.docarray request, file [vivo-sirs_25_20131024-02522], offset [0000005000089E85] 
10:19:44 10.128.14.83:22593 <storage1> ERROR 70110: unable to open the page data file [/coldata_online/pagedata/vivo-sirs_24_20131024-01988.drp], error [0] 
10:19:44 10.128.14.83:22593 <storage1> storage.filepage failed, status [70110] 
10:19:44 10.128.14.83:22593 <storage1> storage.docpage failed, status [70110] 
10:19:45 10.128.14.83:22593 <storage1> storage.docarray returned data, [24] bytes, elapsed [3] 
10:19:45 10.128.14.83:22593 <storage1> storage.filepage request, file [vivo-sirs_25_20131024-02522], offset [000000500255E098] 
10:19:45 10.128.14.83:22593 <storage1> storage.docpage request, file [vivo-sirs_24_20131024-00198], offset [000000500004BC85], page [2] 
10:19:45 10.128.14.83:22593 <storage1> storage.docarray request, file [vivo-sirs_24_20131024-00198], offset [000000500004BC85] 
10:19:45 10.128.14.83:22593 <storage1> storage.docarray returned data, [120] bytes, cached [189], elapsed [0] 
10:19:45 10.128.14.83:22593 <storage1> storage.filepage request, file [vivo-sirs_24_20131024-00198], offset [00D976E700213558] 
10:19:45 ERROR 11815: unable to allocate compressed file I/O buffers, requested block size [99999999] 
10:19:45 10.128.14.83:22593 <storage1> ERROR 70110: unable to open the page data file [/coldata_online/pagedata/vivo-sirs_25_20131024-02522.drp], error [0] 
10:19:45 10.128.14.83:22593 <storage1> storage.filepage failed, status [70110] 
 
 
 
10:25:05 10.128.14.95:38869 <database1> ERROR 70591: operation cancelled 
10:25:05 10.128.14.95:38869 <database1> database.search returned record, [2] rows, [4] columns, more [0], fixed [0], acquire [0], release [3], elapsed [3] 
10:25:05 10.128.14.95:38869 <server1> ERROR 71521: request cancelled 
10:25:05 10.128.14.95:38869 <database1> ERROR 70591: operation cancelled 
10:25:05 10.128.14.95:38869 <database1> database.resolve failed, status [70591] 
10:25:05 10.128.14.95:38869 <server1> ERROR 71521: request cancelled 
10:25:05 10.128.14.95:38869 <database1> ERROR 70591: operation cancelled 
10:25:05 10.128.14.95:38869 <database1> database.resolve failed, status [70591] 
10:25:05 10.128.14.95:38869 <server1> ERROR 71521: request cancelled 
10:25:05 10.128.14.95:38869 <database1> database.search failed, status [70591] 
10:25:05 10.128.14.95:38869 <server1> ERROR 71521: request cancelled 
10:25:05 10.128.14.95:38869 <database1> ERROR 70591: operation cancelled 
10:25:05 10.128.14.95:38869 <database1> database.search failed, status [70591] 
10:25:05 10.128.14.95:38869 <server1> ERROR 71521: request cancelled 
10:25:05 10.128.14.95:38869 <database1> ERROR 70591: operation cancelled 
10:25:05 10.128.14.95:38869 <database1> database.search failed, status [70591] 
10:25:05 10.128.14.95:38869 <server1> ERROR 71521: request cancelled 
10:25:05 10.128.14.95:38869 <database1> ERROR 70591: operation cancelled 
 

Resolution

UPDATED: September 18, 2017


This line

10:19:44 ERROR 11815: unable to allocate compressed file I/O buffers, requested block size [99999999] 

says that Vault is trying to pre-allocate 100MB of RAM for each document of this type that is viewed on the server.

Vault will quickly run out of available kernel memory with a setting this high.

Their server.ini had
 
[Production]
MaximumPageSize=300000000

Their profiles.ini had:
 
CompressedBlockSize=99999999
DocumentBlockSize=10000000

Unfortunately, if files have been ingested with the  CompressedBlockSize turned up too high, there is no way to correct it after the fact other than.

Using .REMOVE or another approved method for removing the job.

Correct the CompressedBlockSize parameter, setting to a lower more reasonable value

Reingesting the job with the new settings.

To verify the BlockSize for any given DRP file, you can run

fileinfo yourfile.drp, and the BlockSize will be returned.

Downloads

  • No Downloads