[ 
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

Reply via email to