You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@tajo.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/08/05 10:20:07 UTC

Build failed in Jenkins: Tajo-master-build #326

See <https://builds.apache.org/job/Tajo-master-build/326/changes>

Changes:

[jinossy] TAJO-949: PullServer does not release files, when a channel throws an internal exception. (jinho)

------------------------------------------
[...truncated 1220 lines...]
INFO: block read in memory in 1 ms. row count = 1
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.044 sec
Running org.apache.tajo.storage.TestLazyTuple
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
Running org.apache.tajo.storage.v2.TestStorages
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: Flushing mem store to file. allocated memory: 51,131,316
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 34B for [col1] BOOLEAN: 1 values, 7B raw, 7B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 43B for [col2] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 56B for [col3] BINARY: 1 values, 17B raw, 17B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 43B for [col4] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 43B for [col5] INT32: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 55B for [col6] INT64: 1 values, 14B raw, 14B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 43B for [col7] FLOAT: 1 values, 10B raw, 10B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 55B for [col8] DOUBLE: 1 values, 14B raw, 14B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 56B for [col9] BINARY: 1 values, 17B raw, 17B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 56B for [col10] BINARY: 1 values, 17B raw, 17B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 47B for [col11] BINARY: 1 values, 14B raw, 14B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: RecordReader initialized will read a total of 1 records.
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: at row 0. reading next block
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: block read in memory in 1 ms. row count = 1
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: Flushing mem store to file. allocated memory: 34,044,142
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 40,047B for [id] INT32: 10,000 values, 40,008B raw, 40,008B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 80,055B for [age] INT64: 10,000 values, 80,008B raw, 80,008B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: written 40,047B for [score] FLOAT: 10,000 values, 40,008B raw, 40,008B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: RecordReader initialized will read a total of 10000 records.
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: at row 0. reading next block
Aug 5, 2014 8:19:18 AM parquet.Log info
INFO: block read in memory in 1 ms. row count = 10000
Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.353 sec
Running org.apache.tajo.storage.v2.TestCSVScanner
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.839 sec
Running org.apache.tajo.storage.v2.TestCSVCompression
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.208 sec
Running org.apache.tajo.storage.index.TestSingleCSVFileBSTIndex
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.934 sec
Running org.apache.tajo.storage.index.TestBSTIndex
Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.482 sec
Running org.apache.tajo.storage.TestFileSystems
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.018 sec
Running org.apache.tajo.storage.TestStorageManager
Formatting using clusterid: testClusterID
Formatting using clusterid: testClusterID
Tests run: 3, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 2.281 sec <<< FAILURE!
testGetSplit(org.apache.tajo.storage.TestStorageManager)  Time elapsed: 1.809 sec  <<< ERROR!
java.net.UnknownHostException: asf901.ygridcore.net: asf901.ygridcore.net
	at java.net.InetAddress.getLocalHost(InetAddress.java:1402)
	at org.apache.hadoop.security.SecurityUtil.getLocalHostName(SecurityUtil.java:186)
	at org.apache.hadoop.security.SecurityUtil.login(SecurityUtil.java:206)
	at org.apache.hadoop.hdfs.server.datanode.DataNode.instantiateDataNode(DataNode.java:1746)
	at org.apache.hadoop.hdfs.MiniDFSCluster.startDataNodes(MiniDFSCluster.java:1218)
	at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:684)
	at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:351)
	at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:332)
	at org.apache.tajo.storage.TestStorageManager.testGetSplit(TestStorageManager.java:110)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

testGetSplitWithBlockStorageLocationsBatching(org.apache.tajo.storage.TestStorageManager)  Time elapsed: 0.432 sec  <<< ERROR!
java.net.UnknownHostException: asf901.ygridcore.net: asf901.ygridcore.net
	at java.net.InetAddress.getLocalHost(InetAddress.java:1402)
	at org.apache.hadoop.security.SecurityUtil.getLocalHostName(SecurityUtil.java:186)
	at org.apache.hadoop.security.SecurityUtil.login(SecurityUtil.java:206)
	at org.apache.hadoop.hdfs.server.datanode.DataNode.instantiateDataNode(DataNode.java:1746)
	at org.apache.hadoop.hdfs.MiniDFSCluster.startDataNodes(MiniDFSCluster.java:1218)
	at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:684)
	at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:351)
	at org.apache.hadoop.hdfs.MiniDFSCluster$Builder.build(MiniDFSCluster.java:332)
	at org.apache.tajo.storage.TestStorageManager.testGetSplitWithBlockStorageLocationsBatching(TestStorageManager.java:165)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

