Regression

org.apache.spark.sql.hive.thriftserver.CliSuite.path

Failing for the past 1 build (Since #5041 )
Took 1 min 5 sec.

Error Message

org.scalatest.exceptions.TestFailedException:  ======================= CliSuite failure output ======================= Spark SQL CLI command line: ../../bin/spark-sql --master local --driver-java-options -Dderby.system.durability=test --conf spark.ui.enabled=false --hiveconf javax.jdo.option.ConnectionURL=jdbc:derby:;databaseName=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-324ebca6-302c-4186-b066-51ee744d1934;create=true --hiveconf hive.exec.scratchdir=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-522a4a28-d4a3-4b69-ada0-e4cc8b6d0a04 --hiveconf conf1=conftest --hiveconf conf2=1 --hiveconf hive.metastore.warehouse.dir=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-ce7bffee-46c8-473e-baec-44eb80dc4b5c --conf spark.hadoop.hive.aux.jars.path=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar Exception: java.util.concurrent.TimeoutException: Futures timed out after [1 minute] Failed to capture next expected output "135" within 1 minute.  2020-05-15 10:28:13.147 - stderr> SLF4J: Class path contains multiple SLF4J bindings. 2020-05-15 10:28:13.147 - stderr> SLF4J: Found binding in [jar:file:/home/jenkins/workspace/NewSparkPullRequestBuilder@2/assembly/target/scala-2.12/jars/slf4j-log4j12-1.7.30.jar!/org/slf4j/impl/StaticLoggerBinder.class] 2020-05-15 10:28:13.15 - stderr> SLF4J: Found binding in [jar:file:/home/sparkivy/per-executor-caches/9/.ivy2/cache/org.slf4j/slf4j-log4j12/jars/slf4j-log4j12-1.7.30.jar!/org/slf4j/impl/StaticLoggerBinder.class] 2020-05-15 10:28:13.151 - stderr> SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. 2020-05-15 10:28:13.151 - stderr> SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory] 2020-05-15 10:28:56.25 - stdout> ADD JAR /home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar 2020-05-15 10:28:56.368 - stderr> Added [/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar] to class path 2020-05-15 10:28:56.368 - stderr> Added resources: [/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar] 2020-05-15 10:28:57.473 - stderr> Spark master: local, Application Id: local-1589563704631 2020-05-15 10:28:57.519 - stdout> spark-sql> CREATE TEMPORARY FUNCTION example_format AS 'org.apache.hadoop.hive.contrib.udf.example.UDFExampleFormat'; 2020-05-15 10:29:06.19 - stderr> Time taken: 8.611 seconds 2020-05-15 10:29:06.255 - stdout> spark-sql> SELECT example_format('%o', 93); =========================== End CliSuite failure output ===========================          

Stacktrace

sbt.ForkMain$ForkError: org.scalatest.exceptions.TestFailedException: 
=======================
CliSuite failure output
=======================
Spark SQL CLI command line: ../../bin/spark-sql --master local --driver-java-options -Dderby.system.durability=test --conf spark.ui.enabled=false --hiveconf javax.jdo.option.ConnectionURL=jdbc:derby:;databaseName=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-324ebca6-302c-4186-b066-51ee744d1934;create=true --hiveconf hive.exec.scratchdir=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-522a4a28-d4a3-4b69-ada0-e4cc8b6d0a04 --hiveconf conf1=conftest --hiveconf conf2=1 --hiveconf hive.metastore.warehouse.dir=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-ce7bffee-46c8-473e-baec-44eb80dc4b5c --conf spark.hadoop.hive.aux.jars.path=/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar
Exception: java.util.concurrent.TimeoutException: Futures timed out after [1 minute]
Failed to capture next expected output "135" within 1 minute.

