You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@spark.apache.org by "M. Le Bihan (JIRA)" <ji...@apache.org> on 2019/06/03 06:19:00 UTC

[jira] [Comment Edited] (SPARK-18105) LZ4 failed to decompress a stream of shuffled data

    [ https://issues.apache.org/jira/browse/SPARK-18105?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16854249#comment-16854249 ] 

M. Le Bihan edited comment on SPARK-18105 at 6/3/19 6:18 AM:
-------------------------------------------------------------

I have also a problem involving a corrupted stream by LZ4, using Spark 2.4.3.

As extra info, it is sometimes replaced by an alternative issue :
{code:java}
2019-06-03 08:12:20.673  INFO 20023 --- [ver-heartbeater] o.a.spark.storage.BlockManagerMaster     : Registered BlockManager BlockManagerId(driver, 192.168.0.12, 34105, None)
2019-06-03 08:12:20.673  INFO 20023 --- [ver-heartbeater] org.apache.spark.storage.BlockManager    : Reporting 7 blocks to the master.
2019-06-03 08:12:20.676  INFO 20023 --- [er-event-loop-1] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_3_piece0 in memory on 192.168.0.12:34105 (size: 21.0 KB, free: 8.2 GB)
2019-06-03 08:12:20.676  INFO 20023 --- [er-event-loop-0] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_7_piece0 in memory on 192.168.0.12:34105 (size: 21.0 KB, free: 8.2 GB)
2019-06-03 08:12:20.677  INFO 20023 --- [er-event-loop-1] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_10_piece1 in memory on 192.168.0.12:34105 (size: 1415.9 KB, free: 8.2 GB)
2019-06-03 08:12:20.678  INFO 20023 --- [er-event-loop-0] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_10_piece0 in memory on 192.168.0.12:34105 (size: 4.0 MB, free: 8.2 GB)
2019-06-03 08:12:20.731 ERROR 20023 --- [ker for task 73] org.apache.spark.MapOutputTracker        : Missing an output location for shuffle 2
2019-06-03 08:12:20.732  WARN 20023 --- [result-getter-1] o.apache.spark.scheduler.TaskSetManager  : Lost task 29.0 in stage 3.0 (TID 73, localhost, executor driver): FetchFailed(null, shuffleId=2, mapId=-1, reduceId=29, message=
org.apache.spark.shuffle.MetadataFetchFailedException: Missing an output location for shuffle 2
    at org.apache.spark.MapOutputTracker$$anonfun$convertMapStatuses$2.apply(MapOutputTracker.scala:882)
    at org.apache.spark.MapOutputTracker$$anonfun$convertMapStatuses$2.apply(MapOutputTracker.scala:878)
    at scala.collection.Iterator$class.foreach(Iterator.scala:891)
    at scala.collection.AbstractIterator.foreach(Iterator.scala:1334)
    at org.apache.spark.MapOutputTracker$.convertMapStatuses(MapOutputTracker.scala:878)
    at org.apache.spark.MapOutputTrackerMaster$$anonfun$getMapSizesByExecutorId$2.apply(MapOutputTracker.scala:655)
    at org.apache.spark.MapOutputTrackerMaster$$anonfun$getMapSizesByExecutorId$2.apply(MapOutputTracker.scala:654)
    at org.apache.spark.ShuffleStatus.withMapStatuses(MapOutputTracker.scala:192)
    at org.apache.spark.MapOutputTrackerMaster.getMapSizesByExecutorId(MapOutputTracker.scala:654)
    at org.apache.spark.shuffle.BlockStoreShuffleReader.read(BlockStoreShuffleReader.scala:49)
    at org.apache.spark.rdd.ShuffledRDD.compute(ShuffledRDD.scala:105)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.scheduler.ShuffleMapTask.runTask(ShuffleMapTask.scala:99)
    at org.apache.spark.scheduler.ShuffleMapTask.runTask(ShuffleMapTask.scala:55)
    at org.apache.spark.scheduler.Task.run(Task.scala:121)
    at org.apache.spark.executor.Executor$TaskRunner$$anonfun$10.apply(Executor.scala:408)
    at org.apache.spark.util.Utils$.tryWithSafeFinally(Utils.scala:1360)
    at org.apache.spark.executor.Executor$TaskRunner.run(Executor.scala:414)
    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){code}
But sometimes, everything works well too.
But not this morning...


was (Author: mlebihan):
I have also a problem involving a corrupted stream by LZ4, using Spark 2.4.3.

It is sometimes replaced by an alternative issue :
{code:java}
2019-06-03 08:12:20.673  INFO 20023 --- [ver-heartbeater] o.a.spark.storage.BlockManagerMaster     : Registered BlockManager BlockManagerId(driver, 192.168.0.12, 34105, None)
2019-06-03 08:12:20.673  INFO 20023 --- [ver-heartbeater] org.apache.spark.storage.BlockManager    : Reporting 7 blocks to the master.
2019-06-03 08:12:20.676  INFO 20023 --- [er-event-loop-1] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_3_piece0 in memory on 192.168.0.12:34105 (size: 21.0 KB, free: 8.2 GB)
2019-06-03 08:12:20.676  INFO 20023 --- [er-event-loop-0] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_7_piece0 in memory on 192.168.0.12:34105 (size: 21.0 KB, free: 8.2 GB)
2019-06-03 08:12:20.677  INFO 20023 --- [er-event-loop-1] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_10_piece1 in memory on 192.168.0.12:34105 (size: 1415.9 KB, free: 8.2 GB)
2019-06-03 08:12:20.678  INFO 20023 --- [er-event-loop-0] o.apache.spark.storage.BlockManagerInfo  : Added broadcast_10_piece0 in memory on 192.168.0.12:34105 (size: 4.0 MB, free: 8.2 GB)
2019-06-03 08:12:20.731 ERROR 20023 --- [ker for task 73] org.apache.spark.MapOutputTracker        : Missing an output location for shuffle 2
2019-06-03 08:12:20.732  WARN 20023 --- [result-getter-1] o.apache.spark.scheduler.TaskSetManager  : Lost task 29.0 in stage 3.0 (TID 73, localhost, executor driver): FetchFailed(null, shuffleId=2, mapId=-1, reduceId=29, message=
org.apache.spark.shuffle.MetadataFetchFailedException: Missing an output location for shuffle 2
    at org.apache.spark.MapOutputTracker$$anonfun$convertMapStatuses$2.apply(MapOutputTracker.scala:882)
    at org.apache.spark.MapOutputTracker$$anonfun$convertMapStatuses$2.apply(MapOutputTracker.scala:878)
    at scala.collection.Iterator$class.foreach(Iterator.scala:891)
    at scala.collection.AbstractIterator.foreach(Iterator.scala:1334)
    at org.apache.spark.MapOutputTracker$.convertMapStatuses(MapOutputTracker.scala:878)
    at org.apache.spark.MapOutputTrackerMaster$$anonfun$getMapSizesByExecutorId$2.apply(MapOutputTracker.scala:655)
    at org.apache.spark.MapOutputTrackerMaster$$anonfun$getMapSizesByExecutorId$2.apply(MapOutputTracker.scala:654)
    at org.apache.spark.ShuffleStatus.withMapStatuses(MapOutputTracker.scala:192)
    at org.apache.spark.MapOutputTrackerMaster.getMapSizesByExecutorId(MapOutputTracker.scala:654)
    at org.apache.spark.shuffle.BlockStoreShuffleReader.read(BlockStoreShuffleReader.scala:49)
    at org.apache.spark.rdd.ShuffledRDD.compute(ShuffledRDD.scala:105)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.rdd.MapPartitionsRDD.compute(MapPartitionsRDD.scala:52)
    at org.apache.spark.rdd.RDD.computeOrReadCheckpoint(RDD.scala:324)
    at org.apache.spark.rdd.RDD.iterator(RDD.scala:288)
    at org.apache.spark.scheduler.ShuffleMapTask.runTask(ShuffleMapTask.scala:99)
    at org.apache.spark.scheduler.ShuffleMapTask.runTask(ShuffleMapTask.scala:55)
    at org.apache.spark.scheduler.Task.run(Task.scala:121)
    at org.apache.spark.executor.Executor$TaskRunner$$anonfun$10.apply(Executor.scala:408)
    at org.apache.spark.util.Utils$.tryWithSafeFinally(Utils.scala:1360)
    at org.apache.spark.executor.Executor$TaskRunner.run(Executor.scala:414)
    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){code}


)