Running org.apache.tajo.storage.TestFrameTuple
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Running org.apache.tajo.storage.TestVTuple
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
Running org.apache.tajo.storage.TestTupleComparator
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
Running org.apache.tajo.storage.TestMergeScanner
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: Flushing mem store to file. allocated memory: 36,271,037
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 40,047B for [id] INT32: 10,000 values, 40,008B raw, 40,008B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 53B for [file] BINARY: 10,000 values, 12B raw, 12B comp, 1 pages, encodings: [BIT_PACKED, PLAIN_DICTIONARY, RLE], dic { 1 entries, 11B raw, 1B comp}
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 51B for [name] BINARY: 10,000 values, 12B raw, 12B comp, 1 pages, encodings: [BIT_PACKED, PLAIN_DICTIONARY, RLE], dic { 1 entries, 10B raw, 1B comp}
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 55B for [age] INT64: 10,000 values, 12B raw, 12B comp, 1 pages, encodings: [BIT_PACKED, PLAIN_DICTIONARY, RLE], dic { 1 entries, 8B raw, 1B comp}
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: Flushing mem store to file. allocated memory: 36,271,037
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 40,047B for [id] INT32: 10,000 values, 40,008B raw, 40,008B comp, 1 pages, encodings: [PLAIN, BIT_PACKED, RLE]
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 53B for [file] BINARY: 10,000 values, 12B raw, 12B comp, 1 pages, encodings: [BIT_PACKED, PLAIN_DICTIONARY, RLE], dic { 1 entries, 11B raw, 1B comp}
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 51B for [name] BINARY: 10,000 values, 12B raw, 12B comp, 1 pages, encodings: [BIT_PACKED, PLAIN_DICTIONARY, RLE], dic { 1 entries, 10B raw, 1B comp}
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: written 55B for [age] INT64: 10,000 values, 12B raw, 12B comp, 1 pages, encodings: [BIT_PACKED, PLAIN_DICTIONARY, RLE], dic { 1 entries, 8B raw, 1B comp}
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: RecordReader initialized will read a total of 10000 records.
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: at row 0. reading next block
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: block read in memory in 0 ms. row count = 10000
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: RecordReader initialized will read a total of 10000 records.
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: at row 0. reading next block
Aug 5, 2014 8:19:46 AM parquet.Log info
INFO: block read in memory in 0 ms. row count = 10000
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.929 sec
Aug 5, 2014 8:19:10 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:11 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:11 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:17 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:18 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:18 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:46 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers
Aug 5, 2014 8:19:46 AM INFO: parquet.hadoop.ParquetFileReader: reading another 1 footers

Results :

Tests in error: 
  testGetSplit(org.apache.tajo.storage.TestStorageManager): asf901.ygridcore.net: asf901.ygridcore.net
  testGetSplitWithBlockStorageLocationsBatching(org.apache.tajo.storage.TestStorageManager): asf901.ygridcore.net: asf901.ygridcore.net

Tests run: 155, Failures: 0, Errors: 2, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [ 16.052 s]
[INFO] Tajo Project POM .................................. SUCCESS [  0.821 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  2.764 s]
[INFO] Tajo Common ....................................... SUCCESS [ 38.684 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  1.418 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.550 s]
[INFO] Tajo Rpc .......................................... SUCCESS [ 21.364 s]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.028 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [  5.843 s]
[INFO] Tajo Storage ...................................... FAILURE [ 43.200 s]
[INFO] Tajo Core PullServer .............................. SKIPPED
[INFO] Tajo Client ....................................... SKIPPED
[INFO] Tajo JDBC Driver .................................. SKIPPED
[INFO] Tajo Core ......................................... SKIPPED
[INFO] Tajo Catalog Drivers .............................. SKIPPED
[INFO] Tajo Catalog ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 02:17 min
[INFO] Finished at: 2014-08-05T08:19:47+00:00
[INFO] Final Memory: 46M/662M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.12.4:test (default-test) on project tajo-storage: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/Tajo-master-build/ws/tajo-storage/target/surefire-reports> for the individual test results.
[ERROR] -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :tajo-storage
Build step 'Execute shell' marked build as failure
Updating TAJO-949

Jenkins build is back to normal : Tajo-master-build #327

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-master-build/327/changes>