I have seen this with very few indexed documents and multiple shards.
In such a case, some shards may not have any documents, and when the query
happens to hit such a shard, it does not find the fields it's looking for
and turns this into "column not found". If you resubmit the query and hit
a different shards (with docs), the query will succeed.

On 6/14/2017 11:42 AM, Susheel Kumar wrote:
> Yes, Joel.  Kind of every other command runs into this issue. I just
> executed below queries and 3 of them failed while 1 succeeded.   I just
> have 6 documents ingested and no further indexing going on.  Let me know
> what else to look for the state of index.
> 
> 
> ➜  solr-6.6.0 curl --data-urlencode 'stmt=SELECT  sr_sv_userFirstName as
> firstName, sr_sv_userLastName as lastName FROM collection1 ORDEr BY
> dv_sv_userLastName LIMIT 15'
> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
> 
> 
> {"result-set":{"docs":[{"EXCEPTION":"Failed to execute sqlQuery 'SELECT
>  sr_sv_userFirstName as firstName, sr_sv_userLastName as lastName FROM
> collection1 ORDEr BY dv_sv_userLastName LIMIT 15' against JDBC connection
> 'jdbc:calcitesolr:'.\nError while executing SQL \"SELECT
>  sr_sv_userFirstName as firstName, sr_sv_userLastName as lastName FROM
> collection1 ORDEr BY dv_sv_userLastName LIMIT 15\": From line 1, column 9
> to line 1, column 27: Column 'sr_sv_userFirstName' not found in any
> table","EOF":true,"RESPONSE_TIME":85}]}}
> 
> 
> ➜  solr-6.6.0 curl --data-urlencode 'stmt=SELECT  sr_sv_userFirstName as
> firstName, sr_sv_userLastName as lastName FROM collection1 ORDEr BY
> dv_sv_userLastName LIMIT 15'
> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
> 
> 
> {"result-set":{"docs":[{"firstName":"Thiago","lastName":"Diego"},{"firstName":"John","lastName":"Jagger"},{"firstName":"John","lastName":"Jagger"},{"firstName":"John","lastName":"Johny"},{"firstName":"Isabel","lastName":"Margret"},{"firstName":"Isabel","lastName":"Margret"},{"EOF":true,"RESPONSE_TIME":241}]}}
> 
> 
> ➜  solr-6.6.0 curl --data-urlencode 'stmt=SELECT  sr_sv_userFirstName as
> firstName, sr_sv_userLastName as lastName FROM collection1 ORDEr BY
> dv_sv_userLastName LIMIT 15'
> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
> 
> 
> 
> {"result-set":{"docs":[{"EXCEPTION":"Failed to execute sqlQuery 'SELECT
>  sr_sv_userFirstName as firstName, sr_sv_userLastName as lastName FROM
> collection1 ORDEr BY dv_sv_userLastName LIMIT 15' against JDBC connection
> 'jdbc:calcitesolr:'.\nError while executing SQL \"SELECT
>  sr_sv_userFirstName as firstName, sr_sv_userLastName as lastName FROM
> collection1 ORDEr BY dv_sv_userLastName LIMIT 15\": From line 1, column 9
> to line 1, column 27: Column 'sr_sv_userFirstName' not found in any
> table","EOF":true,"RESPONSE_TIME":87}]}}
> 
> On Wed, Jun 14, 2017 at 11:18 AM, Joel Bernstein <joels...@gmail.com> wrote:
> 
>> Are you able to reproduce the error, or is it just appearing in the logs?
>>
>> Do you know the state of index when it's occurring?
>>
>> Joel Bernstein
>> http://joelsolr.blogspot.com/
>>
>> On Wed, Jun 14, 2017 at 11:09 AM, Susheel Kumar <susheel2...@gmail.com>
>> wrote:
>>
>>> I have setup Solr-6.6-0 on local (local ZK and Solr) and then on servers
>> (3
>>> ZK and 2 machines, 2 shards) and on both the env,  i see this
>> intermittent
>>> error "column not found". The same query works sometime and other time
>>> fails.
>>>
>>> Is that a bug or am I missing something...
>>>
>>>
>>> Console
>>> ===
>>>
>>> -> solr-6.6.0 curl --data-urlencode 'stmt=SELECT  dv_sv_userFirstName as
>>> firstName, dv_sv_userLastName as lastName FROM collection1 ORDEr BY
>>> dv_sv_userLastName LIMIT 15'
>>> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
>>>
>>> {"result-set":{"docs":[{"EXCEPTION":"Failed to execute sqlQuery 'SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15' against JDBC connection
>>> 'jdbc:calcitesolr:'.\nError while executing SQL \"SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15\": From line 1, column 9
>>> to line 1, column 27: Column 'dv_sv_userFirstName' not found in any
>>> table","EOF":true,"RESPONSE_TIME":78}]}}
>>>
>>> ➜  solr-6.6.0 curl --data-urlencode 'stmt=SELECT  dv_sv_userFirstName as
>>> firstName, dv_sv_userLastName as lastName FROM collection1 ORDEr BY
>>> dv_sv_userLastName LIMIT 15'
>>> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
>>>
>>> {"result-set":{"docs":[{"EXCEPTION":"Failed to execute sqlQuery 'SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15' against JDBC connection
>>> 'jdbc:calcitesolr:'.\nError while executing SQL \"SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15\": From line 1, column 9
>>> to line 1, column 27: Column 'dv_sv_userFirstName' not found in any
>>> table","EOF":true,"RESPONSE_TIME":92}]}}
>>>
>>> ➜  solr-6.6.0 curl --data-urlencode 'stmt=SELECT  dv_sv_userFirstName as
>>> firstName, dv_sv_userLastName as lastName FROM collection1 ORDEr BY
>>> dv_sv_userLastName LIMIT 15'
>>> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
>>>
>>> {"result-set":{"docs":[{"firstName":"Thiago","lastName"
>>> :"Diego"},{"firstName":"John","lastName":"Jagger"},{"
>>> firstName":"John","lastName":"Jagger"},{"firstName":"John","
>>> lastName":"Johny"},{"firstName":"Isabel","lastName"
>>> :"Margret"},{"firstName":"Isabel","lastName":"Margret"},
>>> {"EOF":true,"RESPONSE_TIME":191}]}}
>>>
>>> ➜  solr-6.6.0 curl --data-urlencode 'stmt=SELECT  dv_sv_userFirstName as
>>> firstName, dv_sv_userLastName as lastName FROM collection1 ORDEr BY
>>> dv_sv_userLastName LIMIT 15'
>>> http://server17:8984/solr/collection1/sql\?aggregationMode\=facet
>>>
>>> {"result-set":{"docs":[{"EXCEPTION":"Failed to execute sqlQuery 'SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15' against JDBC connection
>>> 'jdbc:calcitesolr:'.\nError while executing SQL \"SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15\": From line 1, column 9
>>> to line 1, column 27: Column 'dv_sv_userFirstName' not found in any
>>> table","EOF":true,"RESPONSE_TIME":83}]}}
>>>
>>> ➜  solr-6.6.0
>>>
>>>
>>> solr.log entry
>>> ===
>>>
>>> 2017-06-14 14:57:29.624 ERROR (qtp834133664-17) [c:collection1 s:shard1
>>> r:core_node1 x:collection1_shard1_replica1] o.a.c.r.CalciteException
>>> org.apache.calcite.sql.validate.SqlValidatorException: Column
>>> 'dv_sv_userFirstName' not found in any table
>>> 2017-06-14 14:57:29.625 ERROR (qtp834133664-17) [c:collection1 s:shard1
>>> r:core_node1 x:collection1_shard1_replica1] o.a.c.r.CalciteException
>>> org.apache.calcite.runtime.CalciteContextException: From line 1, column
>> 9
>>> to line 1, column 27: Column 'dv_sv_userFirstName' not found in any table
>>> 2017-06-14 14:57:29.628 ERROR (qtp834133664-17) [c:collection1 s:shard1
>>> r:core_node1 x:collection1_shard1_replica1] o.a.s.c.s.i.s.ExceptionStream
>>> java.io.IOException: Failed to execute sqlQuery 'SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15' against JDBC connection
>>> 'jdbc:calcitesolr:'.
>>> Error while executing SQL "SELECT  dv_sv_userFirstName as firstName,
>>> dv_sv_userLastName as lastName FROM collection1 ORDEr BY
>> dv_sv_userLastName
>>> LIMIT 15": From line 1, column 9 to line 1, column 27: Column
>>> 'dv_sv_userFirstName' not found in any table
>>>         at
>>> org.apache.solr.client.solrj.io.stream.JDBCStream.open(
>>> JDBCStream.java:216)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.ExceptionStream.
>>> open(ExceptionStream.java:51)
>>>         at
>>> org.apache.solr.handler.StreamHandler$TimerStream.
>>> open(StreamHandler.java:535)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.TupleStream.
>>> writeMap(TupleStream.java:78)
>>>         at
>>> org.apache.solr.response.JSONWriter.writeMap(
>> JSONResponseWriter.java:547)
>>>         at
>>> org.apache.solr.response.TextResponseWriter.writeVal(
>>> TextResponseWriter.java:193)
>>>         at
>>> org.apache.solr.response.JSONWriter.writeNamedListAsMapWithDups(
>>> JSONResponseWriter.java:209)
>>>         at
>>> org.apache.solr.response.JSONWriter.writeNamedList(
>>> JSONResponseWriter.java:325)
>>>         at
>>> org.apache.solr.response.JSONWriter.writeResponse(
>>> JSONResponseWriter.java:120)
>>>         at
>>> org.apache.solr.response.JSONResponseWriter.write(
>>> JSONResponseWriter.java:71)
>>>         at
>>> org.apache.solr.response.QueryResponseWriterUtil.writeQueryResponse(
>>> QueryResponseWriterUtil.java:65)
>>>         at
>>> org.apache.solr.servlet.HttpSolrCall.writeResponse(
>> HttpSolrCall.java:809)
>>>         at org.apache.solr.servlet.HttpSolrCall.call(
>>> HttpSolrCall.java:538)
>>>         at
>>> org.apache.solr.servlet.SolrDispatchFilter.doFilter(
>>> SolrDispatchFilter.java:361)
>>>         at
>>> org.apache.solr.servlet.SolrDispatchFilter.doFilter(
>>> SolrDispatchFilter.java:305)
>>>         at
>>> org.eclipse.jetty.servlet.ServletHandler$CachedChain.
>>> doFilter(ServletHandler.java:1691)
>>>         at
>>> org.eclipse.jetty.servlet.ServletHandler.doHandle(
>> ServletHandler.java:582)
>>>         at
>>> org.eclipse.jetty.server.handler.ScopedHandler.handle(
>>> ScopedHandler.java:143)
>>>         at
>>> org.eclipse.jetty.security.SecurityHandler.handle(
>>> SecurityHandler.java:548)
>>>         at
>>> org.eclipse.jetty.server.session.SessionHandler.
>>> doHandle(SessionHandler.java:226)
>>>         at
>>> org.eclipse.jetty.server.handler.ContextHandler.
>>> doHandle(ContextHandler.java:1180)
>>>         at
>>> org.eclipse.jetty.servlet.ServletHandler.doScope(
>> ServletHandler.java:512)
>>>         at
>>> org.eclipse.jetty.server.session.SessionHandler.
>>> doScope(SessionHandler.java:185)
>>>         at
>>> org.eclipse.jetty.server.handler.ContextHandler.
>>> doScope(ContextHandler.java:1112)
>>>         at
>>> org.eclipse.jetty.server.handler.ScopedHandler.handle(
>>> ScopedHandler.java:141)
>>>         at
>>> org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(
>>> ContextHandlerCollection.java:213)
>>>         at
>>> org.eclipse.jetty.server.handler.HandlerCollection.
>>> handle(HandlerCollection.java:119)
>>>         at
>>> org.eclipse.jetty.server.handler.HandlerWrapper.handle(
>>> HandlerWrapper.java:134)
>>>         at
>>> org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(
>>> RewriteHandler.java:335)
>>>         at
>>> org.eclipse.jetty.server.handler.HandlerWrapper.handle(
>>> HandlerWrapper.java:134)
>>>         at org.eclipse.jetty.server.Server.handle(Server.java:534)
>>>         at org.eclipse.jetty.server.HttpChannel.handle(
>>> HttpChannel.java:320)
>>>         at
>>> org.eclipse.jetty.server.HttpConnection.onFillable(
>>> HttpConnection.java:251)
>>>         at
>>> org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(
>>> AbstractConnection.java:273)
>>>         at org.eclipse.jetty.io.FillInterest.fillable(
>>> FillInterest.java:95)
>>>         at
>>> org.eclipse.jetty.io.SelectChannelEndPoint$2.run(
>>> SelectChannelEndPoint.java:93)
>>>         at
>>> org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.
>>> executeProduceConsume(ExecuteProduceConsume.java:303)
>>>         at
>>> org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.
>>> produceConsume(ExecuteProduceConsume.java:148)
>>>         at
>>> org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(
>>> ExecuteProduceConsume.java:136)
>>>         at
>>> org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(
>>> QueuedThreadPool.java:671)
>>>         at
>>> org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(
>>> QueuedThreadPool.java:589)
>>>         at java.lang.Thread.run(Thread.java:745)
>>> Caused by: java.sql.SQLException: Error while executing SQL "SELECT
>>>  dv_sv_userFirstName as firstName, dv_sv_userLastName as lastName FROM
>>> collection1 ORDEr BY dv_sv_userLastName LIMIT 15": From line 1, column 9
>> to
>>> line 1, column 27: Column 'dv_sv_userFirstName' not found in any table
>>>         at org.apache.calcite.avatica.Helper.createException(Helper.
>>> java:56)
>>>         at org.apache.calcite.avatica.Helper.createException(Helper.
>>> java:41)
>>>         at
>>> org.apache.calcite.avatica.AvaticaStatement.executeInternal(
>>> AvaticaStatement.java:156)
>>>         at
>>> org.apache.calcite.avatica.AvaticaStatement.executeQuery(
>>> AvaticaStatement.java:218)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.JDBCStream.open(
>>> JDBCStream.java:214)
>>>         ... 41 more
>>> Caused by: org.apache.calcite.runtime.CalciteContextException: From line
>>> 1,
>>> column 9 to line 1, column 27: Column 'dv_sv_userFirstName' not found in
>>> any table
>>>         at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
>>> Method)
>>>         at
>>> sun.reflect.NativeConstructorAccessorImpl.newInstance(
>>> NativeConstructorAccessorImpl.java:62)
>>>         at
>>> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(
>>> DelegatingConstructorAccessorImpl.java:45)
>>>         at java.lang.reflect.Constructor.newInstance(Constructor.java:
>> 423)
>>>         at
>>> org.apache.calcite.runtime.Resources$ExInstWithCause.ex(
>>> Resources.java:463)
>>>
>>
> 

Reply via email to