Hi Rob:
Doesn’t this look like known SE issue JDK-4724038 and discussed by Peter Levart and Uwe
Schindler on a lucene-dev thread 9/9/2015?
MappedByteBuffer …. what OS are you on Rob? What JVM?
http://bugs.java.com/view_bug.do?bug_id=4724038
http://mail-archives.apache.org/mod_mbox/lucene-dev/201509.mbox/%3C55F0461A.2070005@gmail.com%3E
hth
-will
> On Nov 13, 2015, at 11:23 AM, Rob Audenaerde <rob.audenaerde@gmail.com> wrote:
>
> I'm currently running using NIOFS. It seems to prevent the issue from
> appearing.
>
> This is a second run (with applied deletes etc)
>
> raudenaerd@:/<6>index/index$sudo ls -lSra *.dvd
> -rw-r--r--. 1 apache apache 7993 Nov 13 16:09 _y_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 39048886 Nov 13 17:12 _xod_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 53699972 Nov 13 17:17 _110e_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 112855516 Nov 13 17:19 _12r5_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 151149886 Nov 13 17:13 _y0s_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 222062059 Nov 13 17:17 _z20_Lucene50_0.dvd
>
> raudenaerde:/<6>index/index$sudo ls -lSaa *.dvd
> -rw-r--r--. 1 apache apache 222062059 Nov 13 17:17 _z20_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 151149886 Nov 13 17:13 _y0s_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 112855516 Nov 13 17:19 _12r5_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 53699972 Nov 13 17:17 _110e_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 39048886 Nov 13 17:12 _xod_Lucene50_0.dvd
> -rw-r--r--. 1 apache apache 7993 Nov 13 16:09 _y_Lucene50_0.dvd
>
>
>
> On Thu, Nov 12, 2015 at 3:40 PM, Michael McCandless <
> lucene@mikemccandless.com> wrote:
>
>> Hi Rob,
>>
>> A couple more things:
>>
>> Can you print the value of MMapDirectory.UNMAP_SUPPORTED?
>>
>> Also, can you try your test using NIOFSDirectory instead? Curious if
>> that changes things...
>>
>> Mike McCandless
>>
>> http://blog.mikemccandless.com
>>
>>
>> On Thu, Nov 12, 2015 at 7:28 AM, Rob Audenaerde
>> <rob.audenaerde@gmail.com> wrote:
>>> Curious indeed!
>>>
>>> I will turn on the IndexFileDeleter.VERBOSE_REF_COUNTS and recreate the
>>> logs. Will get back with them in a day hopefully.
>>>
>>> Thanks for the extra logging!
>>>
>>> -Rob
>>>
>>> On Thu, Nov 12, 2015 at 11:34 AM, Michael McCandless <
>>> lucene@mikemccandless.com> wrote:
>>>
>>>> Hmm, curious.
>>>>
>>>> I looked at the [large] infoStream output and I see segment _3ou7
>>>> present on init of IW, a few getReader calls referencing it, then a
>>>> forceMerge that indeed merges it away, yet I do NOT see IW attempting
>>>> deletion of its files.
>>>>
>>>> And indeed I see plenty (too many: many times per second?) of commits
>>>> after that, so the index itself is no longer referencing _3ou7.
>>>>
>>>> If you are failing to close all NRT readers then I would expect _3ou7
>>>> to be in the lsof output, but it's not.
>>>>
>>>> The NRT readers close method has logic that notifies IndexWriter when
>>>> it's done "needing" the files, to emulate "delete on last close"
>>>> semantics for filesystems like HDFS that don't do that ... it's
>>>> possible something is wrong here.
>>>>
>>>> Can you set the (public, static) boolean
>>>> IndexFileDeleter.VERBOSE_REF_COUNTS to true, and then re-generate this
>>>> log? This causes IW to log the ref count of each file it's tracking
>>>> ...
>>>>
>>>> I'll also add a bit more verbosity to IW when NRT readers are opened
>>>> and close, for 5.4.0.
>>>>
>>>> Mike McCandless
>>>>
>>>> http://blog.mikemccandless.com
>>>>
>>>>
>>>> On Wed, Nov 11, 2015 at 6:09 AM, Rob Audenaerde
>>>> <rob.audenaerde@gmail.com> wrote:
>>>>> Hi all,
>>>>>
>>>>> I'm still debugging the growing-index size. I think closing index
>> readers
>>>>> might help (work in progress), but I can't really see them holding on
>> to
>>>>> files (at least, using lsof ). Restarting the application sheds some
>>>> light,
>>>>> I see logging on files that are no longer referenced.
>>>>>
>>>>> What I see is that there are files in the index-directory, that seem
>> to
>>>>> longer referenced..
>>>>>
>>>>> I put the output of the infoStream online, because is it rather big
>> (30MB
>>>>> gzipped): http://www.audenaerde.org/lucene/merges.log.gz
>>>>>
>>>>> Output of lsof: (executed 'sudo lsof *' in the index directory ).
>> This
>>>> is
>>>>> on an CentOS box (maybe that influences stuff as well?)
>>>>>
>>>>> COMMAND PID USER FD TYPE DEVICE SIZE/OFF NODE NAME
>>>>> java 30581 apache mem REG 253,0 3176094924 18880508
>>>>> _4gs5_Lucene50_0.dvd
>>>>> java 30581 apache mem REG 253,0 505758610 18880546 _4gs5.fdt
>>>>> java 30581 apache mem REG 253,0 369563337 18880631
>>>>> _4gs5_Lucene50_0.tim
>>>>> java 30581 apache mem REG 253,0 176344058 18880623
>>>>> _4gs5_Lucene50_0.pos
>>>>> java 30581 apache mem REG 253,0 378055201 18880606
>>>>> _4gs5_Lucene50_0.doc
>>>>> java 30581 apache mem REG 253,0 372579599 18880400
>>>>> _4i5a_Lucene50_0.dvd
>>>>> java 30581 apache mem REG 253,0 82017447 18880748 _4g37.cfs
>>>>> java 30581 apache mem REG 253,0 85376507 18880721 _4fb3.cfs
>>>>> java 30581 apache mem REG 253,0 363493917 18880533
>>>>> _4ct1_Lucene50_0.dvd
>>>>> java 30581 apache mem REG 253,0 9421892 18880806 _4gjc.cfs
>>>>> java 30581 apache mem REG 253,0 76877461 18880553 _4ct1.fdt
>>>>> java 30581 apache mem REG 253,0 46271330 18880661
>>>>> _4ct1_Lucene50_0.tim
>>>>> java 30581 apache mem REG 253,0 26911387 18880653
>>>>> _4ct1_Lucene50_0.pos
>>>>> java 30581 apache mem REG 253,0 54678249 18880568
>>>>> _4ct1_Lucene50_0.doc
>>>>> java 30581 apache mem REG 253,0 76556587 18880328 _4i5a.fdt
>>>>> java 30581 apache mem REG 253,0 45032159 18880389
>>>>> _4i5a_Lucene50_0.tim
>>>>> java 30581 apache mem REG 253,0 26486772 18880388
>>>>> _4i5a_Lucene50_0.pos
>>>>> java 30581 apache mem REG 253,0 55411002 18880362
>>>>> _4i5a_Lucene50_0.doc
>>>>> java 30581 apache mem REG 253,0 70484185 18880340 _4hkn.cfs
>>>>> java 30581 apache mem REG 253,0 10873921 18880324 _4gpz.cfs
>>>>> java 30581 apache mem REG 253,0 17230506 18880524 _4i11.cfs
>>>>> java 30581 apache mem REG 253,0 6706969 18880575 _4i0t.cfs
>>>>> java 30581 apache mem REG 253,0 15135578 18880624 _4i0i.cfs
>>>>> java 30581 apache mem REG 253,0 15368310 18880717 _4hzp.cfs
>>>>> java 30581 apache mem REG 253,0 5146140 18880583 _4hze.cfs
>>>>> java 30581 apache mem REG 253,0 2917380 18880411 _4gs5.nvd
>>>>> java 30581 apache mem REG 253,0 6871469 18880732 _4hod.cfs
>>>>> java 30581 apache mem REG 253,0 2860341 18880495 _4i84.cfs
>>>>> java 30581 apache mem REG 253,0 835726 18880660 _4i7z.cfs
>>>>> java 30581 apache mem REG 253,0 1005595 18880648 _4i7w.cfs
>>>>> java 30581 apache mem REG 253,0 5639672 18880401 _4i4o.cfs
>>>>> java 30581 apache mem REG 253,0 4388371 18880440 _4i4a.cfs
>>>>> java 30581 apache mem REG 253,0 1151845 18880512 _4i7v.cfs
>>>>> java 30581 apache mem REG 253,0 941773 18880613 _4i7x.cfs
>>>>> java 30581 apache mem REG 253,0 984023 18880588 _4i7o.cfs
>>>>> java 30581 apache mem REG 253,0 1790005 18880619 _4i7y.cfs
>>>>> java 30581 apache mem REG 253,0 466371 18880515 _4ct1.nvd
>>>>> java 30581 apache mem REG 253,0 723280 18880573 _4i7q.cfs
>>>>> java 30581 apache mem REG 253,0 806289 18880517 _4i7h.cfs
>>>>> java 30581 apache mem REG 253,0 17362 18880520 _4i9s.cfs
>>>>> java 30581 apache mem REG 253,0 698362 18880531 _4i9r.cfs
>>>>> java 30581 apache mem REG 253,0 483215 18880406 _4i5a.nvd
>>>>> java 30581 apache mem REG 253,0 14110 18880416 _4i9v.cfs
>>>>> java 30581 apache mem REG 253,0 6121 18880412 _4i9t.cfs
>>>>> java 30581 apache 30wW REG 253,0 0 18877901 write.lock
>>>>>
>>>>> Output of some of the biggest files in the index directory:
>>>>>
>>>>> -rw-r--r--. 1 apache apache 358684577 Nov 11 08:04 _4fjn.cfs
>>>>> -rw-r--r--. 1 apache apache 363493917 Nov 11 07:54
>> _4ct1_Lucene50_0.dvd
>>>>> -rw-r--r--. 1 apache apache 369563337 Nov 11 08:06
>> _4gs5_Lucene50_0.tim
>>>>> -rw-r--r--. 1 apache apache 372579599 Nov 11 08:09
>> _4i5a_Lucene50_0.dvd
>>>>> -rw-r--r--. 1 apache apache 378055201 Nov 11 08:06
>> _4gs5_Lucene50_0.doc
>>>>> -rw-r--r--. 1 apache apache 427401813 Nov 10 08:14 _3ou7.cfs
>>>>> -rw-r--r--. 1 apache apache 505758610 Nov 11 08:04 _4gs5.fdt
>>>>> -rw-r--r--. 1 apache apache 1107391579 Nov 10 07:55
>> _3k3a_Lucene50_0.dvd
>>>>> -rw-r--r--. 1 apache apache 3176094924 Nov 11 08:10
>> _4gs5_Lucene50_0.dvd
>>>>>
>>>>> Note that the 3ou7 and 3k3a segments no longer appear to be in use?
>>>>
>>>> ---------------------------------------------------------------------
>>>> To unsubscribe, e-mail: java-user-unsubscribe@lucene.apache.org
>>>> For additional commands, e-mail: java-user-help@lucene.apache.org
>>>>
>>>>
>>
>> ---------------------------------------------------------------------
>> To unsubscribe, e-mail: java-user-unsubscribe@lucene.apache.org
>> For additional commands, e-mail: java-user-help@lucene.apache.org
>>
>>
---------------------------------------------------------------------
To unsubscribe, e-mail: java-user-unsubscribe@lucene.apache.org
For additional commands, e-mail: java-user-help@lucene.apache.org
|