You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/10/27 02:05:07 UTC
[JENKINS] Lucene-Solr-4.x-Windows (64bit/jdk1.7.0_45) - Build #
3319 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3319/
Java: 64bit/jdk1.7.0_45 -XX:+UseCompressedOops -XX:+UseSerialGC
2 tests failed.
REGRESSION: org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithSimpleTransformer
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([146D44F20B6F1293:7B296C18D1B97E9E]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:637)
at org.apache.solr.handler.dataimport.AbstractSqlEntityProcessorTestCase.simpleTransform(AbstractSqlEntityProcessorTestCase.java:116)
at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithSimpleTransformer(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:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='16']
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="start">0</str><str name="q">AddAColumn_s:Added</str><str name="qt">standard</str><str name="rows">20</str><str name="version">2.2</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="NAME_mult_s"><str>Jacob</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">1</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Ethan</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">2</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Michael</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">3</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Jayden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="id">4</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>William</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="id">5</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Alexander</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">6</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Noah</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">7</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Daniel</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">8</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Aiden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">9</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Anthony</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">10</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Emma</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">11</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Grace</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">12</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Hailey</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">13</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Isabella</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">14</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Lily</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">15</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Madison</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="id">16</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Mia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="id">17</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Natalie</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">18</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Olivia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">19</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Samantha</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">20</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc></result>
</response>
request was:start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:630)
... 42 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([146D44F20B6F1293:9B0EAB1630E60F10]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:637)
at org.apache.solr.handler.dataimport.AbstractSqlEntityProcessorTestCase.withChildEntities(AbstractSqlEntityProcessorTestCase.java:205)
at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testChildEntities(TestSqlEntityProcessorDelta.java:82)
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:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='18']
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="start">0</str><str name="q">*:*</str><str name="qt">standard</str><str name="rows">20</str><str name="version">2.2</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="NAME_mult_s"><str>Jacob</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">1</str><arr name="SPORT_NAME_mult_s"><str>Swimming</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Ethan</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">2</str><arr name="SPORT_NAME_mult_s"><str>Triathlon</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Michael</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</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><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Jayden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="id">4</str><arr name="SPORT_NAME_mult_s"><str>Snorkeling</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>William</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="id">5</str><arr name="SPORT_NAME_mult_s"><str>Synchronized diving</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Alexander</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">6</str><arr name="SPORT_NAME_mult_s"><str>Underwater rugby</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Noah</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">7</str><arr name="SPORT_NAME_mult_s"><str>Boating</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Daniel</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">8</str><arr name="SPORT_NAME_mult_s"><str>Bodyboarding</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Aiden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">9</str><arr name="SPORT_NAME_mult_s"><str>Canoeing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Anthony</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">10</str><arr name="SPORT_NAME_mult_s"><str>Fishing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Emma</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">11</str><arr name="SPORT_NAME_mult_s"><str>Jet Ski</str><str>Rowing</str><str>Sailing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Grace</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">12</str><arr name="SPORT_NAME_mult_s"><str>Kayaking</str><str>Canoeing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Hailey</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">13</str><arr name="SPORT_NAME_mult_s"><str>Kite surfing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Isabella</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">14</str><arr name="SPORT_NAME_mult_s"><str>Parasailing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Lily</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">15</str><arr name="SPORT_NAME_mult_s"><str>Rafting</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Madison</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="id">16</str><arr name="SPORT_NAME_mult_s"><str>Rowing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Mia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="id">17</str><arr name="SPORT_NAME_mult_s"><str>Sailing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Natalie</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">18</str><arr name="SPORT_NAME_mult_s"><str>White Water Rafting</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Olivia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">19</str><arr name="SPORT_NAME_mult_s"><str>Water skiing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Samantha</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">20</str><arr name="SPORT_NAME_mult_s"><str>Windsurfing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc></result>
</response>
request was:start=0&q=*:*&qt=standard&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:630)
... 42 more
Build Log:
[...truncated 13781 lines...]
[junit4] Suite: org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
[junit4] 2> 88560 T179 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297
[junit4] 2> 88561 T179 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\collection1\'
[junit4] 2> 88665 T179 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
[junit4] 2> 88744 T179 oasc.SolrConfig.<init> Loaded SolrConfig: dataimport-solrconfig.xml
[junit4] 2> 88746 T179 oass.IndexSchema.readSchema Reading Solr Schema from dataimport-schema.xml
[junit4] 2> 88758 T179 oass.IndexSchema.readSchema [null] Schema name=dih_test
[junit4] 2> 88865 T179 oass.IndexSchema.readSchema default search field in schema is desc
[junit4] 2> 88867 T179 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 88869 T179 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 88870 T179 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 88870 T179 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr
[junit4] 2> 88870 T179 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\'
[junit4] 2> 88885 T179 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 88885 T179 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr
[junit4] 2> 88885 T179 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\'
[junit4] 2> 88975 T179 oasc.CoreContainer.<init> New CoreContainer 2137098142
[junit4] 2> 88975 T179 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\]
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 88977 T179 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 88980 T179 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 88983 T179 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 88983 T179 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 88991 T181 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\collection1
[junit4] 2> 88991 T181 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\collection1\'
[junit4] 2> 89064 T181 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
[junit4] 2> 89274 T181 oasc.SolrConfig.<init> Loaded SolrConfig: dataimport-solrconfig.xml
[junit4] 2> 89274 T181 oass.IndexSchema.readSchema Reading Solr Schema from dataimport-schema.xml
[junit4] 2> 89287 T181 oass.IndexSchema.readSchema [collection1] Schema name=dih_test
[junit4] 2> 89374 T181 oass.IndexSchema.readSchema default search field in schema is desc
[junit4] 2> 89377 T181 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 89378 T181 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 89381 T181 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 89381 T181 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test-files\dih\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\
[junit4] 2> 89381 T181 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 89381 T181 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] 2> 89382 T181 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 89382 T181 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\
[junit4] 2> 89382 T181 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\index/
[junit4] 2> 89383 T181 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\index' doesn't exist. Creating new index...
[junit4] 2> 89383 T181 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\index
[junit4] 2> 89386 T181 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_1,generation=1}
[junit4] 2> 89387 T181 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 89389 T181 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "" (default)
[junit4] 2> 89390 T181 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 89390 T181 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 89390 T181 oasc.RequestHandlers.initHandlersFromConfig created /dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 89391 T181 oasc.RequestHandlers.initHandlersFromConfig created /search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 89391 T181 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 89401 T181 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 89411 T181 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 89411 T181 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 89412 T181 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_1,generation=1}
[junit4] 2> 89412 T181 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 89413 T181 oass.SolrIndexSearcher.<init> Opening Searcher@519b34b0 main
[junit4] 2> 89413 T181 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 89413 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@519b34b0 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 89414 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 89415 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@519b34b0 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 89419 T179 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 89434 T179 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4] 2> ASYNC NEW_CORE C44 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 89444 T179 C44 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 89446 T179 C44 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 5
[junit4] 2> ASYNC NEW_CORE C45 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 89473 T179 C45 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 89476 T179 C45 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_2,generation=2}
[junit4] 2> 89476 T179 C45 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 89477 T179 C45 oass.SolrIndexSearcher.<init> Opening Searcher@36476ebd main
[junit4] 2> 89477 T179 C45 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 89477 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@36476ebd main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 89478 T182 C45 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 89479 T182 C45 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=1
[junit4] 2> 89479 T182 C45 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=0
[junit4] 2> 89479 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 89480 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@36476ebd main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 89480 T179 C45 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
[junit4] 2> ASYNC NEW_CORE C46 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 90403 T179 C46 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 90403 T179 C46 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> 90407 T179 C46 oashd.DataImporter.doFullImport Starting Full Import
[junit4] 2> 90408 T179 C46 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: the.properties
[junit4] 2> 90409 T179 C46 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 90410 T179 C46 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:derby:memory:derbyDB;
[junit4] 2> 90412 T179 C46 oashd.JdbcDataSource$1.call Time taken for getConnection(): 2
[junit4] 2> 90504 T179 C46 oashd.DocBuilder.finish Import completed successfully
[junit4] 2> 90504 T179 C46 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 90509 T179 C46 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_3,generation=3}
[junit4] 2> 90509 T179 C46 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 90511 T179 C46 oass.SolrIndexSearcher.<init> Opening Searcher@4eabf587 main
[junit4] 2> 90511 T179 C46 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 90513 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4eabf587 main{StandardDirectoryReader(segments_3:5:nrt _0(4.6):c20)}
[junit4] 2> 90513 T182 C46 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 90513 T182 C46 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 90514 T182 C46 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=0
[junit4] 2> 90514 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 90514 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4eabf587 main{StandardDirectoryReader(segments_3:5:nrt _0(4.6):c20)}
[junit4] 2> 90515 T179 C46 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: the.properties
[junit4] 2> 90516 T179 C46 oashd.SimplePropertiesWriter.persist Wrote last indexed time to the.properties
[junit4] 2> 90516 T179 C46 oashd.DocBuilder.execute Time taken = 0:0:0.107
[junit4] 2> 90516 T179 C46 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={indent=true&clean=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D".\test1677538195884305750tmp"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+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.People.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.People.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.People.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&command=full-import&synchronous=true} {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 0 122
[junit4] 2> 90633 T179 C46 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=*:*&qt=standard&rows=20&version=2.2} hits=20 status=0 QTime=2
[junit4] 2> 90643 T179 C46 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=0
[junit4] 2> 90643 T179 C46 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=0
[junit4] 2> 90645 T179 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 90712 T179 C46 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 90712 T179 C46 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> 90715 T179 C46 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4] 2> 90716 T179 C46 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 90718 T179 C46 oashd.DocBuilder.doDelta Starting delta collection.
[junit4] 2> 90719 T179 C46 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4] 2> 90719 T179 C46 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:derby:memory:derbyDB;
[junit4] 2> 90720 T179 C46 oashd.JdbcDataSource$1.call Time taken for getConnection(): 1
[junit4] 2> ASYNC NEW_CORE C47 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 90911 T179 C47 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 3
[junit4] 2> 90911 T179 C47 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 3
[junit4] 2> 90911 T179 C47 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4] 2> 90911 T179 C47 oashd.DocBuilder.deleteAll Deleting stale documents
[junit4] 2> 90911 T179 C47 oashd.SolrWriter.deleteDoc Deleting document: 14
[junit4] 2> 90911 T179 C47 oashd.SolrWriter.deleteDoc Deleting document: 15
[junit4] 2> 90911 T179 C47 oashd.SolrWriter.deleteDoc Deleting document: 7
[junit4] 2> 90940 T179 C47 oashd.DocBuilder.doDelta Delta Import completed successfully
[junit4] 2> 90940 T179 C47 oashd.DocBuilder.finish Import completed successfully
[junit4] 2> 90940 T179 C47 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 90945 T179 C47 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_4,generation=4}
[junit4] 2> 90945 T179 C47 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 90959 T179 C47 oass.SolrIndexSearcher.<init> Opening Searcher@42a11636 main
[junit4] 2> 90959 T179 C47 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 90961 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@42a11636 main{StandardDirectoryReader(segments_4:8:nrt _0(4.6):c20/4:delGen=1 _1(4.6):c3)}
[junit4] 2> 90962 T182 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=1
[junit4] 2> 90963 T182 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 90963 T182 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=0
[junit4] 2> 90963 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 90963 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@42a11636 main{StandardDirectoryReader(segments_4:8:nrt _0(4.6):c20/4:delGen=1 _1(4.6):c3)}
[junit4] 2> 90964 T179 C47 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 90964 T179 C47 oashd.SimplePropertiesWriter.persist Wrote last indexed time to the.properties
[junit4] 2> 90964 T179 C47 oashd.DocBuilder.execute Time taken = 0:0:0.246
[junit4] 2> 90964 T179 C47 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={indent=true&clean=false&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D".\test1677538195884305750tmp"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+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.People.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.People.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.People.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&command=delta-import&synchronous=true} {delete=[14, 15, 7],add=[1010, 1, 1004],commit=} 0 259
[junit4] 2> 90970 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=*:*&qt=standard&rows=20&version=2.2} hits=19 status=0 QTime=1
[junit4] 2> 90980 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=1
[junit4] 2> 90980 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=0
[junit4] 2> 90982 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:1004&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=1
[junit4] 2> 90985 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:1010&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 90989 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:7&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=1
[junit4] 2> 90993 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:14&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=2
[junit4] 2> 90995 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:15&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 90998 T179 C47 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:1&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=1
[junit4] 2> 91536 T179 oashd.AbstractDataImportHandlerTestCase.tearDown Looking for dataimport.properties at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\solr\collection1\conf\dataimport.properties
[junit4] 2> 91537 T179 oas.SolrTestCaseJ4.tearDown ###Ending testSingleEntity
[junit4] 2> 91551 T179 oas.SolrTestCaseJ4.setUp ###Starting testWithSimpleTransformer
[junit4] 2> 91577 T179 C47 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 91579 T179 C47 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 4
[junit4] 2> ASYNC NEW_CORE C48 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 91604 T179 C48 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 91605 T179 C48 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_5,generation=5}
[junit4] 2> 91605 T179 C48 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 91606 T179 C48 oass.SolrIndexSearcher.<init> Opening Searcher@7da8ca25 main
[junit4] 2> 91606 T179 C48 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 91606 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7da8ca25 main{StandardDirectoryReader(segments_5:9:nrt)}
[junit4] 2> 91607 T182 C48 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 91607 T182 C48 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 91607 T182 C48 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=0
[junit4] 2> 91607 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 91607 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7da8ca25 main{StandardDirectoryReader(segments_5:9:nrt)}
[junit4] 2> 91608 T179 C48 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 92175 T179 C48 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 92175 T179 C48 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> ASYNC NEW_CORE C49 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 92186 T179 C49 oashd.DataImporter.doFullImport Starting Full Import
[junit4] 2> 92189 T179 C49 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: the.properties
[junit4] 2> 92189 T179 C49 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92189 T179 C49 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 92191 T179 C49 oashd.JdbcDataSource$1.call Time taken for getConnection(): 2
[junit4] 2> 92299 T179 C49 oashd.DocBuilder.finish Import completed successfully
[junit4] 2> 92299 T179 C49 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92304 T179 C49 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_6,generation=6}
[junit4] 2> 92304 T179 C49 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 92305 T179 C49 oass.SolrIndexSearcher.<init> Opening Searcher@e93e296 main
[junit4] 2> 92305 T179 C49 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92306 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@e93e296 main{StandardDirectoryReader(segments_6:12:nrt _2(4.6):c20)}
[junit4] 2> 92309 T182 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=3
[junit4] 2> 92310 T182 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=1
[junit4] 2> 92311 T182 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=1
[junit4] 2> 92311 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 92311 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e93e296 main{StandardDirectoryReader(segments_6:12:nrt _2(4.6):c20)}
[junit4] 2> 92313 T179 C49 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: the.properties
[junit4] 2> 92314 T179 C49 oashd.SimplePropertiesWriter.persist Wrote last indexed time to the.properties
[junit4] 2> 92315 T179 C49 oashd.DocBuilder.execute Time taken = 0:0:0.126
[junit4] 2> 92315 T179 C49 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={indent=true&clean=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D".\test7951551372578969688tmp"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;"+/>+%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.People.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.People.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.People.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&command=full-import&synchronous=true} {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 0 149
[junit4] 2> 92325 T179 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2} hits=20 status=0 QTime=1
[junit4] 2> 92335 T179 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=1
[junit4] 2> 92335 T179 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=0
[junit4] 2> 92337 T179 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 92351 T179 C49 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 92351 T179 C49 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> 92355 T179 C49 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4] 2> 92355 T179 C49 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 92356 T179 C49 oashd.DocBuilder.doDelta Starting delta collection.
[junit4] 2> 92356 T179 C49 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4] 2> 92357 T179 C49 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 92357 T179 C49 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4] 2> 92364 T179 C49 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 0
[junit4] 2> 92364 T179 C49 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 0
[junit4] 2> 92365 T179 C49 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4] 2> 92365 T179 C49 oashd.DocBuilder.doDelta Delta Import completed successfully
[junit4] 2> 92365 T179 C49 oashd.DocBuilder.execute Time taken = 0:0:0.9
[junit4] 2> 92366 T179 C49 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={indent=true&clean=false&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D".\test7951551372578969688tmp"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;"+/>+%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.People.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.People.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.People.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&command=delta-import&synchronous=true} {} 0 24
[junit4] 2> 92368 T179 C49 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2} hits=20 status=0 QTime=1
[junit4] 2> 92375 T179 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: xpath=//*[@numFound='16']
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="start">0</str><str name="q">AddAColumn_s:Added</str><str name="qt">standard</str><str name="rows">20</str><str name="version">2.2</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="NAME_mult_s"><str>Jacob</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">1</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Ethan</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">2</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Michael</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">3</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Jayden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="id">4</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>William</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="id">5</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Alexander</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">6</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Noah</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">7</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Daniel</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">8</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Aiden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">9</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Anthony</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">10</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Emma</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">11</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Grace</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">12</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Hailey</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">13</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Isabella</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">14</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Lily</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">15</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Madison</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="id">16</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Mia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="id">17</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Natalie</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">18</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Olivia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">19</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Samantha</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">20</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2
[junit4] 2> 92376 T179 oasc.SolrException.log ERROR REQUEST FAILED: start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='16']
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="start">0</str><str name="q">AddAColumn_s:Added</str><str name="qt">standard</str><str name="rows">20</str><str name="version">2.2</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="NAME_mult_s"><str>Jacob</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">1</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Ethan</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">2</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Michael</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">3</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Jayden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="id">4</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>William</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="id">5</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Alexander</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">6</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Noah</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">7</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Daniel</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">8</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Aiden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">9</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Anthony</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">10</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Emma</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">11</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Grace</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">12</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Hailey</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">13</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Isabella</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">14</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Lily</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">15</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Madison</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="id">16</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Mia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="id">17</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Natalie</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">18</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Olivia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">19</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Samantha</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">20</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:630)
[junit4] 2> at org.apache.solr.handler.dataimport.AbstractSqlEntityProcessorTestCase.simpleTransform(AbstractSqlEntityProcessorTestCase.java:116)
[junit4] 2> at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithSimpleTransformer(TestSqlEntityProcessorDelta.java:58)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 92386 T179 oashd.AbstractDataImportHandlerTestCase.tearDown Looking for dataimport.properties at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\solr\collection1\conf\dataimport.properties
[junit4] 2> 92386 T179 oas.SolrTestCaseJ4.tearDown ###Ending testWithSimpleTransformer
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSqlEntityProcessorDelta -Dtests.method=testWithSimpleTransformer -Dtests.seed=146D44F20B6F1293 -Dtests.slow=true -Dtests.locale=ja_JP -Dtests.timezone=Atlantic/Jan_Mayen -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.89s | TestSqlEntityProcessorDelta.testWithSimpleTransformer <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([146D44F20B6F1293:7B296C18D1B97E9E]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:637)
[junit4] > at org.apache.solr.handler.dataimport.AbstractSqlEntityProcessorTestCase.simpleTransform(AbstractSqlEntityProcessorTestCase.java:116)
[junit4] > at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta.testWithSimpleTransformer(TestSqlEntityProcessorDelta.java:58)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//*[@numFound='16']
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int><lst name="params"><str name="start">0</str><str name="q">AddAColumn_s:Added</str><str name="qt">standard</str><str name="rows">20</str><str name="version">2.2</str></lst></lst><result name="response" numFound="20" start="0"><doc><arr name="NAME_mult_s"><str>Jacob</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">1</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Ethan</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">2</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Michael</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">3</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Jayden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NP</str></arr><str name="id">4</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>William</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NO</str></arr><str name="id">5</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Alexander</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">6</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Noah</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">7</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Daniel</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">8</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Aiden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">9</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Anthony</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">10</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Emma</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">11</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Grace</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">12</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Hailey</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">13</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Isabella</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">14</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Lily</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">15</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Madison</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="id">16</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Mia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="id">17</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Natalie</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">18</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Olivia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">19</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc><doc><arr name="NAME_mult_s"><str>Samantha</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">20</str><str name="AddAColumn_s">Added</str><date name="timestamp">2013-10-27T00:04:15.902Z</date></doc></result>
[junit4] > </response>
[junit4] > request was:start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:630)
[junit4] > ... 42 more
[junit4] 2> 92442 T179 oas.SolrTestCaseJ4.setUp ###Starting testWithComplexTransformer
[junit4] 2> ASYNC NEW_CORE C50 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 92469 T179 C50 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92470 T179 C50 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 4
[junit4] 2> 92480 T179 C50 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92480 T179 C50 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_7,generation=7}
[junit4] 2> 92480 T179 C50 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 92480 T179 C50 oass.SolrIndexSearcher.<init> Opening Searcher@67d6928d main
[junit4] 2> 92481 T179 C50 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92482 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@67d6928d main{StandardDirectoryReader(segments_7:13:nrt)}
[junit4] 2> 92482 T182 C50 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 92483 T182 C50 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=0
[junit4] 2> 92483 T182 C50 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=0
[junit4] 2> 92484 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 92484 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@67d6928d main{StandardDirectoryReader(segments_7:13:nrt)}
[junit4] 2> 92485 T179 C50 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> ASYNC NEW_CORE C51 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 92854 T179 C51 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 92854 T179 C51 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> 92857 T179 C51 oashd.DataImporter.doFullImport Starting Full Import
[junit4] 2> 92859 T179 C51 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: the.properties
[junit4] 2> 92860 T179 C51 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92860 T179 C51 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:derby:memory:derbyDB;
[junit4] 2> 92862 T179 C51 oashd.JdbcDataSource$1.call Time taken for getConnection(): 2
[junit4] 2> 92958 T179 C51 oashd.DocBuilder.finish Import completed successfully
[junit4] 2> 92958 T179 C51 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92969 T179 C51 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@358e3609 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1ac05bcb),segFN=segments_8,generation=8}
[junit4] 2> 92970 T179 C51 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> ASYNC NEW_CORE C52 name=collection1 org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 92985 T179 C52 oass.SolrIndexSearcher.<init> Opening Searcher@6e7e15e0 main
[junit4] 2> 92986 T179 C52 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92989 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6e7e15e0 main{StandardDirectoryReader(segments_8:16:nrt _3(4.6):c60)}
[junit4] 2> 92990 T182 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=solr&distrib=false&rows=10} hits=0 status=0 QTime=1
[junit4] 2> 92991 T182 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&event=newSearcher&q=rocks&distrib=false&rows=10} hits=0 status=0 QTime=1
[junit4] 2> 92991 T182 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false} hits=0 status=0 QTime=0
[junit4] 2> 92991 T182 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 92991 T182 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e7e15e0 main{StandardDirectoryReader(segments_8:16:nrt _3(4.6):c60)}
[junit4] 2> 92993 T179 C52 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: the.properties
[junit4] 2> 92995 T179 C52 oashd.SimplePropertiesWriter.persist Wrote last indexed time to the.properties
[junit4] 2> 92995 T179 C52 oashd.DocBuilder.execute Time taken = 0:0:0.136
[junit4] 2> 92996 T179 C52 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={indent=true&clean=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D".\test3787503425173136085tmp"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+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.People.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.People.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.People.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&command=full-import&synchronous=true} {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 149
[junit4] 2> 93187 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={sort=id+asc&q=*:*&rows=60} hits=60 status=0 QTime=169
[junit4] 2> 93209 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:TripleThreat-1-*&qt=standard&rows=20&version=2.2} hits=20 status=0 QTime=1
[junit4] 2> 93215 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:TripleThreat-2-*&qt=standard&rows=20&version=2.2} hits=20 status=0 QTime=2
[junit4] 2> 93249 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=8
[junit4] 2> 93253 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=AddAColumn_s:Added&qt=standard&rows=20&version=2.2} hits=20 status=0 QTime=0
[junit4] 2> 93257 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=0
[junit4] 2> 93258 T179 C52 oasc.SolrCore.execute [collection1] webapp=null path=null params={indent=true} status=0 QTime=0
[junit4] 2> 93259 T179 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 93291 T179 C52 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 93291 T179 C52 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> 93294 T179 C52 oashd.DataImporter.doDeltaImport Starting Delta Import
[junit4] 2> 93296 T179 C52 oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 93297 T179 C52 oashd.DocBuilder.doDelta Starting delta collection.
[junit4] 2> 93297 T179 C52 oashd.DocBuilder.collectDelta Running ModifiedRowKey() for Entity: People
[junit4] 2> 93297 T179 C52 oashd.JdbcDataSource$1.call Creating a connection for entity People with URL: jdbc:derby:memory:derbyDB;
[junit4] 2> 93298 T179 C52 oashd.JdbcDataSource$1.call Time taken for getConnection(): 1
[junit4] 2> 93315 T179 C52 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 93321 T179 C52 oashd.DocBuilder.collectDelta Completed ModifiedRowKey for Entity: People rows obtained : 6
[junit4] 2> 93321 T179 C52 oashd.DocBuilder.collectDelta Completed DeletedRowKey for Entity: People rows obtained : 4
[junit4] 2> 93321 T179 C52 oashd.DocBuilder.collectDelta Completed parentDeltaQuery for Entity: People
[junit4] 2> 93322 T179 C52 oashd.DocBuilder.deleteAll Deleting stale documents
[junit4] 2> 93324 T179 C52 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 93324 T179 C52 oashd.SolrWriter.deleteDoc Deleting document: 11
[junit4] 2> 93324 T179 C52 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 93324 T179 C52 oashd.SolrWriter.deleteDoc Deleting document: 4
[junit4] 2> 93324 T179 C52 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 93324 T179 C52 oashd.SolrWriter.deleteDoc Deleting document: 5
[junit4] 2> 93324 T179 C52 oashd.DocBuilder.findMatchingPkColumn Resolving deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 93324 T179 C52 oashd.SolrWriter.deleteDoc Deleting document: 7
[junit4
[...truncated too long message...]
<str>NO</str></arr><str name="id">5</str><arr name="SPORT_NAME_mult_s"><str>Synchronized diving</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Alexander</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">6</str><arr name="SPORT_NAME_mult_s"><str>Underwater rugby</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Noah</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">7</str><arr name="SPORT_NAME_mult_s"><str>Boating</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Daniel</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">8</str><arr name="SPORT_NAME_mult_s"><str>Bodyboarding</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Aiden</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">9</str><arr name="SPORT_NAME_mult_s"><str>Canoeing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Anthony</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">10</str><arr name="SPORT_NAME_mult_s"><str>Fishing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Emma</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NL</str></arr><str name="id">11</str><arr name="SPORT_NAME_mult_s"><str>Jet Ski</str><str>Rowing</str><str>Sailing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Grace</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NI</str></arr><str name="id">12</str><arr name="SPORT_NAME_mult_s"><str>Kayaking</str><str>Canoeing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Hailey</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NG</str></arr><str name="id">13</str><arr name="SPORT_NAME_mult_s"><str>Kite surfing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Isabella</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NF</str></arr><str name="id">14</str><arr name="SPORT_NAME_mult_s"><str>Parasailing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Lily</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NE</str></arr><str name="id">15</str><arr name="SPORT_NAME_mult_s"><str>Rafting</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Madison</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NC</str></arr><str name="id">16</str><arr name="SPORT_NAME_mult_s"><str>Rowing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Mia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NA</str></arr><str name="id">17</str><arr name="SPORT_NAME_mult_s"><str>Sailing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Natalie</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NZ</str></arr><str name="id">18</str><arr name="SPORT_NAME_mult_s"><str>White Water Rafting</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Olivia</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NU</str></arr><str name="id">19</str><arr name="SPORT_NAME_mult_s"><str>Water skiing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc><doc><arr name="NAME_mult_s"><str>Samantha</str></arr><arr name="COUNTRY_CODES_mult_s"><str>NR</str></arr><str name="id">20</str><arr name="SPORT_NAME_mult_s"><str>Windsurfing</str></arr><str name="sportsAdded_s">sport_added</str><date name="timestamp">2013-10-27T00:04:17.833Z</date></doc></result>
[junit4] > </response>
[junit4] > request was:start=0&q=*:*&qt=standard&rows=20&version=2.2
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:630)
[junit4] > ... 42 more
[junit4] 2> 94318 T179 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 94318 T179 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2137098142
[junit4] 2> 94320 T179 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@34ca6c3e
[junit4] 2> 94321 T179 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=141,cumulative_deletesById=7,cumulative_deletesByQuery=8,cumulative_errors=0}
[junit4] 2> 94321 T179 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 94321 T179 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 94321 T179 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 94325 T179 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 94329 T179 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 94329 T179 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\index;done=false>>]
[junit4] 2> 94329 T179 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\index
[junit4] 2> 94392 T179 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\;done=false>>]
[junit4] 2> 94393 T179 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\solrtest-TestSqlEntityProcessorDelta-1382832252297\
[junit4] 2> NOTE: test params are: codec=Lucene45: {timestamp=PostingsFormat(name=MockSep), id=PostingsFormat(name=Asserting), COUNTRY_CODES_mult_s=PostingsFormat(name=MockSep), SPORT_NAME_mult_s=PostingsFormat(name=SimpleText), AddAColumn_s=PostingsFormat(name=MockSep), sportsAdded_s=PostingsFormat(name=Asserting), NAME_mult_s=Pulsing41(freqCutoff=4 minBlockSize=85 maxBlockSize=214)}, docValues:{}, sim=DefaultSimilarity, locale=ja_JP, timezone=Atlantic/Jan_Mayen
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_45 (64-bit)/cpus=2,threads=1,free=3482872,total=48820224
[junit4] 2> NOTE: All tests run in this JVM: [TestSimplePropertiesWriter, TestTemplateTransformer, TestXPathRecordReader, TestDataConfig, TestFileListEntityProcessor, TestEphemeralCache, TestZKPropertiesWriter, TestBuiltInEvaluators, TestScriptTransformer, TestLineEntityProcessor, TestRegexTransformer, TestDocBuilder2, TestURLDataSource, TestSolrEntityProcessorEndToEnd, TestDateFormatTransformer, TestErrorHandling, TestFileListWithLineEntityProcessor, TestVariableResolver, TestSqlEntityProcessorDelta]
[junit4] Completed in 5.88s, 4 tests, 2 errors <<< FAILURES!
[...truncated 58 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:428: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:408: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:209: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:451: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:483: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1263: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:906: There were test failures: 35 suites, 143 tests, 2 errors, 3 ignored
Total time: 90 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_45 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure