lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0-ea-b58) - Build # 2261 - Failure!
Date Thu, 08 Nov 2012 05:32:33 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/2261/
Java: 32bit/jdk1.8.0-ea-b58 -server -XX:+UseParallelGC

2 tests failed.
REGRESSION:  org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithComplexTransformer

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([C023A5B6CCB52DAC:AA29D43DA7432311]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:513)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:480)
	at org.apache.solr.handler.dataimport.AbstractDIHJdbcTestCase.complexTransform(AbstractDIHJdbcTestCase.java:119)
	at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithComplexTransformer(TestSqlEntityProcessorDelta.java:58)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:474)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:722)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='61']
	xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="rows">51</str><str name="sort">id asc</str><str name="q">*:*</str></lst></lst><result name="response" numFound="60" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Jacob</str><str>bocaJ</str></arr><str name="id">TripleThreat-1-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Anthony</str><str>ynohtnA</str></arr><str name="id">TripleThreat-1-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Emma</str><str>ammE</str></arr><str name="id">TripleThreat-1-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Grace</str><str>ecarG</str></arr><str name="id">TripleThreat-1-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Hailey</str><str>yeliaH</str></arr><str name="id">TripleThreat-1-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Isabella</str><str>allebasI</str></arr><str name="id">TripleThreat-1-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Lily</str><str>yliL</str></arr><str name="id">TripleThreat-1-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str><str>CN</str></arr><arr name="NAME_mult_s"><str>Madison</str><str>nosidaM</str></arr><str name="id">TripleThreat-1-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str><str>AN</str></arr><arr name="NAME_mult_s"><str>Mia</str><str>aiM</str></arr><str name="id">TripleThreat-1-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Natalie</str><str>eilataN</str></arr><str name="id">TripleThreat-1-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Olivia</str><str>aivilO</str></arr><str name="id">TripleThreat-1-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Ethan</str><str>nahtE</str></arr><str name="id">TripleThreat-1-2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Samantha</str><str>ahtnamaS</str></arr><str name="id">TripleThreat-1-20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Michael</str><str>leahciM</str></arr><str name="id">TripleThreat-1-3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str><str>PN</str></arr><arr name="NAME_mult_s"><str>Jayden</str><str>nedyaJ</str></arr><str name="id">TripleThreat-1-4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str><str>ON</str></arr><arr name="NAME_mult_s"><str>William</str><str>mailliW</str></arr><str name="id">TripleThreat-1-5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Alexander</str><str>rednaxelA</str></arr><str name="id">TripleThreat-1-6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Noah</str><str>haoN</str></arr><str name="id">TripleThreat-1-7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Daniel</str><str>leinaD</str></arr><str name="id">TripleThreat-1-8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Aiden</str><str>nediA</str></arr><str name="id">TripleThreat-1-9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc></result>
</response>

	request was:rows=51&sort=id+asc&q=*:*
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:506)
	... 43 more


REGRESSION:  org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testChildEntities

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([C023A5B6CCB52DAC:4F404A52F73C302F]:0)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:513)
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:480)
	at org.apache.solr.handler.dataimport.AbstractDIHJdbcTestCase.withChildEntities(AbstractDIHJdbcTestCase.java:180)
	at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testChildEntities(TestSqlEntityProcessorDelta.java:66)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:474)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:722)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='21']
	xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="version">2.2</str><str name="start">0</str><str name="rows">20</str><str name="qt">standard</str><str name="q">*:*</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><arr name="SPORT_NAME_mult_s"><str>Swimming</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><arr name="SPORT_NAME_mult_s"><str>Triathlon</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><arr name="SPORT_NAME_mult_s"><str>Water polo</str><str>Underwater rugby</str><str>Kayaking</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><arr name="SPORT_NAME_mult_s"><str>Snorkeling</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><arr name="SPORT_NAME_mult_s"><str>Synchronized diving</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><arr name="SPORT_NAME_mult_s"><str>Underwater rugby</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><arr name="SPORT_NAME_mult_s"><str>Boating</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><arr name="SPORT_NAME_mult_s"><str>Bodyboarding</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><arr name="SPORT_NAME_mult_s"><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><arr name="SPORT_NAME_mult_s"><str>Fishing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><arr name="SPORT_NAME_mult_s"><str>Jet Ski</str><str>Rowing</str><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><arr name="SPORT_NAME_mult_s"><str>Kayaking</str><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><arr name="SPORT_NAME_mult_s"><str>Kite surfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><arr name="SPORT_NAME_mult_s"><str>Parasailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><arr name="SPORT_NAME_mult_s"><str>Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><arr name="SPORT_NAME_mult_s"><str>Rowing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><arr name="SPORT_NAME_mult_s"><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><arr name="SPORT_NAME_mult_s"><str>White Water Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><arr name="SPORT_NAME_mult_s"><str>Water skiing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><arr name="SPORT_NAME_mult_s"><str>Windsurfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc></result>
</response>

	request was:version=2.2&start=0&rows=20&qt=standard&q=*:*
	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:506)
	... 43 more