> LZ4 failed to decompress a stream of shuffled data
> --------------------------------------------------
>
>                 Key: SPARK-18105
>                 URL: https://issues.apache.org/jira/browse/SPARK-18105
>             Project: Spark
>          Issue Type: Bug
>          Components: Spark Core
>            Reporter: Davies Liu
>            Assignee: Davies Liu
>            Priority: Major
>
> When lz4 is used to compress the shuffle files, it may fail to decompress it as "stream is corrupt"
> {code}
> Caused by: org.apache.spark.SparkException: Job aborted due to stage failure: Task 92 in stage 5.0 failed 4 times, most recent failure: Lost task 92.3 in stage 5.0 (TID 16616, 10.0.27.18): java.io.IOException: Stream is corrupted
> 	at org.apache.spark.io.LZ4BlockInputStream.refill(LZ4BlockInputStream.java:220)
> 	at org.apache.spark.io.LZ4BlockInputStream.available(LZ4BlockInputStream.java:109)
> 	at java.io.BufferedInputStream.read(BufferedInputStream.java:353)
> 	at java.io.DataInputStream.read(DataInputStream.java:149)
> 	at com.google.common.io.ByteStreams.read(ByteStreams.java:828)
> 	at com.google.common.io.ByteStreams.readFully(ByteStreams.java:695)
> 	at org.apache.spark.sql.execution.UnsafeRowSerializerInstance$$anon$3$$anon$1.next(UnsafeRowSerializer.scala:127)
> 	at org.apache.spark.sql.execution.UnsafeRowSerializerInstance$$anon$3$$anon$1.next(UnsafeRowSerializer.scala:110)
> 	at scala.collection.Iterator$$anon$13.next(Iterator.scala:372)
> 	at scala.collection.Iterator$$anon$11.next(Iterator.scala:328)
> 	at org.apache.spark.util.CompletionIterator.next(CompletionIterator.scala:30)
> 	at org.apache.spark.InterruptibleIterator.next(InterruptibleIterator.scala:43)
> 	at scala.collection.Iterator$$anon$11.next(Iterator.scala:328)
> 	at org.apache.spark.sql.catalyst.expressions.GeneratedClass$GeneratedIterator.sort_addToSorter$(Unknown Source)
> 	at org.apache.spark.sql.catalyst.expressions.GeneratedClass$GeneratedIterator.processNext(Unknown Source)
> 	at org.apache.spark.sql.execution.BufferedRowIterator.hasNext(BufferedRowIterator.java:43)
> 	at org.apache.spark.sql.execution.WholeStageCodegenExec$$anonfun$8$$anon$1.hasNext(WholeStageCodegenExec.scala:370)
> 	at org.apache.spark.sql.execution.datasources.DynamicPartitionWriterContainer.writeRows(WriterContainer.scala:397)
> 	at org.apache.spark.sql.execution.datasources.InsertIntoHadoopFsRelationCommand$$anonfun$run$1$$anonfun$apply$mcV$sp$1.apply(InsertIntoHadoopFsRelationCommand.scala:143)
> 	at org.apache.spark.sql.execution.datasources.InsertIntoHadoopFsRelationCommand$$anonfun$run$1$$anonfun$apply$mcV$sp$1.apply(InsertIntoHadoopFsRelationCommand.scala:143)
> 	at org.apache.spark.scheduler.ResultTask.runTask(ResultTask.scala:70)
> 	at org.apache.spark.scheduler.Task.run(Task.scala:86)
> 	at org.apache.spark.executor.Executor$TaskRunner.run(Executor.scala:274)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:745)
> {code}
> https://github.com/jpountz/lz4-java/issues/89



--
This message was sent by Atlassian JIRA
(v7.6.3#76005)

---------------------------------------------------------------------
To unsubscribe, e-mail: issues-unsubscribe@spark.apache.org
For additional commands, e-mail: issues-help@spark.apache.org