[ https://issues.apache.org/jira/browse/SOLR-5652?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13880639#comment-13880639 ]
Steve Rowe commented on SOLR-5652: ---------------------------------- I tried reproducing the other four seeds I found by running each of them ten times, but they all passed. Here's the output of {{egrep 'Throwable|SOLR\-5652: \[\^(]'}} over the other four failed trials' log files: {noformat} 25.log: [junit4] 2> 19647 T10 oasc.DistribCursorPagingTest.doRandomSortsOnLargeIndex SOLR-5652: Begining Loop over smallish num of docs 25.log: [junit4] > Throwable #1: java.lang.AssertionError: ({params(q=*%3A*&fl=id%2Cint_dv_last&rows=50&sort=int_dv_last+desc%2C+id+desc),defaults(cursorMark=AoIGycP9Cl8B)}) walk already seen: 53, don't know why; q=id:53 gives: {responseHeader={status=0,QTime=7},response={numFound=1,start=0,maxScore=4.3672957,docs=[SolrDocument{id=53, long=-1762578138619777716, long_last=-1762578138619777716, long_first=-1762578138619777716, long_dv_last=-1762578138619777716, long_dv_first=-1762578138619777716, float=7.8670176E8, float_last=7.8670176E8, float_first=7.8670176E8, float_dv_last=7.8670176E8, float_dv_first=7.8670176E8, double=-5.708345229626098E8, double_last=-5.708345229626098E8, double_first=-5.708345229626098E8, double_dv_last=-5.708345229626098E8, double_dv_first=-5.708345229626098E8, str=さおれん, str_last=さおれん, str_first=さおれん, str_dv_last=さおれん, str_dv_first=さおれん, bin=O69Ees9vzo65vMxdlD794IAfqQgcvHEy+6USZ9bEELcM4PnS, bin_last=O69Ees9vzo65vMxdlD794IAfqQgcvHEy+6USZ9bEELcM4PnS, bin_first=O69Ees9vzo65vMxdlD794IAfqQgcvHEy+6USZ9bEELcM4PnS, bin_dv_last=O69Ees9vzo65vMxdlD794IAfqQgcvHEy+6USZ9bEELcM4PnS, bin_dv_first=O69Ees9vzo65vMxdlD794IAfqQgcvHEy+6USZ9bEELcM4PnS, _version_=1457993135883812864}]}} 330.log: [junit4] 2> 19366 T10 oasc.DistribCursorPagingTest.doRandomSortsOnLargeIndex SOLR-5652: Begining Loop over smallish num of docs 330.log: [junit4] > Throwable #1: java.lang.AssertionError: ({params(q=*%3A*&fl=id%2Cdouble_dv_first&rows=33&sort=double_dv_first+desc%2C+id+desc),defaults(cursorMark=AoIFP6OxOxOxOxRRAQ%3D%3D)}) walk already seen: 53, don't know why; q=id:53 gives: {responseHeader={status=0,QTime=6},response={numFound=1,start=0,maxScore=4.5409594,docs=[SolrDocument{id=53, int=1280166143, int_last=1280166143, int_first=1280166143, int_dv_last=1280166143, int_dv_first=1280166143, long=-9052102457621824595, long_last=-9052102457621824595, long_first=-9052102457621824595, long_dv_last=-9052102457621824595, long_dv_first=-9052102457621824595, float=3.0276464E8, float_last=3.0276464E8, float_first=3.0276464E8, float_dv_last=3.0276464E8, float_dv_first=3.0276464E8, str=⟉⟑, str_last=⟉⟑, str_first=⟉⟑, str_dv_last=⟉⟑, str_dv_first=⟉⟑, bin=rS4=, bin_last=rS4=, bin_first=rS4=, bin_dv_last=rS4=, bin_dv_first=rS4=, _version_=1458022773190295552}]}} 358.log: [junit4] 2> 20392 T10 oasc.DistribCursorPagingTest.doRandomSortsOnLargeIndex SOLR-5652: Begining Loop over smallish num of docs 358.log: [junit4] > Throwable #1: java.lang.AssertionError: ({params(q=*%3A*&fl=id%2Cdouble_dv_last&rows=26&sort=double_dv_last+asc%2C+id+asc),defaults(cursorMark=AoIFQcxu1GR52DdbBQ%3D%3D)}) walk already seen: 53, don't know why; q=id:53 gives: {responseHeader={status=0,QTime=6},response={numFound=1,start=0,maxScore=4.713572,docs=[SolrDocument{id=53, int=326151412, int_last=326151412, int_first=326151412, int_dv_last=326151412, int_dv_first=326151412, long=2982275399264847435, long_last=2982275399264847435, long_first=2982275399264847435, long_dv_last=2982275399264847435, long_dv_first=2982275399264847435, float=-4.07416768E8, float_last=-4.07416768E8, float_first=-4.07416768E8, float_dv_last=-4.07416768E8, float_dv_first=-4.07416768E8, str=s, str_last=s, str_first=s, str_dv_last=s, str_dv_first=s, bin=XR3Lrq5HZ64ra30SYdaN4EkoTS0jNYojEq+1McIN6T4QD136dLnbj4v/fp1VK+lN, bin_last=XR3Lrq5HZ64ra30SYdaN4EkoTS0jNYojEq+1McIN6T4QD136dLnbj4v/fp1VK+lN, bin_first=XR3Lrq5HZ64ra30SYdaN4EkoTS0jNYojEq+1McIN6T4QD136dLnbj4v/fp1VK+lN, bin_dv_last=XR3Lrq5HZ64ra30SYdaN4EkoTS0jNYojEq+1McIN6T4QD136dLnbj4v/fp1VK+lN, bin_dv_first=XR3Lrq5HZ64ra30SYdaN4EkoTS0jNYojEq+1McIN6T4QD136dLnbj4v/fp1VK+lN, _version_=1458025403210792960}]}} 372.log: [junit4] 2> 20889 T10 oasc.DistribCursorPagingTest.doRandomSortsOnLargeIndex SOLR-5652: Begining Loop over smallish num of docs 372.log: [junit4] > Throwable #1: java.lang.AssertionError: ({params(q=*%3A*&fl=id%2Cstr_dv_last&rows=18&sort=str_dv_last+desc%2C+id+desc),defaults(cursorMark=AoIgSg%3D%3D)}) walk already seen: 45, don't know why; q=id:45 gives: {responseHeader={status=0,QTime=10},response={numFound=1,start=0,maxScore=4.8394523,docs=[SolrDocument{id=45, int=55600073, int_last=55600073, int_first=55600073, int_dv_last=55600073, int_dv_first=55600073, long=-5726302924934473981, long_last=-5726302924934473981, long_first=-5726302924934473981, long_dv_last=-5726302924934473981, long_dv_first=-5726302924934473981, float=4.3000288E8, float_last=4.3000288E8, float_first=4.3000288E8, float_dv_last=4.3000288E8, float_dv_first=4.3000288E8, double=-6.3097894268989615E7, double_last=-6.3097894268989615E7, double_first=-6.3097894268989615E7, double_dv_last=-6.3097894268989615E7, double_dv_first=-6.3097894268989615E7, bin=TMQSu87+U6mLrws1ot/s491jlIrAp1SdDMSIc/wF8H7JW8Uvk9/Z216erOE8JFucgFQ=, bin_last=TMQSu87+U6mLrws1ot/s491jlIrAp1SdDMSIc/wF8H7JW8Uvk9/Z216erOE8JFucgFQ=, bin_first=TMQSu87+U6mLrws1ot/s491jlIrAp1SdDMSIc/wF8H7JW8Uvk9/Z216erOE8JFucgFQ=, bin_dv_last=TMQSu87+U6mLrws1ot/s491jlIrAp1SdDMSIc/wF8H7JW8Uvk9/Z216erOE8JFucgFQ=, bin_dv_first=TMQSu87+U6mLrws1ot/s491jlIrAp1SdDMSIc/wF8H7JW8Uvk9/Z216erOE8JFucgFQ=, _version_=1458026742612492288}]}} {noformat} The trial #358 failure has sort=double_dv_last+*asc* bq. One thing that jumps out at me here is that in this failure the doc in question (93) doesn't have a value for the int_dv_last field being sorted on This is also true for all of the above failures, and for the failure in the attached {{129.log}}. > Heisenbug in DistribCursorPagingTest: "walk already seen ..." > ------------------------------------------------------------- > > Key: SOLR-5652 > URL: https://issues.apache.org/jira/browse/SOLR-5652 > Project: Solr > Issue Type: Bug > Reporter: Hoss Man > Assignee: Hoss Man > Attachments: 129.log, > jenkins.thetaphi.de_Lucene-Solr-4.x-MacOSX_1200.log.txt, > jenkins.thetaphi.de_Lucene-Solr-4.x-MacOSX_1217.log.txt > > > Twice now, Uwe's jenkins has encountered a "walk already seen ..." assertion > failure from DistribCursorPagingTest that I've been unable to fathom, let > alone reproduce (although sarowe was able to trigger a similar, > non-reproducible seed, failure on his machine) > Using this as a tracking issue to try and make sense of it. > Summary of things noticed so far (in 3 failures): > * So far only seen on http://jenkins.thetaphi.de & sarowe's mac > * So far only seen on MacOSX > * So far only seen on branch 4x > * So far seen on both Java6 and Java7 > * fails occured in first block of randomized testing: > ** we've indexed a small number of randomized docs > ** we're explicitly looping over every field and sorting in both directions > * fails were both when doing a "desc" sorting on one of the "\*_dv_last" or > "\*_dv_first" fields (docValues=true, either sortMissingLast=true OR > sortMissingFirst=true) > ** sort on same field asc has always worked fine just before this (fields are > in arbitrary order, but "asc" always tried before "desc") > ** sorting on some other random fields has sometimes been tried before this > and worked > (specifics of each failure seen in the wild recorded in comments) -- This message was sent by Atlassian JIRA (v6.1.5#6160) --------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org