2020-05-15 10:28:13.147 - stderr> SLF4J: Class path contains multiple SLF4J bindings.
2020-05-15 10:28:13.147 - stderr> SLF4J: Found binding in [jar:file:/home/jenkins/workspace/NewSparkPullRequestBuilder@2/assembly/target/scala-2.12/jars/slf4j-log4j12-1.7.30.jar!/org/slf4j/impl/StaticLoggerBinder.class]
2020-05-15 10:28:13.15 - stderr> SLF4J: Found binding in [jar:file:/home/sparkivy/per-executor-caches/9/.ivy2/cache/org.slf4j/slf4j-log4j12/jars/slf4j-log4j12-1.7.30.jar!/org/slf4j/impl/StaticLoggerBinder.class]
2020-05-15 10:28:13.151 - stderr> SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
2020-05-15 10:28:13.151 - stderr> SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
2020-05-15 10:28:56.25 - stdout> ADD JAR /home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar
2020-05-15 10:28:56.368 - stderr> Added [/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar] to class path
2020-05-15 10:28:56.368 - stderr> Added resources: [/home/jenkins/workspace/NewSparkPullRequestBuilder@2/target/tmp/spark-9dd7d2d2-019c-48f3-87ce-2ae18549935a/hive-contrib-2.3.7.jar]
2020-05-15 10:28:57.473 - stderr> Spark master: local, Application Id: local-1589563704631
2020-05-15 10:28:57.519 - stdout> spark-sql> CREATE TEMPORARY FUNCTION example_format AS 'org.apache.hadoop.hive.contrib.udf.example.UDFExampleFormat';
2020-05-15 10:29:06.19 - stderr> Time taken: 8.611 seconds
2020-05-15 10:29:06.255 - stdout> spark-sql> SELECT example_format('%o', 93);
===========================
End CliSuite failure output
===========================
         
	at org.scalatest.Assertions.newAssertionFailedException(Assertions.scala:530)
	at org.scalatest.Assertions.newAssertionFailedException$(Assertions.scala:529)
	at org.scalatest.FunSuite.newAssertionFailedException(FunSuite.scala:1560)
	at org.scalatest.Assertions.fail(Assertions.scala:1107)
	at org.scalatest.Assertions.fail$(Assertions.scala:1103)
	at org.scalatest.FunSuite.fail(FunSuite.scala:1560)
	at org.apache.spark.sql.hive.thriftserver.CliSuite.runCliWithin(CliSuite.scala:192)
	at org.apache.spark.sql.hive.thriftserver.CliSuite.$anonfun$new$17(CliSuite.scala:409)
	at scala.runtime.java8.JFunction0$mcV$sp.apply(JFunction0$mcV$sp.java:23)
	at org.scalatest.OutcomeOf.outcomeOf(OutcomeOf.scala:85)
	at org.scalatest.OutcomeOf.outcomeOf$(OutcomeOf.scala:83)
	at org.scalatest.OutcomeOf$.outcomeOf(OutcomeOf.scala:104)
	at org.scalatest.Transformer.apply(Transformer.scala:22)
	at org.scalatest.Transformer.apply(Transformer.scala:20)
	at org.scalatest.FunSuiteLike$$anon$1.apply(FunSuiteLike.scala:186)
	at org.apache.spark.SparkFunSuite.withFixture(SparkFunSuite.scala:151)
	at org.scalatest.FunSuiteLike.invokeWithFixture$1(FunSuiteLike.scala:184)
	at org.scalatest.FunSuiteLike.$anonfun$runTest$1(FunSuiteLike.scala:196)
	at org.scalatest.SuperEngine.runTestImpl(Engine.scala:286)
	at org.scalatest.FunSuiteLike.runTest(FunSuiteLike.scala:196)
	at org.scalatest.FunSuiteLike.runTest$(FunSuiteLike.scala:178)
	at org.apache.spark.SparkFunSuite.org$scalatest$BeforeAndAfterEach$$super$runTest(SparkFunSuite.scala:58)
	at org.scalatest.BeforeAndAfterEach.runTest(BeforeAndAfterEach.scala:221)
	at org.scalatest.BeforeAndAfterEach.runTest$(BeforeAndAfterEach.scala:214)
	at org.apache.spark.SparkFunSuite.runTest(SparkFunSuite.scala:58)
	at org.scalatest.FunSuiteLike.$anonfun$runTests$1(FunSuiteLike.scala:229)
	at org.scalatest.SuperEngine.$anonfun$runTestsInBranch$1(Engine.scala:393)
	at scala.collection.immutable.List.foreach(List.scala:392)
	at org.scalatest.SuperEngine.traverseSubNodes$1(Engine.scala:381)
	at org.scalatest.SuperEngine.runTestsInBranch(Engine.scala:376)
	at org.scalatest.SuperEngine.runTestsImpl(Engine.scala:458)
	at org.scalatest.FunSuiteLike.runTests(FunSuiteLike.scala:229)
	at org.scalatest.FunSuiteLike.runTests$(FunSuiteLike.scala:228)
	at org.scalatest.FunSuite.runTests(FunSuite.scala:1560)
	at org.scalatest.Suite.run(Suite.scala:1124)
	at org.scalatest.Suite.run$(Suite.scala:1106)
	at org.scalatest.FunSuite.org$scalatest$FunSuiteLike$$super$run(FunSuite.scala:1560)
	at org.scalatest.FunSuiteLike.$anonfun$run$1(FunSuiteLike.scala:233)
	at org.scalatest.SuperEngine.runImpl(Engine.scala:518)
	at org.scalatest.FunSuiteLike.run(FunSuiteLike.scala:233)
	at org.scalatest.FunSuiteLike.run$(FunSuiteLike.scala:232)
	at org.apache.spark.SparkFunSuite.org$scalatest$BeforeAndAfterAll$$super$run(SparkFunSuite.scala:58)
	at org.scalatest.BeforeAndAfterAll.liftedTree1$1(BeforeAndAfterAll.scala:213)
	at org.scalatest.BeforeAndAfterAll.run(BeforeAndAfterAll.scala:210)
	at org.scalatest.BeforeAndAfterAll.run$(BeforeAndAfterAll.scala:208)
	at org.apache.spark.SparkFunSuite.run(SparkFunSuite.scala:58)
	at org.scalatest.tools.Framework.org$scalatest$tools$Framework$$runSuite(Framework.scala:317)
	at org.scalatest.tools.Framework$ScalaTestTask.execute(Framework.scala:510)
	at sbt.ForkMain$Run$2.call(ForkMain.java:296)
	at sbt.ForkMain$Run$2.call(ForkMain.java:286)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
Caused by: sbt.ForkMain$ForkError: java.util.concurrent.TimeoutException: Futures timed out after [1 minute]
	at scala.concurrent.impl.Promise$DefaultPromise.ready(Promise.scala:259)
	at scala.concurrent.impl.Promise$DefaultPromise.result(Promise.scala:263)
	at org.apache.spark.util.ThreadUtils$.awaitResult(ThreadUtils.scala:294)
	at org.apache.spark.sql.hive.thriftserver.CliSuite.runCliWithin(CliSuite.scala:174)
	... 47 more