Build Log:
[...truncated 11398 lines...]
[junit4:junit4] Suite: org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
[junit4:junit4]   2> 3 T61 oas.SolrTestCaseJ4.initCore ####initCore
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./solrtest-TestSqlEntityProcessorDelta-1352352729631
[junit4:junit4]   2> 3 T61 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test-files/dih/solr/collection1/'
[junit4:junit4]   2> 37 T61 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 65 T61 oasc.SolrConfig.<init> Loaded SolrConfig: dataimport-solrconfig.xml
[junit4:junit4]   2> 65 T61 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 68 T61 oass.IndexSchema.readSchema Schema name=dih_test
[junit4:junit4]   2> 107 T61 oass.IndexSchema.readSchema default search field in schema is desc
[junit4:junit4]   2> 108 T61 oass.IndexSchema.readSchema query parser default operator is OR
[junit4:junit4]   2> 109 T61 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 110 T61 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 110 T61 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test-files/dih/solr
[junit4:junit4]   2> 110 T61 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test-files/dih/solr/'
[junit4:junit4]   2> 116 T61 oasc.CoreContainer.<init> New CoreContainer 6157225
[junit4:junit4]   2> 116 T61 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test-files/dih/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./solrtest-TestSqlEntityProcessorDelta-1352352729631/
[junit4:junit4]   2> 116 T61 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 117 T61 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=solr,start=0,rows=10}, {q=rocks,start=0,rows=10}, {q=static newSearcher warming query from solrconfig.xml}]}
[junit4:junit4]   2> 117 T61 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4:junit4]   2> 117 T61 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./solrtest-TestSqlEntityProcessorDelta-1352352729631/index/
[junit4:junit4]   2> 117 T61 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./solrtest-TestSqlEntityProcessorDelta-1352352729631/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 118 T61 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./solrtest-TestSqlEntityProcessorDelta-1352352729631/index forceNew:false
[junit4:junit4]   2> 119 T61 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 120 T61 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 120 T61 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4:junit4]   2> 121 T61 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 121 T61 oasc.RequestHandlers.initHandlersFromConfig created /dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4:junit4]   2> 121 T61 oasc.RequestHandlers.initHandlersFromConfig created /search: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 121 T61 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 124 T61 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 126 T61 oass.SolrIndexSearcher.<init> Opening Searcher@18b5662 main
[junit4:junit4]   2> 126 T61 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 127 T61 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 127 T61 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 127 T61 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 128 T61 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 128 T61 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 128 T61 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 128 T61 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 129 T61 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 129 T61 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 129 T61 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 129 T61 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 130 T61 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 133 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@18b5662 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 133 T61 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 133 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 134 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@18b5662 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 134 T61 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4:junit4]   2> 137 T61 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4:junit4]   2> ASYNC  NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@2cbb29
[junit4:junit4]   2> 139 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 141 T61 C4 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 141 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 142 T61 C4 UPDATE [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 3
[junit4:junit4]   2> 150 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 151 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 152 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 153 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@164a17c main
[junit4:junit4]   2> 153 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 154 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@164a17c main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 154 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 154 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 155 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 155 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 155 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 156 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@164a17c main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 156 T61 C4 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4:junit4]   2> 379 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 380 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 380 T61 C4 oashd.DataImporter.doFullImport Starting Full Import
[junit4:junit4]   2> 380 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 394 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 397 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 397 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 421 T61 C4 oashd.DocBuilder.finish Import completed successfully
[junit4:junit4]   2> 421 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 441 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_3,generation=3,filenames=[_0_MockVariableIntBlock_0.tib, _0_Lucene41WithOrds_0.tib, _0_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.tii, _0_TestBloomFilteredLucene41Postings_0.tim, _0.fdx, segments_3, _0_TestBloomFilteredLucene41Postings_0.tip, _0.fnm, _0_Lucene41WithOrds_0.tii, _0.si, _0_TestBloomFilteredLucene41Postings_0.blm, _0_TestBloomFilteredLucene41Postings_0.doc, _0.fdt, _0_Lucene41WithOrds_0.doc]
[junit4:junit4]   2> 442 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 3
[junit4:junit4]   2> 461 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@ed9075 main
[junit4:junit4]   2> 462 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 462 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 463 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@ed9075 main{StandardDirectoryReader(segments_3:5 _0(4.1):C20)}
[junit4:junit4]   2> 463 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 463 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 464 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 464 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 464 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ed9075 main{StandardDirectoryReader(segments_3:5 _0(4.1):C20)}
[junit4:junit4]   2> 469 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 470 T61 C4 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4:junit4]   2> 470 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.89
[junit4:junit4]   2> 471 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&synchronous=true&indent=true&command=full-import} {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 0 95
[junit4:junit4]   2> 481 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=*:*} hits=20 status=0 QTime=7 
[junit4:junit4]   2> 489 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 496 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 497 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 497 T61 C4 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4:junit4]   2> 498 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 498 T61 C4 oashd.DocBuilder.doDelta Starting delta collection.
[junit4:junit4]   2> 499 T61 C4 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4:junit4]   2> 499 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 500 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 508 T61 C4 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 1
[junit4:junit4]   2> 509 T61 C4 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 0
[junit4:junit4]   2> 509 T61 C4 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4:junit4]   2> 513 T61 C4 oashd.DocBuilder.doDelta Delta Import completed successfully
[junit4:junit4]   2> 514 T61 C4 oashd.DocBuilder.finish Import completed successfully
[junit4:junit4]   2> 514 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 556 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_3,generation=3,filenames=[_0_MockVariableIntBlock_0.tib, _0_Lucene41WithOrds_0.tib, _0_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.tii, _0_TestBloomFilteredLucene41Postings_0.tim, _0.fdx, segments_3, _0_TestBloomFilteredLucene41Postings_0.tip, _0.fnm, _0_Lucene41WithOrds_0.tii, _0.si, _0_TestBloomFilteredLucene41Postings_0.blm, _0_TestBloomFilteredLucene41Postings_0.doc, _0.fdt, _0_Lucene41WithOrds_0.doc]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_4,generation=4,filenames=[_0_MockVariableIntBlock_0.tib, _0_Lucene41WithOrds_0.tib, segments_4, _1.fnm, _1_TestBloomFilteredLucene41Postings_0.tip, _0_MockVariableIntBlock_0.tii, _1_Lucene41WithOrds_0.tib, _1.fdx, _0.fdx, _0_Lucene41WithOrds_0.tii, _1_TestBloomFilteredLucene41Postings_0.tim, _0_TestBloomFilteredLucene41Postings_0.blm, _0.si, _1.fdt, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _1_TestBloomFilteredLucene41Postings_0.blm, _1_TestBloomFilteredLucene41Postings_0.doc, _0_TestBloomFilteredLucene41Postings_0.tim, _1.si, _1_Lucene41WithOrds_0.tii, _1_MockVariableIntBlock_0.tib, _0_TestBloomFilteredLucene41Postings_0.tip, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_Lucene41WithOrds_0.doc, _1_MockVariableIntBlock_0.skp, _0.fdt, _0_TestBloomFilteredLucene41Postings_0.doc, _0_Lucene41WithOrds_0.doc]
[junit4:junit4]   2> 557 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 4
[junit4:junit4]   2> 566 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@a23b80 main
[junit4:junit4]   2> 566 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 567 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 567 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@a23b80 main{StandardDirectoryReader(segments_4:7 _0(4.1):C20 _1(4.1):C1)}
[junit4:junit4]   2> 568 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 568 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 569 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 569 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 569 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a23b80 main{StandardDirectoryReader(segments_4:7 _0(4.1):C20 _1(4.1):C1)}
[junit4:junit4]   2> 570 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 571 T61 C4 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4:junit4]   2> 571 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.73
[junit4:junit4]   2> 572 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&synchronous=true&indent=true&command=delta-import} {add=[1008],commit=} 0 80
[junit4:junit4]   2> 577 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=*:*} hits=21 status=0 QTime=1 
[junit4:junit4]   2> 587 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 590 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:1008} hits=1 status=0 QTime=2 
[junit4:junit4]   2> 592 T61 oashd.AbstractDataImportHandlerTestCase.tearDown Looking for dataimport.properties at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/solr/collection1/conf/dataimport.properties
[junit4:junit4]   2> 593 T61 oas.SolrTestCaseJ4.tearDown ###Ending testSingleEntity
[junit4:junit4]   2> 602 T61 oas.SolrTestCaseJ4.setUp ###Starting testWithComplexTransformer
[junit4:junit4]   2> 606 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 607 T61 C4 UPDATE [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2
[junit4:junit4]   2> 611 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 612 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_4,generation=4,filenames=[_0_MockVariableIntBlock_0.tib, _0_Lucene41WithOrds_0.tib, segments_4, _1.fnm, _1_TestBloomFilteredLucene41Postings_0.tip, _0_MockVariableIntBlock_0.tii, _1_Lucene41WithOrds_0.tib, _1.fdx, _0.fdx, _0_Lucene41WithOrds_0.tii, _1_TestBloomFilteredLucene41Postings_0.tim, _0_TestBloomFilteredLucene41Postings_0.blm, _0.si, _1.fdt, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _1_TestBloomFilteredLucene41Postings_0.blm, _1_TestBloomFilteredLucene41Postings_0.doc, _0_TestBloomFilteredLucene41Postings_0.tim, _1.si, _1_Lucene41WithOrds_0.tii, _1_MockVariableIntBlock_0.tib, _0_TestBloomFilteredLucene41Postings_0.tip, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_Lucene41WithOrds_0.doc, _1_MockVariableIntBlock_0.skp, _0.fdt, _0_TestBloomFilteredLucene41Postings_0.doc, _0_Lucene41WithOrds_0.doc]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_5,generation=5,filenames=[segments_5]
[junit4:junit4]   2> 613 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 5
[junit4:junit4]   2> 616 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@17605b1 main
[junit4:junit4]   2> 616 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 617 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 617 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@17605b1 main{StandardDirectoryReader(segments_5:8)}
[junit4:junit4]   2> 617 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 618 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 618 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 619 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 619 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@17605b1 main{StandardDirectoryReader(segments_5:8)}
[junit4:junit4]   2> 620 T61 C4 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 9
[junit4:junit4]   2> 629 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 629 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 629 T61 C4 oashd.DataImporter.doFullImport Starting Full Import
[junit4:junit4]   2> 630 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 630 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 631 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 632 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 675 T61 C4 oashd.DocBuilder.finish Import completed successfully
[junit4:junit4]   2> 675 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 681 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_5,generation=5,filenames=[segments_5]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_6,generation=6,filenames=[_2_Lucene41WithOrds_0.tib, segments_6, _2.fdt, _2_TestBloomFilteredLucene41Postings_0.doc, _2.fdx, _2_TestBloomFilteredLucene41Postings_0.tip, _2_TestBloomFilteredLucene41Postings_0.blm, _2_MockVariableIntBlock_0.skp, _2_TestBloomFilteredLucene41Postings_0.tim, _2_Lucene41WithOrds_0.doc, _2_MockVariableIntBlock_0.doc, _2_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tib, _2.fnm, _2.si, _2_Lucene41WithOrds_0.tii]
[junit4:junit4]   2> 682 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 6
[junit4:junit4]   2> 683 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@59b580 main
[junit4:junit4]   2> 684 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 684 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 685 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@59b580 main{StandardDirectoryReader(segments_6:11 _2(4.1):C60)}
[junit4:junit4]   2> 685 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 686 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 686 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 686 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 687 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59b580 main{StandardDirectoryReader(segments_6:11 _2(4.1):C60)}
[junit4:junit4]   2> 687 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 688 T61 C4 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4:junit4]   2> 688 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.58
[junit4:junit4]   2> 689 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&synchronous=true&indent=true&command=full-import} {deleteByQuery=*:*,add=[1, TripleThreat-1-1, TripleThreat-2-1, 2, TripleThreat-1-2, TripleThreat-2-2, 3, TripleThreat-1-3, TripleThreat-2-3, 4, ... (60 adds)],commit=} 0 62
[junit4:junit4]   2> 739 T61 C4 REQ [collection1] webapp=null path=null params={rows=60&sort=id+asc&q=*:*} hits=60 status=0 QTime=49 
[junit4:junit4]   2> 762 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:TripleThreat-1-*} hits=20 status=0 QTime=2 
[junit4:junit4]   2> 768 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:TripleThreat-2-*} hits=20 status=0 QTime=2 
[junit4:junit4]   2> 778 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=AddAColumn_s:Added} hits=20 status=0 QTime=4 
[junit4:junit4]   2> 784 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 785 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 804 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 805 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 805 T61 C4 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4:junit4]   2> 806 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 806 T61 C4 oashd.DocBuilder.doDelta Starting delta collection.
[junit4:junit4]   2> 807 T61 C4 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4:junit4]   2> 807 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 808 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 815 T61 C4 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 0
[junit4:junit4]   2> 816 T61 C4 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 0
[junit4:junit4]   2> 816 T61 C4 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4:junit4]   2> 817 T61 C4 oashd.DocBuilder.doDelta Delta Import completed successfully
[junit4:junit4]   2> 817 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.11
[junit4:junit4]   2> 818 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&synchronous=true&indent=true&command=delta-import} {} 0 21
[junit4:junit4]   2> 820 T61 C4 REQ [collection1] webapp=null path=null params={rows=51&sort=id+asc&q=*:*} hits=60 status=0 QTime=1 
[junit4:junit4]   2> 838 T61 oas.SolrTestCaseJ4.assertQ SEVERE REQUEST FAILED: xpath=//*[@numFound='61']
[junit4:junit4]   2> 		xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4:junit4]   2> 	<response>
[junit4:junit4]   2> 	<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="rows">51</str><str name="sort">id asc</str><str name="q">*:*</str></lst></lst><result name="response" numFound="60" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Jacob</str><str>bocaJ</str></arr><str name="id">TripleThreat-1-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Anthony</str><str>ynohtnA</str></arr><str name="id">TripleThreat-1-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Emma</str><str>ammE</str></arr><str name="id">TripleThreat-1-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Grace</str><str>ecarG</str></arr><str name="id">TripleThreat-1-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Hailey</str><str>yeliaH</str></arr><str name="id">TripleThreat-1-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Isabella</str><str>allebasI</str></arr><str name="id">TripleThreat-1-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Lily</str><str>yliL</str></arr><str name="id">TripleThreat-1-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str><str>CN</str></arr><arr name="NAME_mult_s"><str>Madison</str><str>nosidaM</str></arr><str name="id">TripleThreat-1-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str><str>AN</str></arr><arr name="NAME_mult_s"><str>Mia</str><str>aiM</str></arr><str name="id">TripleThreat-1-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Natalie</str><str>eilataN</str></arr><str name="id">TripleThreat-1-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Olivia</str><str>aivilO</str></arr><str name="id">TripleThreat-1-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Ethan</str><str>nahtE</str></arr><str name="id">TripleThreat-1-2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Samantha</str><str>ahtnamaS</str></arr><str name="id">TripleThreat-1-20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Michael</str><str>leahciM</str></arr><str name="id">TripleThreat-1-3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str><str>PN</str></arr><arr name="NAME_mult_s"><str>Jayden</str><str>nedyaJ</str></arr><str name="id">TripleThreat-1-4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str><str>ON</str></arr><arr name="NAME_mult_s"><str>William</str><str>mailliW</str></arr><str name="id">TripleThreat-1-5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Alexander</str><str>rednaxelA</str></arr><str name="id">TripleThreat-1-6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Noah</str><str>haoN</str></arr><str name="id">TripleThreat-1-7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Daniel</str><str>leinaD</str></arr><str name="id">TripleThreat-1-8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Aiden</str><str>nediA</str></arr><str name="id">TripleThreat-1-9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc></result>
[junit4:junit4]   2> 	</response>
[junit4:junit4]   2> 	
[junit4:junit4]   2> 		request was:rows=51&sort=id+asc&q=*:*
[junit4:junit4]   2> 841 T61 oasc.SolrException.log SEVERE REQUEST FAILED: rows=51&sort=id+asc&q=*:*:java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='61']
[junit4:junit4]   2> 		xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4:junit4]   2> 	<response>
[junit4:junit4]   2> 	<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="rows">51</str><str name="sort">id asc</str><str name="q">*:*</str></lst></lst><result name="response" numFound="60" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Jacob</str><str>bocaJ</str></arr><str name="id">TripleThreat-1-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Anthony</str><str>ynohtnA</str></arr><str name="id">TripleThreat-1-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Emma</str><str>ammE</str></arr><str name="id">TripleThreat-1-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Grace</str><str>ecarG</str></arr><str name="id">TripleThreat-1-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Hailey</str><str>yeliaH</str></arr><str name="id">TripleThreat-1-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Isabella</str><str>allebasI</str></arr><str name="id">TripleThreat-1-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Lily</str><str>yliL</str></arr><str name="id">TripleThreat-1-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str><str>CN</str></arr><arr name="NAME_mult_s"><str>Madison</str><str>nosidaM</str></arr><str name="id">TripleThreat-1-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str><str>AN</str></arr><arr name="NAME_mult_s"><str>Mia</str><str>aiM</str></arr><str name="id">TripleThreat-1-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Natalie</str><str>eilataN</str></arr><str name="id">TripleThreat-1-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Olivia</str><str>aivilO</str></arr><str name="id">TripleThreat-1-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Ethan</str><str>nahtE</str></arr><str name="id">TripleThreat-1-2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Samantha</str><str>ahtnamaS</str></arr><str name="id">TripleThreat-1-20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Michael</str><str>leahciM</str></arr><str name="id">TripleThreat-1-3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str><str>PN</str></arr><arr name="NAME_mult_s"><str>Jayden</str><str>nedyaJ</str></arr><str name="id">TripleThreat-1-4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str><str>ON</str></arr><arr name="NAME_mult_s"><str>William</str><str>mailliW</str></arr><str name="id">TripleThreat-1-5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Alexander</str><str>rednaxelA</str></arr><str name="id">TripleThreat-1-6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Noah</str><str>haoN</str></arr><str name="id">TripleThreat-1-7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Daniel</str><str>leinaD</str></arr><str name="id">TripleThreat-1-8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Aiden</str><str>nediA</str></arr><str name="id">TripleThreat-1-9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc></result>
[junit4:junit4]   2> 	</response>
[junit4:junit4]   2> 	
[junit4:junit4]   2> 		request was:rows=51&sort=id+asc&q=*:*
[junit4:junit4]   2> 		at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:506)
[junit4:junit4]   2> 		at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:480)
[junit4:junit4]   2> 		at org.apache.solr.handler.dataimport.AbstractDIHJdbcTestCase.complexTransform(AbstractDIHJdbcTestCase.java:119)
[junit4:junit4]   2> 		at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithComplexTransformer(TestSqlEntityProcessorDelta.java:58)
[junit4:junit4]   2> 		at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]   2> 		at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]   2> 		at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]   2> 		at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]   2> 		at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   2> 		at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   2> 		at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	
[junit4:junit4]   2> 844 T61 oashd.AbstractDataImportHandlerTestCase.tearDown Looking for dataimport.properties at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/solr/collection1/conf/dataimport.properties
[junit4:junit4]   2> 844 T61 oas.SolrTestCaseJ4.tearDown ###Ending testWithComplexTransformer
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSqlEntityProcessorDelta -Dtests.method=testWithComplexTransformer -Dtests.seed=C023A5B6CCB52DAC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ga_IE -Dtests.timezone=Navajo -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.32s J1 | TestSqlEntityProcessorDelta.testWithComplexTransformer <<<
[junit4:junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([C023A5B6CCB52DAC:AA29D43DA7432311]:0)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:513)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:480)
[junit4:junit4]    > 	at org.apache.solr.handler.dataimport.AbstractDIHJdbcTestCase.complexTransform(AbstractDIHJdbcTestCase.java:119)
[junit4:junit4]    > 	at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithComplexTransformer(TestSqlEntityProcessorDelta.java:58)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='61']
[junit4:junit4]    > 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4:junit4]    > <response>
[junit4:junit4]    > <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="rows">51</str><str name="sort">id asc</str><str name="q">*:*</str></lst></lst><result name="response" numFound="60" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Jacob</str><str>bocaJ</str></arr><str name="id">TripleThreat-1-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Anthony</str><str>ynohtnA</str></arr><str name="id">TripleThreat-1-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Emma</str><str>ammE</str></arr><str name="id">TripleThreat-1-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Grace</str><str>ecarG</str></arr><str name="id">TripleThreat-1-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Hailey</str><str>yeliaH</str></arr><str name="id">TripleThreat-1-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Isabella</str><str>allebasI</str></arr><str name="id">TripleThreat-1-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str><str>EN</str></arr><arr name="NAME_mult_s"><str>Lily</str><str>yliL</str></arr><str name="id">TripleThreat-1-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str><str>CN</str></arr><arr name="NAME_mult_s"><str>Madison</str><str>nosidaM</str></arr><str name="id">TripleThreat-1-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str><str>AN</str></arr><arr name="NAME_mult_s"><str>Mia</str><str>aiM</str></arr><str name="id">TripleThreat-1-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str><str>ZN</str></arr><arr name="NAME_mult_s"><str>Natalie</str><str>eilataN</str></arr><str name="id">TripleThreat-1-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Olivia</str><str>aivilO</str></arr><str name="id">TripleThreat-1-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str><str>UN</str></arr><arr name="NAME_mult_s"><str>Ethan</str><str>nahtE</str></arr><str name="id">TripleThreat-1-2</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Samantha</str><str>ahtnamaS</str></arr><str name="id">TripleThreat-1-20</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str><str>RN</str></arr><arr name="NAME_mult_s"><str>Michael</str><str>leahciM</str></arr><str name="id">TripleThreat-1-3</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str><str>PN</str></arr><arr name="NAME_mult_s"><str>Jayden</str><str>nedyaJ</str></arr><str name="id">TripleThreat-1-4</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str><str>ON</str></arr><arr name="NAME_mult_s"><str>William</str><str>mailliW</str></arr><str name="id">TripleThreat-1-5</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str><str>LN</str></arr><arr name="NAME_mult_s"><str>Alexander</str><str>rednaxelA</str></arr><str name="id">TripleThreat-1-6</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str><str>IN</str></arr><arr name="NAME_mult_s"><str>Noah</str><str>haoN</str></arr><str name="id">TripleThreat-1-7</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str><str>GN</str></arr><arr name="NAME_mult_s"><str>Daniel</str><str>leinaD</str></arr><str name="id">TripleThreat-1-8</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str><str>FN</str></arr><arr name="NAME_mult_s"><str>Aiden</str><str>nediA</str></arr><str name="id">TripleThreat-1-9</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-1</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-10</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><arr name="NAME_mult_s"><str>Emma</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-11</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><arr name="NAME_mult_s"><str>Grace</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-12</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-13</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-14</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><arr name="NAME_mult_s"><str>Lily</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-15</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><arr name="NAME_mult_s"><str>Madison</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-16</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><arr name="NAME_mult_s"><str>Mia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-17</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-18</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="AddAColumn_s">Added</str><str name="id">TripleThreat-2-19</str><date name="timestamp">2012-11-08T05:32:10.255Z</date></doc></result>
[junit4:junit4]    > </response>
[junit4:junit4]    > 
[junit4:junit4]    > 	request was:rows=51&sort=id+asc&q=*:*
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:506)
[junit4:junit4]    > 	... 43 more
[junit4:junit4]   2> 916 T61 oas.SolrTestCaseJ4.setUp ###Starting testWithSimpleTransformer
[junit4:junit4]   2> 920 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 921 T61 C4 UPDATE [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4:junit4]   2> 938 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 939 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_6,generation=6,filenames=[_2_Lucene41WithOrds_0.tib, segments_6, _2.fdt, _2_TestBloomFilteredLucene41Postings_0.doc, _2.fdx, _2_TestBloomFilteredLucene41Postings_0.tip, _2_TestBloomFilteredLucene41Postings_0.blm, _2_MockVariableIntBlock_0.skp, _2_TestBloomFilteredLucene41Postings_0.tim, _2_Lucene41WithOrds_0.doc, _2_MockVariableIntBlock_0.doc, _2_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tib, _2.fnm, _2.si, _2_Lucene41WithOrds_0.tii]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_7,generation=7,filenames=[segments_7]
[junit4:junit4]   2> 939 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 7
[junit4:junit4]   2> 941 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@f05557 main
[junit4:junit4]   2> 941 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 942 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 942 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@f05557 main{StandardDirectoryReader(segments_7:12)}
[junit4:junit4]   2> 943 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 943 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 944 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 944 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 944 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f05557 main{StandardDirectoryReader(segments_7:12)}
[junit4:junit4]   2> 946 T61 C4 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4:junit4]   2> 956 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 957 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 957 T61 C4 oashd.DataImporter.doFullImport Starting Full Import
[junit4:junit4]   2> 957 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 959 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 960 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 961 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 988 T61 C4 oashd.DocBuilder.finish Import completed successfully
[junit4:junit4]   2> 989 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 992 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_7,generation=7,filenames=[segments_7]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_8,generation=8,filenames=[_3.si, _3_TestBloomFilteredLucene41Postings_0.blm, _3.fdt, _3_MockVariableIntBlock_0.tii, _3_Lucene41WithOrds_0.tii, _3_TestBloomFilteredLucene41Postings_0.tip, _3_Lucene41WithOrds_0.tib, _3_Lucene41WithOrds_0.doc, _3_MockVariableIntBlock_0.skp, _3_TestBloomFilteredLucene41Postings_0.tim, _3_MockVariableIntBlock_0.tib, segments_8, _3_TestBloomFilteredLucene41Postings_0.doc, _3.fdx, _3_MockVariableIntBlock_0.doc, _3.fnm]
[junit4:junit4]   2> 992 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 8
[junit4:junit4]   2> 994 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@1e7a6b1 main
[junit4:junit4]   2> 994 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 996 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 997 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1e7a6b1 main{StandardDirectoryReader(segments_8:15 _3(4.1):C20)}
[junit4:junit4]   2> 997 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 998 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 998 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 998 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 998 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e7a6b1 main{StandardDirectoryReader(segments_8:15 _3(4.1):C20)}
[junit4:junit4]   2> 999 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 1000 T61 C4 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4:junit4]   2> 1000 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.42
[junit4:junit4]   2> 1000 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&synchronous=true&indent=true&command=full-import} {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 0 46
[junit4:junit4]   2> 1002 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=AddAColumn_s:Added} hits=20 status=0 QTime=1 
[junit4:junit4]   2> 1006 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 1011 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 1011 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 1011 T61 C4 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4:junit4]   2> 1012 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 1012 T61 C4 oashd.DocBuilder.doDelta Starting delta collection.
[junit4:junit4]   2> 1012 T61 C4 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4:junit4]   2> 1013 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 1013 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 1015 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1017 T61 C4 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 3
[junit4:junit4]   2> 1017 T61 C4 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 10
[junit4:junit4]   2> 1017 T61 C4 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4:junit4]   2> 1018 T61 C4 oashd.DocBuilder.deleteAll Deleting stale documents 
[junit4:junit4]   2> 1018 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1018 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 5
[junit4:junit4]   2> 1019 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1019 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 8
[junit4:junit4]   2> 1019 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1020 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 11
[junit4:junit4]   2> 1020 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1020 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 13
[junit4:junit4]   2> 1020 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1021 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 17
[junit4:junit4]   2> 1021 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1021 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 19
[junit4:junit4]   2> 1022 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1022 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 1
[junit4:junit4]   2> 1022 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1023 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 18
[junit4:junit4]   2> 1023 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1023 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 6
[junit4:junit4]   2> 1024 T61 C4 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4:junit4]   2> 1024 T61 C4 oashd.SolrWriter.deleteDoc Deleting document: 7
[junit4:junit4]   2> 1027 T61 C4 oashd.DocBuilder.doDelta Delta Import completed successfully
[junit4:junit4]   2> 1027 T61 C4 oashd.DocBuilder.finish Import completed successfully
[junit4:junit4]   2> 1027 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1033 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_8,generation=8,filenames=[_3.si, _3_TestBloomFilteredLucene41Postings_0.blm, _3.fdt, _3_MockVariableIntBlock_0.tii, _3_Lucene41WithOrds_0.tii, _3_TestBloomFilteredLucene41Postings_0.tip, _3_Lucene41WithOrds_0.tib, _3_Lucene41WithOrds_0.doc, _3_MockVariableIntBlock_0.skp, _3_TestBloomFilteredLucene41Postings_0.tim, _3_MockVariableIntBlock_0.tib, segments_8, _3_TestBloomFilteredLucene41Postings_0.doc, _3.fdx, _3_MockVariableIntBlock_0.doc, _3.fnm]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_9,generation=9,filenames=[_3.si, _3_MockVariableIntBlock_0.tii, _4.fdt, _4_TestBloomFilteredLucene41Postings_0.doc, _3_Lucene41WithOrds_0.doc, _3_Lucene41WithOrds_0.tib, _3_TestBloomFilteredLucene41Postings_0.tim, _4_TestBloomFilteredLucene41Postings_0.tim, _4_MockVariableIntBlock_0.doc, _4_TestBloomFilteredLucene41Postings_0.tip, _3_TestBloomFilteredLucene41Postings_0.doc, _3_MockVariableIntBlock_0.doc, _3.fdx, _4.fnm, _3.fnm, _3_TestBloomFilteredLucene41Postings_0.blm, _3_1.del, _3.fdt, _4_MockVariableIntBlock_0.tii, _3_Lucene41WithOrds_0.tii, segments_9, _3_TestBloomFilteredLucene41Postings_0.tip, _3_MockVariableIntBlock_0.skp, _3_MockVariableIntBlock_0.tib, _4.si, _4_Lucene41WithOrds_0.tii, _4_TestBloomFilteredLucene41Postings_0.blm, _4.fdx, _4_Lucene41WithOrds_0.tib, _4_MockVariableIntBlock_0.skp, _4_MockVariableIntBlock_0.tib, _4_Lucene41WithOrds_0.doc]
[junit4:junit4]   2> 1034 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 9
[junit4:junit4]   2> 1037 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@87d6d5 main
[junit4:junit4]   2> 1037 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1038 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1040 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@87d6d5 main{StandardDirectoryReader(segments_9:18 _3(4.1):C20/11 _4(4.1):C3)}
[junit4:junit4]   2> 1040 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1041 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1041 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1041 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 1042 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@87d6d5 main{StandardDirectoryReader(segments_9:18 _3(4.1):C20/11 _4(4.1):C3)}
[junit4:junit4]   2> 1043 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 1043 T61 C4 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4:junit4]   2> 1044 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.32
[junit4:junit4]   2> 1044 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&synchronous=true&indent=true&command=delta-import} {delete=[5, 8, 11, 13, 17, 19, 1, 18, 6, 7],add=[1004, 1019, 12],commit=} 0 36
[junit4:junit4]   2> 1046 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=AddAColumn_s:Added} hits=12 status=0 QTime=1 
[junit4:junit4]   2> 1049 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 1050 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:1004} hits=1 status=0 QTime=0 
[junit4:junit4]   2> 1053 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:1019} hits=1 status=0 QTime=1 
[junit4:junit4]   2> 1055 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:11} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1058 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:8} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1060 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:13} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1063 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:18} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1065 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:19} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1068 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:1} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1070 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:17} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1073 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:7} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1075 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:6} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1077 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:5} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1080 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=id:12} hits=1 status=0 QTime=1 
[junit4:junit4]   2> 1084 T61 oashd.AbstractDataImportHandlerTestCase.tearDown Looking for dataimport.properties at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/solr/collection1/conf/dataimport.properties
[junit4:junit4]   2> 1085 T61 oas.SolrTestCaseJ4.tearDown ###Ending testWithSimpleTransformer
[junit4:junit4]   2> 1099 T61 oas.SolrTestCaseJ4.setUp ###Starting testChildEntities
[junit4:junit4]   2> 1102 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1103 T61 C4 UPDATE [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4:junit4]   2> 1106 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1107 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_9,generation=9,filenames=[_3.si, _3_MockVariableIntBlock_0.tii, _4.fdt, _4_TestBloomFilteredLucene41Postings_0.doc, _3_Lucene41WithOrds_0.doc, _3_Lucene41WithOrds_0.tib, _3_TestBloomFilteredLucene41Postings_0.tim, _4_TestBloomFilteredLucene41Postings_0.tim, _4_MockVariableIntBlock_0.doc, _4_TestBloomFilteredLucene41Postings_0.tip, _3_TestBloomFilteredLucene41Postings_0.doc, _3_MockVariableIntBlock_0.doc, _3.fdx, _4.fnm, _3.fnm, _3_TestBloomFilteredLucene41Postings_0.blm, _3_1.del, _3.fdt, _4_MockVariableIntBlock_0.tii, _3_Lucene41WithOrds_0.tii, segments_9, _3_TestBloomFilteredLucene41Postings_0.tip, _3_MockVariableIntBlock_0.skp, _3_MockVariableIntBlock_0.tib, _4.si, _4_Lucene41WithOrds_0.tii, _4_TestBloomFilteredLucene41Postings_0.blm, _4.fdx, _4_Lucene41WithOrds_0.tib, _4_MockVariableIntBlock_0.skp, _4_MockVariableIntBlock_0.tib, _4_Lucene41WithOrds_0.doc]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_a,generation=10,filenames=[segments_a]
[junit4:junit4]   2> 1108 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 10
[junit4:junit4]   2> 1109 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@169dd14 main
[junit4:junit4]   2> 1109 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1110 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1110 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@169dd14 main{StandardDirectoryReader(segments_a:19)}
[junit4:junit4]   2> 1111 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1111 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1111 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1112 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 1112 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@169dd14 main{StandardDirectoryReader(segments_a:19)}
[junit4:junit4]   2> 1112 T61 C4 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4:junit4]   2> 1118 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 1118 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 1119 T61 C4 oashd.DataImporter.doFullImport Starting Full Import
[junit4:junit4]   2> 1119 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 1120 T61 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1120 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 1121 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 1121 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity Sports with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 1122 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 1137 T61 C4 oashd.DocBuilder.finish Import completed successfully
[junit4:junit4]   2> 1138 T61 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1143 T61 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_a,generation=10,filenames=[segments_a]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2817ee lockFactory=org.apache.lucene.store.NativeFSLockFactory@1158876),segFN=segments_b,generation=11,filenames=[_5_MockVariableIntBlock_0.tii, _5_TestBloomFilteredLucene41Postings_0.blm, segments_b, _5.si, _5_TestBloomFilteredLucene41Postings_0.tim, _5_Lucene41WithOrds_0.doc, _5_MockVariableIntBlock_0.doc, _5_MockVariableIntBlock_0.skp, _5_MockVariableIntBlock_0.tib, _5_TestBloomFilteredLucene41Postings_0.doc, _5.fnm, _5.fdx, _5_Lucene41WithOrds_0.tib, _5.fdt, _5_TestBloomFilteredLucene41Postings_0.tip, _5_Lucene41WithOrds_0.tii]
[junit4:junit4]   2> 1144 T61 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 11
[junit4:junit4]   2> 1146 T61 C4 oass.SolrIndexSearcher.<init> Opening Searcher@848738 main
[junit4:junit4]   2> 1146 T61 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1147 T61 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1150 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@848738 main{StandardDirectoryReader(segments_b:22 _5(4.1):C20)}
[junit4:junit4]   2> 1150 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1150 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&start=0&rows=10&q=rocks} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1151 T62 C4 REQ [collection1] webapp=null path=null params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1151 T62 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4]   2> 1151 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@848738 main{StandardDirectoryReader(segments_b:22 _5(4.1):C20)}
[junit4:junit4]   2> 1151 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 1152 T61 C4 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4:junit4]   2> 1152 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.33
[junit4:junit4]   2> 1153 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Sports"+dataSource%3D"hsqldb"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+WHERE+DELETED+!%3D+'Y'+AND+PERSON_ID%3D'${People.ID}'+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&synchronous=true&indent=true&command=full-import} {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 0 36
[junit4:junit4]   2> 1154 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=*:*} hits=20 status=0 QTime=1 
[junit4:junit4]   2> 1157 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=AddAColumn_s:Added} hits=20 status=0 QTime=0 
[junit4:junit4]   2> 1162 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=SPORT_NAME_mult_s:Sailing} hits=2 status=0 QTime=2 
[junit4:junit4]   2> 1168 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=NAME_mult_s:Michael} hits=1 status=0 QTime=3 
[junit4:junit4]   2> 1180 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 1181 T61 C4 REQ [collection1] webapp=null path=null params={indent=true} status=0 QTime=0 
[junit4:junit4]   2> 1205 T61 C4 oashdc.ConfigParseUtil.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4:junit4]   2> 1206 T61 C4 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4:junit4]   2> 1206 T61 C4 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4:junit4]   2> 1207 T61 C4 oashd.SimplePropertiesWriter.readIndexerProperties Read dataimport.properties
[junit4:junit4]   2> 1209 T61 C4 oashd.DocBuilder.doDelta Starting delta collection.
[junit4:junit4]   2> 1210 T61 C4 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: Sports
[junit4:junit4]   2> 1210 T61 C4 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: Sports rows obtained : 0
[junit4:junit4]   2> 1210 T61 C4 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: Sports rows obtained : 0
[junit4:junit4]   2> 1211 T61 C4 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: Sports
[junit4:junit4]   2> 1211 T61 C4 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4:junit4]   2> 1211 T61 C4 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4:junit4]   2> 1212 T61 C4 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4:junit4]   2> 1216 T61 C4 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 0
[junit4:junit4]   2> 1217 T61 C4 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 0
[junit4:junit4]   2> 1217 T61 C4 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4:junit4]   2> 1217 T61 C4 oashd.DocBuilder.doDelta Delta Import completed successfully
[junit4:junit4]   2> 1218 T61 C4 oashd.DocBuilder.execute Time taken = 0:0:0.11
[junit4:junit4]   2> 1218 T61 C4 UPDATE [collection1] webapp=null path=null params={commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.last_index_time}'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Sports"+dataSource%3D"hsqldb"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+WHERE+DELETED+!%3D+'Y'+AND+PERSON_ID%3D'${People.ID}'+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&synchronous=true&indent=true&command=delta-import} {} 0 35
[junit4:junit4]   2> 1220 T61 C4 REQ [collection1] webapp=null path=null params={version=2.2&start=0&rows=20&qt=standard&q=*:*} hits=20 status=0 QTime=1 
[junit4:junit4]   2> 1230 T61 oas.SolrTestCaseJ4.assertQ SEVERE REQUEST FAILED: xpath=//*[@numFound='21']
[junit4:junit4]   2> 		xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4:junit4]   2> 	<response>
[junit4:junit4]   2> 	<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="version">2.2</str><str name="start">0</str><str name="rows">20</str><str name="qt">standard</str><str name="q">*:*</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><arr name="SPORT_NAME_mult_s"><str>Swimming</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><arr name="SPORT_NAME_mult_s"><str>Triathlon</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><arr name="SPORT_NAME_mult_s"><str>Water polo</str><str>Underwater rugby</str><str>Kayaking</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><arr name="SPORT_NAME_mult_s"><str>Snorkeling</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><arr name="SPORT_NAME_mult_s"><str>Synchronized diving</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><arr name="SPORT_NAME_mult_s"><str>Underwater rugby</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><arr name="SPORT_NAME_mult_s"><str>Boating</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><arr name="SPORT_NAME_mult_s"><str>Bodyboarding</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><arr name="SPORT_NAME_mult_s"><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><arr name="SPORT_NAME_mult_s"><str>Fishing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><arr name="SPORT_NAME_mult_s"><str>Jet Ski</str><str>Rowing</str><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><arr name="SPORT_NAME_mult_s"><str>Kayaking</str><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><arr name="SPORT_NAME_mult_s"><str>Kite surfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><arr name="SPORT_NAME_mult_s"><str>Parasailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><arr name="SPORT_NAME_mult_s"><str>Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><arr name="SPORT_NAME_mult_s"><str>Rowing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><arr name="SPORT_NAME_mult_s"><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><arr name="SPORT_NAME_mult_s"><str>White Water Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><arr name="SPORT_NAME_mult_s"><str>Water skiing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><arr name="SPORT_NAME_mult_s"><str>Windsurfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc></result>
[junit4:junit4]   2> 	</response>
[junit4:junit4]   2> 	
[junit4:junit4]   2> 		request was:version=2.2&start=0&rows=20&qt=standard&q=*:*
[junit4:junit4]   2> 1232 T61 oasc.SolrException.log SEVERE REQUEST FAILED: version=2.2&start=0&rows=20&qt=standard&q=*:*:java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='21']
[junit4:junit4]   2> 		xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4:junit4]   2> 	<response>
[junit4:junit4]   2> 	<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="version">2.2</str><str name="start">0</str><str name="rows">20</str><str name="qt">standard</str><str name="q">*:*</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><arr name="SPORT_NAME_mult_s"><str>Swimming</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><arr name="SPORT_NAME_mult_s"><str>Triathlon</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><arr name="SPORT_NAME_mult_s"><str>Water polo</str><str>Underwater rugby</str><str>Kayaking</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><arr name="SPORT_NAME_mult_s"><str>Snorkeling</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><arr name="SPORT_NAME_mult_s"><str>Synchronized diving</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><arr name="SPORT_NAME_mult_s"><str>Underwater rugby</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><arr name="SPORT_NAME_mult_s"><str>Boating</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><arr name="SPORT_NAME_mult_s"><str>Bodyboarding</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><arr name="SPORT_NAME_mult_s"><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><arr name="SPORT_NAME_mult_s"><str>Fishing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><arr name="SPORT_NAME_mult_s"><str>Jet Ski</str><str>Rowing</str><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><arr name="SPORT_NAME_mult_s"><str>Kayaking</str><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><arr name="SPORT_NAME_mult_s"><str>Kite surfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><arr name="SPORT_NAME_mult_s"><str>Parasailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><arr name="SPORT_NAME_mult_s"><str>Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><arr name="SPORT_NAME_mult_s"><str>Rowing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><arr name="SPORT_NAME_mult_s"><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><arr name="SPORT_NAME_mult_s"><str>White Water Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><arr name="SPORT_NAME_mult_s"><str>Water skiing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><arr name="SPORT_NAME_mult_s"><str>Windsurfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc></result>
[junit4:junit4]   2> 	</response>
[junit4:junit4]   2> 	
[junit4:junit4]   2> 		request was:version=2.2&start=0&rows=20&qt=standard&q=*:*
[junit4:junit4]   2> 		at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:506)
[junit4:junit4]   2> 		at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:480)
[junit4:junit4]   2> 		at org.apache.solr.handler.dataimport.AbstractDIHJdbcTestCase.withChildEntities(AbstractDIHJdbcTestCase.java:180)
[junit4:junit4]   2> 		at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testChildEntities(TestSqlEntityProcessorDelta.java:66)
[junit4:junit4]   2> 		at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]   2> 		at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]   2> 		at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]   2> 		at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]   2> 		at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   2> 		at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   2> 		at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 		at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   2> 		at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	
[junit4:junit4]   2> 1234 T61 oashd.AbstractDataImportHandlerTestCase.tearDown Looking for dataimport.properties at: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/solr/collection1/conf/dataimport.properties
[junit4:junit4]   2> 1234 T61 oas.SolrTestCaseJ4.tearDown ###Ending testChildEntities
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSqlEntityProcessorDelta -Dtests.method=testChildEntities -Dtests.seed=C023A5B6CCB52DAC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ga_IE -Dtests.timezone=Navajo -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.15s J1 | TestSqlEntityProcessorDelta.testChildEntities <<<
[junit4:junit4]    > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([C023A5B6CCB52DAC:4F404A52F73C302F]:0)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:513)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:480)
[junit4:junit4]    > 	at org.apache.solr.handler.dataimport.AbstractDIHJdbcTestCase.withChildEntities(AbstractDIHJdbcTestCase.java:180)
[junit4:junit4]    > 	at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testChildEntities(TestSqlEntityProcessorDelta.java:66)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='21']
[junit4:junit4]    > 	xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4:junit4]    > <response>
[junit4:junit4]    > <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="version">2.2</str><str name="start">0</str><str name="rows">20</str><str name="qt">standard</str><str name="q">*:*</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jacob</str></arr><str name="id">1</str><arr name="SPORT_NAME_mult_s"><str>Swimming</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Ethan</str></arr><str name="id">2</str><arr name="SPORT_NAME_mult_s"><str>Triathlon</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Michael</str></arr><str name="id">3</str><arr name="SPORT_NAME_mult_s"><str>Water polo</str><str>Underwater rugby</str><str>Kayaking</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Jayden</str></arr><str name="id">4</str><arr name="SPORT_NAME_mult_s"><str>Snorkeling</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>William</str></arr><str name="id">5</str><arr name="SPORT_NAME_mult_s"><str>Synchronized diving</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Alexander</str></arr><str name="id">6</str><arr name="SPORT_NAME_mult_s"><str>Underwater rugby</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Noah</str></arr><str name="id">7</str><arr name="SPORT_NAME_mult_s"><str>Boating</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Daniel</str></arr><str name="id">8</str><arr name="SPORT_NAME_mult_s"><str>Bodyboarding</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Aiden</str></arr><str name="id">9</str><arr name="SPORT_NAME_mult_s"><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Anthony</str></arr><str name="id">10</str><arr name="SPORT_NAME_mult_s"><str>Fishing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Emma</str></arr><str name="id">11</str><arr name="SPORT_NAME_mult_s"><str>Jet Ski</str><str>Rowing</str><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Grace</str></arr><str name="id">12</str><arr name="SPORT_NAME_mult_s"><str>Kayaking</str><str>Canoeing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Hailey</str></arr><str name="id">13</str><arr name="SPORT_NAME_mult_s"><str>Kite surfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Isabella</str></arr><str name="id">14</str><arr name="SPORT_NAME_mult_s"><str>Parasailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Lily</str></arr><str name="id">15</str><arr name="SPORT_NAME_mult_s"><str>Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Madison</str></arr><str name="id">16</str><arr name="SPORT_NAME_mult_s"><str>Rowing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Mia</str></arr><str name="id">17</str><arr name="SPORT_NAME_mult_s"><str>Sailing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Natalie</str></arr><str name="id">18</str><arr name="SPORT_NAME_mult_s"><str>White Water Rafting</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Olivia</str></arr><str name="id">19</str><arr name="SPORT_NAME_mult_s"><str>Water skiing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc><doc><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="AddAColumn_s">Added</str><arr name="NAME_mult_s"><str>Samantha</str></arr><str name="id">20</str><arr name="SPORT_NAME_mult_s"><str>Windsurfing</str></arr><date name="timestamp">2012-11-08T05:32:10.745Z</date></doc></result>
[junit4:junit4]    > </response>
[junit4:junit4]    > 
[junit4:junit4]    > 	request was:version=2.2&start=0&rows=20&qt=standard&q=*:*
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:506)
[junit4:junit4]    > 	... 43 more
[junit4:junit4]   2> 1244 T61 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> 1245 T61 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=6157225
[junit4:junit4]   2> 1245 T61 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2cbb29
[junit4:junit4]   2> 1245 T61 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=10,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=124,cumulative_deletesById=10,cumulative_deletesByQuery=8,cumulative_errors=0}
[junit4:junit4]   2> 1246 T61 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 1246 T61 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 1246 T61 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 1247 T61 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> NOTE: test params are: codec=Lucene41: {NAME_mult_s=MockVariableIntBlock(baseBlockSize=68), timestamp=PostingsFormat(name=Lucene41WithOrds), AddAColumn_s=PostingsFormat(name=Lucene41WithOrds), id=PostingsFormat(name=TestBloomFilteredLucene41Postings), SPORT_NAME_mult_s=PostingsFormat(name=TestBloomFilteredLucene41Postings), COUNTRY_CODES_mult_s=PostingsFormat(name=Lucene41WithOrds)}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=ga_IE, timezone=Navajo
[junit4:junit4]   2> NOTE: Linux 3.2.0-32-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=151102696,total=198508544
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestPlainTextEntityProcessor, TestScriptTransformer, TestTemplateString, TestFileListWithLineEntityProcessor, TestJdbcDataSource, TestDocBuilder, TestXPathEntityProcessor, TestFileListEntityProcessor, TestErrorHandling, TestContentStreamDataSource, TestSqlEntityProcessorDelta]
[junit4:junit4] Completed on J1 in 1.30s, 4 tests, 2 errors <<< FAILURES!

[...truncated 50 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:335: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:192: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:410: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1163: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:827: There were test failures: 33 suites, 138 tests, 2 errors, 5 ignored

Total time: 26 minutes 34 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.8.0-ea-b58 -server -XX:+UseParallelGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message