[JENKINS-7745] CopyArtifact plugin triggers intermittent remoting failures

timja / jenkins-gh-issues-poc-06-18

0 stars 0 forks source link

[JENKINS-7745] CopyArtifact plugin triggers intermittent remoting failures #6091

Closed timja closed 13 years ago

timja commented 13 years ago

We are using the CopyArtifact plugin to distribute a ~7MB tar.gz file from a single polling job to several downstream build/test jobs. Since Hudson 1.377, copying the artifact to the build/test job randomly throws one of two exceptions (the first is reported in ~~JENKINS-7581~~):

ERROR: Failed to copy artifacts from job-poll with filter: workspace.tar.gz
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=7c9e6f6bf0e618[...snip...]
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
    [...snip...]

and the following (new in 1.380):

Deleting old artifacts from #21
FATAL: null
java.lang.AssertionError
    at hudson.remoting.PipeWindow$Real.decrease(PipeWindow.java:160)
    at hudson.remoting.ProxyOutputStream._write(ProxyOutputStream.java:124)
    at hudson.remoting.ProxyOutputStream.write(ProxyOutputStream.java:103)
    at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65)
    at java.io.BufferedOutputStream.write(BufferedOutputStream.java:109)
    at java.util.zip.DeflaterOutputStream.deflate(DeflaterOutputStream.java:161)
    at java.util.zip.DeflaterOutputStream.write(DeflaterOutputStream.java:118)
    at java.util.zip.GZIPOutputStream.write(GZIPOutputStream.java:72)
    at java.io.BufferedOutputStream.write(BufferedOutputStream.java:105)
    at org.apache.tools.tar.TarBuffer.writeBlock(TarBuffer.java:410)
    at org.apache.tools.tar.TarBuffer.writeRecord(TarBuffer.java:388)
    at hudson.org.apache.tools.tar.TarOutputStream.write(TarOutputStream.java:337)
    at hudson.util.io.TarArchiver.visit(TarArchiver.java:103)
    at hudson.util.DirScanner$Glob.scan(DirScanner.java:104)
    at hudson.FilePath.writeToTar(FilePath.java:1543)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1470)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
    at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:172)
    at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
    at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:601)
    at hudson.model.Build$RunnerImpl.build(Build.java:174)
    at hudson.model.Build$RunnerImpl.doRun(Build.java:138)
    at hudson.model.AbstractBuild$AbstractRunner.run(AbstractBuild.java:416)
    at hudson.model.Run.run(Run.java:1280)
    at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
    at hudson.model.ResourceController.execute(ResourceController.java:88)
    at hudson.model.Executor.run(Executor.java:140)

These exceptions appear to occur randomly, and happen approximately 50% of the time.

Originally reported by jsiirola, imported from: CopyArtifact plugin triggers intermittent remoting failures

assignee: kohsuke
status: Closed
priority: Blocker
resolution: Fixed
resolved: 2011-02-04T03:21:19+00:00
imported: 2022/01/10

timja commented 13 years ago

lynggaard:

I am getting it during archive
[HUDSON] Archiving site from /xdata/hudson/.hudson/jobs/Build_Foundation/workspace/datamodel/target/site to /xdata/hudson/.hudson/jobs/Build_Foundation/site/datamodel
[INFO] ------------------------------------------------------------------------
[ERROR] FATAL ERROR
[INFO] ------------------------------------------------------------------------
[INFO] null
[INFO] ------------------------------------------------------------------------
[INFO] Trace
java.lang.AssertionError
at hudson.remoting.PipeWindow$Real.decrease(PipeWindow.java:160)
at hudson.remoting.ProxyOutputStream._write(ProxyOutputStream.java:124)
at hudson.remoting.ProxyOutputStream.write(ProxyOutputStream.java:103)
at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65)
at java.io.BufferedOutputStream.write(BufferedOutputStream.java:109)
at java.util.zip.DeflaterOutputStream.deflate(DeflaterOutputStream.java:161)
at java.util.zip.DeflaterOutputStream.write(DeflaterOutputStream.java:118)
at java.util.zip.GZIPOutputStream.write(GZIPOutputStream.java:72)
at java.io.BufferedOutputStream.write(BufferedOutputStream.java:105)
at org.apache.tools.tar.TarBuffer.writeBlock(TarBuffer.java:410)
at org.apache.tools.tar.TarBuffer.writeRecord(TarBuffer.java:388)
at hudson.org.apache.tools.tar.TarOutputStream.write(TarOutputStream.java:337)
at hudson.util.io.TarArchiver.visit(TarArchiver.java:103)
at hudson.util.DirScanner$Glob.scan(DirScanner.java:104)
at hudson.FilePath.writeToTar(FilePath.java:1543)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1470)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:772)
at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)
at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalWithLifecycle(DefaultLifecycleExecutor.java:556)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:535)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:180)
at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
at hudson.maven.agent.Main.launch(Main.java:165)
at hudson.maven.MavenBuilder.call(MavenBuilder.java:165)
at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:694)
at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:638)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:138)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:619)

timja commented 13 years ago

mindless:

kohsuke, can you take a look at this?

timja commented 13 years ago

scm_issue_link:

Code changed in hudson
User: : kohsuke
Path:
trunk/hudson/main/remoting/src/main/java/hudson/remoting/PipeWindow.java
trunk/www/changelog.html
http://jenkins-ci.org/commit/36558
Log:
[FIXED JENKINS-7745] suppressing the assertion so that the processing won't die.

timja commented 13 years ago

dogfood:

Integrated in hudson_main_trunk #379
[FIXED JENKINS-7745] suppressing the assertion so that the processing won't die.

kohsuke :
Files :

/trunk/www/changelog.html
/trunk/hudson/main/remoting/src/main/java/hudson/remoting/PipeWindow.java

timja commented 13 years ago

howjay:

Unfortunately I still see this problem after upgrading to 1.384. Could you check it again? It is really annoying. Thanks!

I doubt another plugin PrioritySorter also has impact to this problem - because the problem showed up in our environment after installing that plugin without any Hudson upgrading - however perhaps I was wrong.

Log:

ERROR: Failed to copy artifacts from XXXXX_TR with filter: BuildRoot/*.xxx
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=ed8ff4f86d31edf3a2c9abed8e87705ee867495262658944d75ae8feefe5a4fca172eec55ca70290b7d5b2ae8c17e3746fbfa51f1aac42fbf0a2dec18b76390ef5961c94f2c456688829fdbbc94fdef984202b81b1b64731aa5c3513b73ee9328b36758e98b27e2bd07bd7518e2be4e4368dffd8f21db1b1dc62ba2fe98a7f72ee8312d38c03736da7fbdfa436e7df57c17f891d22a5f67f6953c46e8491312759ca1179712bb8cf5338eef361a17f2e401fdae134fe532a2977d78644a188b6f4ac16c3c3d3e3c3aded0cca1dd5c0fccada450b9da3e0852f9ddd7494f32a599741e7f6c5563a373dfec6f175d1b92d7c258eadf60330f981655b6846da0a529e83c4ef10507ea06c97999002b1f5951ca030c6fead89125811c6e8292478e87ce97ee99ff3ddbdfa379f1747ff134844531bb15735bef59c95f1cac24ee23d22dd667e639e774fae466cc8cd878437468ad1228dddb5803808cad78e5452f610dd43e35ba650b40a32a846aee1556506be4550c3de4f0dc4c997b0c1f396220d384e515ba721afe19cfb5303eaf772aa7fdad3d38a36e83cc1a294930276724f6c44fcd46ba5eee09c89d63320332dc381f6c71e6d6f58f72b4de3fbd496847ce8b2e735ecc3be3e417fb5b79297213c613a99bc928e0d78fafe39689ec11257da807409633b8983f73eef64b0b85a54fd0172ad175a05ba974f0c957242e89e699e8ecb5ba729d8bbffbc84b1a7e07dbe6843baba820732bb332c017d8326dd61bccf38db3392456c0ffcdedf19882900608eac473b5b54e83d43c5f968b7c639f4ce1b8fee84d9b6b1faf029536ad8c86dfc0deb431b22ac35c20bacb363b6f1a9ab7928e74e2c8a3bde8272e2596bb1c04c1d03b3dbf3221f929c3d71efd955d317cf76558d99fec8ec30c6b443c77037c102db3810fb24cf79f43320d3c370bee8b74c2759f1cb8d2bf72acbec4abaa62acb706e79ca56407dc96fcdd8356d45bb1b7ac91658ea3aacd0d3f432c89fcb720f0afc0c3b9172a426ea57e9d2868a6ffb305c0487da0fe56b58f7c09acd4212c9ea62d1f63ac888858503f851a9933bfd51effdd8e7f8017d4de44553ebe0fa675f09dadd68833895f4bd14de6ea36759a86dd21a58cea704a17da395946750bf56ac8b665d0c5d77d5198776171de836460b6bbf6e60d12f726fe3b56f5d0dd8c5d1fddbad818ebd45f735f8b76847d637061d1ddf65ac6310fef5e86b71747f7d954257491edcc6f7bf20d64f154b6d55330fd507578c6d9a2696d653feb1eb77177721bf2649f9ee21fe8ab2d6ff2e80a00a63c2d724c0562f4b6dcd8123d1bfdcec6ed59634edb8a3a47b5e81d6edc36b37238addbd64a44d1962d7779b261d6e101b0cb42f6fdcb517f2ddf9e06e7b5454ecff7f487b1bb8a6ceb37ffc3af739390918e590132db6b4
at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
at hudson.plugins.copyartifact.FilePathCopyMethod.copyAll(FilePathCopyMethod.java:65)
at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:194)
at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:168)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:601)
at hudson.model.Build$RunnerImpl.build(Build.java:174)
at hudson.model.Build$RunnerImpl.doRun(Build.java:138)
at hudson.model.AbstractBuild$AbstractRunner.run(AbstractBuild.java:416)
at hudson.model.Run.run(Run.java:1324)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:139)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=ed8ff4f86d31edf3a2c9abed8e87705ee867495262658944d75ae8feefe5a4fca172eec55ca70290b7d5b2ae8c17e3746fbfa51f1aac42fbf0a2dec18b76390ef5961c94f2c456688829fdbbc94fdef984202b81b1b64731aa5c3513b73ee9328b36758e98b27e2bd07bd7518e2be4e4368dffd8f21db1b1dc62ba2fe98a7f72ee8312d38c03736da7fbdfa436e7df57c17f891d22a5f67f6953c46e8491312759ca1179712bb8cf5338eef361a17f2e401fdae134fe532a2977d78644a188b6f4ac16c3c3d3e3c3aded0cca1dd5c0fccada450b9da3e0852f9ddd7494f32a599741e7f6c5563a373dfec6f175d1b92d7c258eadf60330f981655b6846da0a529e83c4ef10507ea06c97999002b1f5951ca030c6fead89125811c6e8292478e87ce97ee99ff3ddbdfa379f1747ff134844531bb15735bef59c95f1cac24ee23d22dd667e639e774fae466cc8cd878437468ad1228dddb5803808cad78e5452f610dd43e35ba650b40a32a846aee1556506be4550c3de4f0dc4c997b0c1f396220d384e515ba721afe19cfb5303eaf772aa7fdad3d38a36e83cc1a294930276724f6c44fcd46ba5eee09c89d63320332dc381f6c71e6d6f58f72b4de3fbd496847ce8b2e735ecc3be3e417fb5b79297213c613a99bc928e0d78fafe39689ec11257da807409633b8983f73eef64b0b85a54fd0172ad175a05ba974f0c957242e89e699e8ecb5ba729d8bbffbc84b1a7e07dbe6843baba820732bb332c017d8326dd61bccf38db3392456c0ffcdedf19882900608eac473b5b54e83d43c5f968b7c639f4ce1b8fee84d9b6b1faf029536ad8c86dfc0deb431b22ac35c20bacb363b6f1a9ab7928e74e2c8a3bde8272e2596bb1c04c1d03b3dbf3221f929c3d71efd955d317cf76558d99fec8ec30c6b443c77037c102db3810fb24cf79f43320d3c370bee8b74c2759f1cb8d2bf72acbec4abaa62acb706e79ca56407dc96fcdd8356d45bb1b7ac91658ea3aacd0d3f432c89fcb720f0afc0c3b9172a426ea57e9d2868a6ffb305c0487da0fe56b58f7c09acd4212c9ea62d1f63ac888858503f851a9933bfd51effdd8e7f8017d4de44553ebe0fa675f09dadd68833895f4bd14de6ea36759a86dd21a58cea704a17da395946750bf56ac8b665d0c5d77d5198776171de836460b6bbf6e60d12f726fe3b56f5d0dd8c5d1fddbad818ebd45f735f8b76847d637061d1ddf65ac6310fef5e86b71747f7d954257491edcc6f7bf20d64f154b6d55330fd507578c6d9a2696d653feb1eb77177721bf2649f9ee21fe8ab2d6ff2e80a00a63c2d724c0562f4b6dcd8123d1bfdcec6ed59634edb8a3a47b5e81d6edc36b37238addbd64a44d1962d7779b261d6e101b0cb42f6fdcb517f2ddf9e06e7b5454ecff7f487b1bb8a6ceb37ffc3af739390918e590132db6b4
at hudson.remoting.Channel$2.adapt(Channel.java:663)
at hudson.remoting.Channel$2.adapt(Channel.java:658)
at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1472)
... 13 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=ed8ff4f86d31edf3a2c9abed8e87705ee867495262658944d75ae8feefe5a4fca172eec55ca70290b7d5b2ae8c17e3746fbfa51f1aac42fbf0a2dec18b76390ef5961c94f2c456688829fdbbc94fdef984202b81b1b64731aa5c3513b73ee9328b36758e98b27e2bd07bd7518e2be4e4368dffd8f21db1b1dc62ba2fe98a7f72ee8312d38c03736da7fbdfa436e7df57c17f891d22a5f67f6953c46e8491312759ca1179712bb8cf5338eef361a17f2e401fdae134fe532a2977d78644a188b6f4ac16c3c3d3e3c3aded0cca1dd5c0fccada450b9da3e0852f9ddd7494f32a599741e7f6c5563a373dfec6f175d1b92d7c258eadf60330f981655b6846da0a529e83c4ef10507ea06c97999002b1f5951ca030c6fead89125811c6e8292478e87ce97ee99ff3ddbdfa379f1747ff134844531bb15735bef59c95f1cac24ee23d22dd667e639e774fae466cc8cd878437468ad1228dddb5803808cad78e5452f610dd43e35ba650b40a32a846aee1556506be4550c3de4f0dc4c997b0c1f396220d384e515ba721afe19cfb5303eaf772aa7fdad3d38a36e83cc1a294930276724f6c44fcd46ba5eee09c89d63320332dc381f6c71e6d6f58f72b4de3fbd496847ce8b2e735ecc3be3e417fb5b79297213c613a99bc928e0d78fafe39689ec11257da807409633b8983f73eef64b0b85a54fd0172ad175a05ba974f0c957242e89e699e8ecb5ba729d8bbffbc84b1a7e07dbe6843baba820732bb332c017d8326dd61bccf38db3392456c0ffcdedf19882900608eac473b5b54e83d43c5f968b7c639f4ce1b8fee84d9b6b1faf029536ad8c86dfc0deb431b22ac35c20bacb363b6f1a9ab7928e74e2c8a3bde8272e2596bb1c04c1d03b3dbf3221f929c3d71efd955d317cf76558d99fec8ec30c6b443c77037c102db3810fb24cf79f43320d3c370bee8b74c2759f1cb8d2bf72acbec4abaa62acb706e79ca56407dc96fcdd8356d45bb1b7ac91658ea3aacd0d3f432c89fcb720f0afc0c3b9172a426ea57e9d2868a6ffb305c0487da0fe56b58f7c09acd4212c9ea62d1f63ac888858503f851a9933bfd51effdd8e7f8017d4de44553ebe0fa675f09dadd68833895f4bd14de6ea36759a86dd21a58cea704a17da395946750bf56ac8b665d0c5d77d5198776171de836460b6bbf6e60d12f726fe3b56f5d0dd8c5d1fddbad818ebd45f735f8b76847d637061d1ddf65ac6310fef5e86b71747f7d954257491edcc6f7bf20d64f154b6d55330fd507578c6d9a2696d653feb1eb77177721bf2649f9ee21fe8ab2d6ff2e80a00a63c2d724c0562f4b6dcd8123d1bfdcec6ed59634edb8a3a47b5e81d6edc36b37238addbd64a44d1962d7779b261d6e101b0cb42f6fdcb517f2ddf9e06e7b5454ecff7f487b1bb8a6ceb37ffc3af739390918e590132db6b4
at hudson.FilePath$TarCompression$2.extract(FilePath.java:534)
at hudson.FilePath$32.invoke(FilePath.java:1463)
at hudson.FilePath$32.invoke(FilePath.java:1460)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
at java.util.concurrent.FutureTask$Sync.innerRun(Unknown Source)
at java.util.concurrent.FutureTask.run(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at hudson.remoting.Engine$1$1.run(Engine.java:58)
at java.lang.Thread.run(Unknown Source)
Caused by: java.io.IOException: Not in GZIP format
at java.util.zip.GZIPInputStream.readHeader(Unknown Source)
at java.util.zip.GZIPInputStream.(Unknown Source)
at hudson.FilePath$TarCompression$2.extract(FilePath.java:530)
... 13 more

timja commented 13 years ago

sirot:

I am still facing the issue event after an upgrade to hudson 1.384
The console indicates that the build ends successfully but the build is marked as failed and some ZipException are reported in the log.

hudson.util.IOException2: hudson.util.IOException2: Failed to extract /var/opt/hudson/workspace/PKIX-Site/trunk/target/site/**/*
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
    at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
    at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:828)
    at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)
    at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
    at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalWithLifecycle(DefaultLifecycleExecutor.java:556)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:535)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:180)
    at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
    at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
    at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
    at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
    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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
    at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
    at hudson.maven.agent.Main.launch(Main.java:165)
    at hudson.maven.MavenBuilder.call(MavenBuilder.java:165)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:750)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:694)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:619)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Failed to extract /var/opt/hudson/workspace/PKIX-Site/trunk/target/site/**/*
    at hudson.remoting.Channel$2.adapt(Channel.java:663)
    at hudson.remoting.Channel$2.adapt(Channel.java:658)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1472)
    ... 35 more
Caused by: hudson.util.IOException2: Failed to extract /var/opt/hudson/workspace/PKIX-Site/trunk/target/site/**/*
    at hudson.FilePath.readFromTar(FilePath.java:1577)
    at hudson.FilePath.access$100(FilePath.java:159)
    at hudson.FilePath$32.invoke(FilePath.java:1463)
    at hudson.FilePath$32.invoke(FilePath.java:1460)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
    ... 9 more
Caused by: java.util.zip.ZipException: invalid stored block lengths
    at java.util.zip.InflaterInputStream.read(InflaterInputStream.java:147)
    at java.util.zip.GZIPInputStream.read(GZIPInputStream.java:92)
    at org.apache.tools.tar.TarBuffer.readBlock(TarBuffer.java:257)
    at org.apache.tools.tar.TarBuffer.readRecord(TarBuffer.java:223)
    at hudson.org.apache.tools.tar.TarInputStream.read(TarInputStream.java:345)
    at java.io.FilterInputStream.read(FilterInputStream.java:90)
    at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1025)
    at org.apache.commons.io.IOUtils.copy(IOUtils.java:999)
    at hudson.util.IOUtils.copy(IOUtils.java:33)
    at hudson.FilePath.readFromTar(FilePath.java:1565)
    ... 13 more

timja commented 13 years ago

lynggaard:

I am still seeing this with 1.384, so re-opening

[HUDSON] Archiving site from /data/hudson/experiments/.hudson/jobs/Test_Build_Webchannel/workspace/trunk/service/booking-handler/booking-handler-ejb/target/site to /data/hudson/experiments/.hudson/jobs/Test_Build_Webchannel/site/booking-handler-ejb
FATAL: Unable to copy site from /data/hudson/experiments/.hudson/jobs/Test_Build_Webchannel/workspace/trunk/service/booking-handler/booking-handler-ejb/target/site to /data/hudson/experiments/.hudson/jobs/Test_Build_Webchannel/site/booking-handler-ejb
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=e772e4bf384fb803bcf53d1e269c5c1b73e43fa9d526ce7f8247b9fccfe2fafb97e75f3ed9f81771923e397d757c057fff79f8ef0fbff75bf0ef3fdef89f7e007f7ecf3c7d7df27bffc3df7cf2bd7fe9477fffe66ffd57f0e8f1e8d5cf8d478f36fe4ffcef7b2ffe93c65fc2c3dfbd3cbb3981bfbff9cd6ffea3fff9dfff6bf8f57df3eafcfa378ffef7ffb2f213b8fb83d3e3c39b0fff4bf7fff9cd6fbef75bbff3478ffe9b6f8bfff4fffb27fb3f45384e4fce8fffe18b3ffb7bcbc1c2a77b4dcc7fef29e589b4316ffed7abd5c9f3bff3fd9f995c01f3fff7e1bfdffb7d9cffdfffd7fe5fb4067ffbf6f0f5e1a347ffd93f6affce3ff83fe0fe5f304f7e665e6b7df35ed2e9a3c31e9010391d326b5dea3dfceabfa57bf0d1636406c009fee22ffe02eefebaf88ffe53f8f35b8c1ffce6d13ff9ef9e40858fda9c2174feec2f1efdee9f3feafc59effbbfc5fe7effbff8a3bf7cf4fddfffc78f7e9ffcee177ff8375e7dffb7fff0dffbde1ffef8c77ff557bf5f78f4fdbff968a3f0e8ab777ffd937f8a1dc819c742d7c4fc1f8f129efd71e67fbdddcee57f2657baf31f263fb000b8fbdfdefedbfff7a3e9f3bfd3e9fcd96fff738fbef7578ffec37fe72fff7cebcf1ffdbdfaa3efffebdf3bfe577ef6e87bbf7dfbe8b7fff0b7fef277ff7378f22fffb31b38ffffc6c5a3b7fffdb77ff0b7b003f9fc5fe872cd7f3c3d381507e0bcf37fda6dfffc07f5bf9dcfff2cae48febf97b8cc66d0053c807d51c36afb0067c60e7a1d765687a06a053a50ab7cbeb58da7333cd978ecbcd3b57b785787776df14ebce4b17401272f17880acfec80365cf32c585e497798138337a8b689635b4585de75544f9dc22fc49c458e6b886cd20f5d3a32f104ec22fac7e42e51a981ee3316f6f78c83b057b67aeb74dd038fe7205a018b75e4800042746a4b38a03c70901ee5cb33b2a61a0502bf354561ab7e0f020bd8acaa71283852842bea31fc1c1ddcf0b3e1f972137a13a142f956c56e680404d89d4cefe1666c40a5cc0bc66b227d2a017ba42572da270fda98189472f7e7902725db624f41108aa2122f5894d5ae34e2a776d00ef448c655aebdf2c80668d649bd0747b8f84d0614aa05f01036a8184780231608d3c0d56fbee6ccebb45d6ff0cb8507cfc04c7ae51cfe1f18d199088f99c3ffeb95967ffda7d168e5fc3f93abfcc30df24397e7b948e62e6642015e66f4c0d6ccc9e6d13352ab549ae4b5a4bf27c71a3aacf5299f5c283250b30e0c0cbdf4765556f330affa3acc30436897bb6c76a13b5ca73d19d78f3a639312d944ee50d67432d47a72ff012b8167635061743679816b0c0d6b79e0cbf337e44bb6700b8c73dc81a945cee42e550d8abef8113e3106b48795b0b50d0a820e60b0345cf252838a99cf7d975019deebd6042435ab0d51e11656
at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:828)
at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)
at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalWithLifecycle(DefaultLifecycleExecutor.java:556)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:535)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:181)
at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
at hudson.maven.agent.Main.launch(Main.java:165)
at hudson.maven.MavenBuilder.call(MavenBuilder.java:165)
at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:750)
at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:694)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:442)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:139)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:909)
at java.lang.Thread.run(Thread.java:619)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=e772e4bf384fb803bcf53d1e269c5c1b73e43fa9d526ce7f8247b9fccfe2fafb97e75f3ed9f81771923e397d757c057fff79f8ef0fbff75bf0ef3fdef89f7e007f7ecf3c7d7df27bffc3df7cf2bd7fe9477fffe66ffd57f0e8f1e8d5cf8d478f36fe4ffcef7b2ffe93c65fc2c3dfbd3cbb3981bfbff9cd6ffea3fff9dfff6bf8f57df3eafcfa378ffef7ffb2f213b8fb83d3e3c39b0fff4bf7fff9cd6fbef75bbff3478ffe9b6f8bfff4fffb27fb3f45384e4fce8fffe18b3ffb7bcbc1c2a77b4dcc7fef29e589b4316ffed7abd5c9f3bff3fd9f995c01f3fff7e1bfdffb7d9cffdfffd7fe5fb4067ffbf6f0f5e1a347ffd93f6affce3ff83fe0fe5f304f7e665e6b7df35ed2e9a3c31e9010391d326b5dea3dfceabfa57bf0d1636406c009fee22ffe02eefebaf88ffe53f8f35b8c1ffce6d13ff9ef9e40858fda9c2174feec2f1efdee9f3feafc59effbbfc5fe7effbff8a3bf7cf4fddfffc78f7e9ffcee177ff8375e7dffb7fff0dffbde1ffef8c77ff557bf5f78f4fdbff968a3f0e8ab777ffd937f8a1dc819c742d7c4fc1f8f129efd71e67fbdddcee57f2657baf31f263fb000b8fbdfdefedbfff7a3e9f3bfd3e9fcd96fff738fbef7578ffec37fe72fff7cebcf1ffdbdfaa3efffebdf3bfe577ef6e87bbf7dfbe8b7fff0b7fef277ff7378f22fffb31b38ffffc6c5a3b7fffdb77ff0b7b003f9fc5fe872cd7f3c3d381507e0bcf37fda6dfffc07f5bf9dcfff2cae48febf97b8cc66d0053c807d51c36afb0067c60e7a1d765687a06a053a50ab7cbeb58da7333cd978ecbcd3b57b785787776df14ebce4b17401272f17880acfec80365cf32c585e497798138337a8b689635b4585de75544f9dc22fc49c458e6b886cd20f5d3a32f104ec22fac7e42e51a981ee3316f6f78c83b057b67aeb74dd038fe7205a018b75e4800042746a4b38a03c70901ee5cb33b2a61a0502bf354561ab7e0f020bd8acaa71283852842bea31fc1c1ddcf0b3e1f972137a13a142f956c56e680404d89d4cefe1666c40a5cc0bc66b227d2a017ba42572da270fda98189472f7e7902725db624f41108aa2122f5894d5ae34e2a776d00ef448c655aebdf2c80668d649bd0747b8f84d0614aa05f01036a8184780231608d3c0d56fbee6ccebb45d6ff0cb8507cfc04c7ae51cfe1f18d199088f99c3ffeb95967ffda7d168e5fc3f93abfcc30df24397e7b948e62e6642015e66f4c0d6ccc9e6d13352ab549ae4b5a4bf27c71a3aacf5299f5c283250b30e0c0cbdf4765556f330affa3acc30436897bb6c76a13b5ca73d19d78f3a639312d944ee50d67432d47a72ff012b8167635061743679816b0c0d6b79e0cbf337e44bb6700b8c73dc81a945cee42e550d8abef8113e3106b48795b0b50d0a820e60b0345cf252838a99cf7d975019deebd6042435ab0d51e11656
at hudson.remoting.Channel$2.adapt(Channel.java:663)
at hudson.remoting.Channel$2.adapt(Channel.java:658)
at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1472)
... 35 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=e772e4bf384fb803bcf53d1e269c5c1b73e43fa9d526ce7f8247b9fccfe2fafb97e75f3ed9f81771923e397d757c057fff79f8ef0fbff75bf0ef3fdef89f7e007f7ecf3c7d7df27bffc3df7cf2bd7fe9477fffe66ffd57f0e8f1e8d5cf8d478f36fe4ffcef7b2ffe93c65fc2c3dfbd3cbb3981bfbff9cd6ffea3fff9dfff6bf8f57df3eafcfa378ffef7ffb2f213b8fb83d3e3c39b0fff4bf7fff9cd6fbef75bbff3478ffe9b6f8bfff4fffb27fb3f45384e4fce8fffe18b3ffb7bcbc1c2a77b4dcc7fef29e589b4316ffed7abd5c9f3bff3fd9f995c01f3fff7e1bfdffb7d9cffdfffd7fe5fb4067ffbf6f0f5e1a347ffd93f6affce3ff83fe0fe5f304f7e665e6b7df35ed2e9a3c31e9010391d326b5dea3dfceabfa57bf0d1636406c009fee22ffe02eefebaf88ffe53f8f35b8c1ffce6d13ff9ef9e40858fda9c2174feec2f1efdee9f3feafc59effbbfc5fe7effbff8a3bf7cf4fddfffc78f7e9ffcee177ff8375e7dffb7fff0dffbde1ffef8c77ff557bf5f78f4fdbff968a3f0e8ab777ffd937f8a1dc819c742d7c4fc1f8f129efd71e67fbdddcee57f2657baf31f263fb000b8fbdfdefedbfff7a3e9f3bfd3e9fcd96fff738fbef7578ffec37fe72fff7cebcf1ffdbdfaa3efffebdf3bfe577ef6e87bbf7dfbe8b7fff0b7fef277ff7378f22fffb31b38ffffc6c5a3b7fffdb77ff0b7b003f9fc5fe872cd7f3c3d381507e0bcf37fda6dfffc07f5bf9dcfff2cae48febf97b8cc66d0053c807d51c36afb0067c60e7a1d765687a06a053a50ab7cbeb58da7333cd978ecbcd3b57b785787776df14ebce4b17401272f17880acfec80365cf32c585e497798138337a8b689635b4585de75544f9dc22fc49c458e6b886cd20f5d3a32f104ec22fac7e42e51a981ee3316f6f78c83b057b67aeb74dd038fe7205a018b75e4800042746a4b38a03c70901ee5cb33b2a61a0502bf354561ab7e0f020bd8acaa71283852842bea31fc1c1ddcf0b3e1f972137a13a142f956c56e680404d89d4cefe1666c40a5cc0bc66b227d2a017ba42572da270fda98189472f7e7902725db624f41108aa2122f5894d5ae34e2a776d00ef448c655aebdf2c80668d649bd0747b8f84d0614aa05f01036a8184780231608d3c0d56fbee6ccebb45d6ff0cb8507cfc04c7ae51cfe1f18d199088f99c3ffeb95967ffda7d168e5fc3f93abfcc30df24397e7b948e62e6642015e66f4c0d6ccc9e6d13352ab549ae4b5a4bf27c71a3aacf5299f5c283250b30e0c0cbdf4765556f330affa3acc30436897bb6c76a13b5ca73d19d78f3a639312d944ee50d67432d47a72ff012b8167635061743679816b0c0d6b79e0cbf337e44bb6700b8c73dc81a945cee42e550d8abef8113e3106b48795b0b50d0a820e60b0345cf252838a99cf7d975019deebd6042435ab0d51e11656
at hudson.FilePath$TarCompression$2.extract(FilePath.java:534)
at hudson.FilePath$32.invoke(FilePath.java:1463)
at hudson.FilePath$32.invoke(FilePath.java:1460)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:138)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
... 1 more
Caused by: java.io.IOException: Not in GZIP format
at java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:137)
at java.util.zip.GZIPInputStream.(GZIPInputStream.java:58)
at hudson.FilePath$TarCompression$2.extract(FilePath.java:530)
... 12 more

timja commented 13 years ago

lynggaard:

Seeing the following in the hudson log, maybe related?
Nov 9, 2010 12:41:27 PM hudson.remoting.ProxyOutputStream$Chunk$1 run
WARNING: Failed to write to stream
java.io.IOException: Pipe is already closed
at hudson.remoting.FastPipedOutputStream.write(FastPipedOutputStream.java:145)
at hudson.remoting.FastPipedOutputStream.write(FastPipedOutputStream.java:129)
at hudson.remoting.ProxyOutputStream$Chunk$1.run(ProxyOutputStream.java:185)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:138)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:619)
Caused by: hudson.remoting.FastPipedInputStream$ClosedBy: The pipe was closed at...
at hudson.remoting.FastPipedInputStream.close(FastPipedInputStream.java:110)
at hudson.FilePath$32.invoke(FilePath.java:1466)
at hudson.FilePath$32.invoke(FilePath.java:1460)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
... 6 more
Nov 9, 2010 12:41:27 PM hudson.remoting.ProxyOutputStream$Chunk$1 run
WARNING: Failed to write to stream
java.io.IOException: Pipe is already closed
at hudson.remoting.FastPipedOutputStream.write(FastPipedOutputStream.java:145)
at hudson.remoting.FastPipedOutputStream.write(FastPipedOutputStream.java:129)
at hudson.remoting.ProxyOutputStream$Chunk$1.run(ProxyOutputStream.java:185)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:138)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:619)
Caused by: hudson.remoting.FastPipedInputStream$ClosedBy: The pipe was closed at...
at hudson.remoting.FastPipedInputStream.close(FastPipedInputStream.java:110)
at hudson.FilePath$32.invoke(FilePath.java:1466)
at hudson.FilePath$32.invoke(FilePath.java:1460)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
... 6 more

timja commented 13 years ago

davidwoon:

We are still on 1.377 and this is intermittent.(Not sure if this is the same or related) However, it is happening in just the basic Archive the Artifacts Post Build Action.
Wondering if the big files have anything / related to the copy. It is not very common, but happens at random stumping us as we go.

Archiving artifacts
ERROR: Failed to archive artifacts: platform/release/, platform/release//, release/, cims.txt
hudson.util.IOException2: Failed to extract /Volumes/data/hudson/workspace/integrated_device-umts-begonia-user-dbg_main-dev_linux_continuous/platform/release/, platform/release//, release/, cims.txt
at hudson.FilePath.readFromTar(FilePath.java:1577)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1491)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:117)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:601)
at hudson.model.AbstractBuild$AbstractRunner.performAllBuildSteps(AbstractBuild.java:580)
at hudson.model.AbstractBuild$AbstractRunner.performAllBuildSteps(AbstractBuild.java:558)
at hudson.model.Build$RunnerImpl.post2(Build.java:157)
at hudson.model.AbstractBuild$AbstractRunner.post(AbstractBuild.java:528)
at hudson.model.Run.run(Run.java:1296)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:137)
Caused by: java.io.IOException
at hudson.remoting.FastPipedInputStream.read(FastPipedInputStream.java:173)
at hudson.util.HeadBufferingStream.read(HeadBufferingStream.java:61)
at java.util.zip.InflaterInputStream.fill(InflaterInputStream.java:221)
at java.util.zip.InflaterInputStream.read(InflaterInputStream.java:141)
at java.util.zip.GZIPInputStream.read(GZIPInputStream.java:92)
at org.apache.tools.tar.TarBuffer.readBlock(TarBuffer.java:257)
at org.apache.tools.tar.TarBuffer.readRecord(TarBuffer.java:223)
at hudson.org.apache.tools.tar.TarInputStream.read(TarInputStream.java:345)
at java.io.FilterInputStream.read(FilterInputStream.java:90)
at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1025)
at org.apache.commons.io.IOUtils.copy(IOUtils.java:999)
at hudson.util.IOUtils.copy(IOUtils.java:33)
at hudson.FilePath.readFromTar(FilePath.java:1565)
... 12 more
ERROR: Publisher hudson.plugins.descriptionsetter.DescriptionSetterPublisher aborted due to exception
java.lang.InterruptedException
at java.lang.Object.wait(Native Method)
at hudson.remoting.Request.call(Request.java:122)
at hudson.remoting.Channel.call(Channel.java:557)
at hudson.EnvVars.getRemote(EnvVars.java:202)
at hudson.model.Computer.getEnvironment(Computer.java:746)
at hudson.model.Run.getEnvironment(Run.java:1673)
at hudson.model.AbstractBuild.getEnvironment(AbstractBuild.java:682)
at hudson.plugins.descriptionsetter.DescriptionSetterPublisher.perform(DescriptionSetterPublisher.java:82)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:601)
at hudson.model.AbstractBuild$AbstractRunner.performAllBuildSteps(AbstractBuild.java:580)
at hudson.model.AbstractBuild$AbstractRunner.performAllBuildSteps(AbstractBuild.java:558)
at hudson.model.Build$RunnerImpl.post2(Build.java:157)
at hudson.model.AbstractBuild$AbstractRunner.post(AbstractBuild.java:528)
at hudson.model.Run.run(Run.java:1296)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:137)

timja commented 13 years ago

khushsk:

Still seeing this issue in 1.384/1.385:

hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=5f65df7c3a2f784a797b59fd9c9f2fbbed89479fb8cb5cbe61c54b47d66dbfec9fa79e3df1f8d6f7cae76d7ce1a255ab8e7965f531dc0583020f25fe3f002240ddbfb193c9c9caeb89411224b126090620696bac044b9194c409453084284bb1fcdfb7beaa6edc08c9c919e76c621175e96e34fa525d55a86ef00f4d435a62d4bfa98064ee5f55f9f9b78724afab44aeb99e7d74d46cbb55ab4de87f2fc82eff3b01bcd69c4d0ed41bb242ce8d74a92030819431289aa4d95ec91481b4dc8ac77f619a2db55207d920f3f172a99f05b619cf2e2295c87063b8d623715777ba3c9e24648dd8d115755cae24927e076912cc7f8e603f9018f64770c0569eedef1ffcfcd597fb8fc13a98edde1dfc7c123dfeaaf2c39774a95466678b1feed68b5dbad75d653abf239379f787d9d99ddcfb4e9b2977d379443f90e877cbd5e8fc72b47b72ba7b7077f76565e7eee5b3ddbb3b898df933cb2631bd87d98cff21b3ef4ae580951afc2a63e3ce164bb28f5949933693a68683b914eb1190f95b690e4b61dd6de85549b0770311db4bf1e249c8b7d9823f74ce423d56ac6393f45ebd7aeb0fa5ed86bccc8ab7a3247e041a37b081e0948273f71349ce3793e07ef1709547e35941225ca6072d51b84c4e796a014460185fd9c464106f303593951745460a46ae928627d81df48184eb2b60b6e701a39e56a4090fd57faa43450fad76f4546de8eb9ebe3e91e5b2ed5419c0f5fed17e60647c611278c5029e007f3cf12712a97d550e0eca937dfe7740433185321c2971489e8da08aefeda59524ad3f919472fad41875c51e4b8cf53835acde5fd75352b04ce272f03b4a7cb808a57eeea8bfa82ae979a419eb7764b462edfcdcf9724bb96b462ea797d02c266bb64fb7c9fc3c9f6eb362401a982c99f375e9f4f66a4a0bc9557805d5f774f54b65174b6ccc2a2eedf397a2ee2b4333be8c279e7b76b6b7a45585d3b000cfb481e4d47a6b321955a37366f59a93d1386b752c491745b65c7252a6d5f63d4db99a4d66e3f53c5c47a43770b39a27a16e93fb56ad7ac3b36dee217818f0286c294c4a154e80056c97d9ab29bb239214aa237763b2f613411b1083960646e5748d377c68de09bb19f6f70d443af5f773b925a9b0e56fe66b854ea09fbfd1efd617b04bb73809f42d49324192092799908e956a7e76531cd0df11fded97dcc9043e59328c97a3c9930bc44b3d195fd0647f42b270ce899fa4fec876504a2be9e9ad339379c0cb0569acdd902c28f36a9d9e3c49b63f566ffd60687bbee376a9598f8ea8690dfa6cfff06f2477142df871a83f3a92566c44a7521385a7ffc4eb52e3af23ca249c46a4455fe93020598878fd514595839d6754035647b5bacd91c91965193375bde060107e9ee982bdb4b1d16194d37e188abf6e93c34152676094ca135d262b
at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
at hudson.plugins.copyartifact.FilePathCopyMethod.copyAll(FilePathCopyMethod.java:65)
at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:194)
at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:168)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:601)
at hudson.model.Build$RunnerImpl.build(Build.java:174)
at hudson.model.Build$RunnerImpl.doRun(Build.java:138)
at hudson.model.AbstractBuild$AbstractRunner.run(AbstractBuild.java:416)
at hudson.model.Run.run(Run.java:1324)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:139)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=5f65df7c3a2f784a797b59fd9c9f2fbbed89479fb8cb5cbe61c54b47d66dbfec9fa79e3df1f8d6f7cae76d7ce1a255ab8e7965f531dc0583020f25fe3f002240ddbfb193c9c9caeb89411224b126090620696bac044b9194c409453084284bb1fcdfb7beaa6edc08c9c919e76c621175e96e34fa525d55a86ef00f4d435a62d4bfa98064ee5f55f9f9b78724afab44aeb99e7d74d46cbb55ab4de87f2fc82eff3b01bcd69c4d0ed41bb242ce8d74a92030819431289aa4d95ec91481b4dc8ac77f619a2db55207d920f3f172a99f05b619cf2e2295c87063b8d623715777ba3c9e24648dd8d115755cae24927e076912cc7f8e603f9018f64770c0569eedef1ffcfcd597fb8fc13a98edde1dfc7c123dfeaaf2c39774a95466678b1feed68b5dbad75d653abf239379f787d9d99ddcfb4e9b2977d379443f90e877cbd5e8fc72b47b72ba7b7077f76565e7eee5b3ddbb3b898df933cb2631bd87d98cff21b3ef4ae580951afc2a63e3ce164bb28f5949933693a68683b914eb1190f95b690e4b61dd6de85549b0770311db4bf1e249c8b7d9823f74ce423d56ac6393f45ebd7aeb0fa5ed86bccc8ab7a3247e041a37b081e0948273f71349ce3793e07ef1709547e35941225ca6072d51b84c4e796a014460185fd9c464106f303593951745460a46ae928627d81df48184eb2b60b6e701a39e56a4090fd57faa43450fad76f4546de8eb9ebe3e91e5b2ed5419c0f5fed17e60647c611278c5029e007f3cf12712a97d550e0eca937dfe7740433185321c2971489e8da08aefeda59524ad3f919472fad41875c51e4b8cf53835acde5fd75352b04ce272f03b4a7cb808a57eeea8bfa82ae979a419eb7764b462edfcdcf9724bb96b462ea797d02c266bb64fb7c9fc3c9f6eb362401a982c99f375e9f4f66a4a0bc9557805d5f774f54b65174b6ccc2a2eedf397a2ee2b4333be8c279e7b76b6b7a45585d3b000cfb481e4d47a6b321955a37366f59a93d1386b752c491745b65c7252a6d5f63d4db99a4d66e3f53c5c47a43770b39a27a16e93fb56ad7ac3b36dee217818f0286c294c4a154e80056c97d9ab29bb239214aa237763b2f613411b1083960646e5748d377c68de09bb19f6f70d443af5f773b925a9b0e56fe66b854ea09fbfd1efd617b04bb73809f42d49324192092799908e956a7e76531cd0df11fded97dcc9043e59328c97a3c9930bc44b3d195fd0647f42b270ce899fa4fec876504a2be9e9ad339379c0cb0569acdd902c28f36a9d9e3c49b63f566ffd60687bbee376a9598f8ea8690dfa6cfff06f2477142df871a83f3a92566c44a7521385a7ffc4eb52e3af23ca249c46a4455fe93020598878fd514595839d6754035647b5bacd91c91965193375bde060107e9ee982bdb4b1d16194d37e188abf6e93c34152676094ca135d262b
at hudson.remoting.Channel$2.adapt(Channel.java:663)
at hudson.remoting.Channel$2.adapt(Channel.java:658)
at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
at hudson.FilePath.copyRecursiveTo(FilePath.java:1472)
... 13 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=5f65df7c3a2f784a797b59fd9c9f2fbbed89479fb8cb5cbe61c54b47d66dbfec9fa79e3df1f8d6f7cae76d7ce1a255ab8e7965f531dc0583020f25fe3f002240ddbfb193c9c9caeb89411224b126090620696bac044b9194c409453084284bb1fcdfb7beaa6edc08c9c919e76c621175e96e34fa525d55a86ef00f4d435a62d4bfa98064ee5f55f9f9b78724afab44aeb99e7d74d46cbb55ab4de87f2fc82eff3b01bcd69c4d0ed41bb242ce8d74a92030819431289aa4d95ec91481b4dc8ac77f619a2db55207d920f3f172a99f05b619cf2e2295c87063b8d623715777ba3c9e24648dd8d115755cae24927e076912cc7f8e603f9018f64770c0569eedef1ffcfcd597fb8fc13a98edde1dfc7c123dfeaaf2c39774a95466678b1feed68b5dbad75d653abf239379f787d9d99ddcfb4e9b2977d379443f90e877cbd5e8fc72b47b72ba7b7077f76565e7eee5b3ddbb3b898df933cb2631bd87d98cff21b3ef4ae580951afc2a63e3ce164bb28f5949933693a68683b914eb1190f95b690e4b61dd6de85549b0770311db4bf1e249c8b7d9823f74ce423d56ac6393f45ebd7aeb0fa5ed86bccc8ab7a3247e041a37b081e0948273f71349ce3793e07ef1709547e35941225ca6072d51b84c4e796a014460185fd9c464106f303593951745460a46ae928627d81df48184eb2b60b6e701a39e56a4090fd57faa43450fad76f4546de8eb9ebe3e91e5b2ed5419c0f5fed17e60647c611278c5029e007f3cf12712a97d550e0eca937dfe7740433185321c2971489e8da08aefeda59524ad3f919472fad41875c51e4b8cf53835acde5fd75352b04ce272f03b4a7cb808a57eeea8bfa82ae979a419eb7764b462edfcdcf9724bb96b462ea797d02c266bb64fb7c9fc3c9f6eb362401a982c99f375e9f4f66a4a0bc9557805d5f774f54b65174b6ccc2a2eedf397a2ee2b4333be8c279e7b76b6b7a45585d3b000cfb481e4d47a6b321955a37366f59a93d1386b752c491745b65c7252a6d5f63d4db99a4d66e3f53c5c47a43770b39a27a16e93fb56ad7ac3b36dee217818f0286c294c4a154e80056c97d9ab29bb239214aa237763b2f613411b1083960646e5748d377c68de09bb19f6f70d443af5f773b925a9b0e56fe66b854ea09fbfd1efd617b04bb73809f42d49324192092799908e956a7e76531cd0df11fded97dcc9043e59328c97a3c9930bc44b3d195fd0647f42b270ce899fa4fec876504a2be9e9ad339379c0cb0569acdd902c28f36a9d9e3c49b63f566ffd60687bbee376a9598f8ea8690dfa6cfff06f2477142df871a83f3a92566c44a7521385a7ffc4eb52e3af23ca249c46a4455fe93020598878fd514595839d6754035647b5bacd91c91965193375bde060107e9ee982bdb4b1d16194d37e188abf6e93c34152676094ca135d262b
at hudson.FilePath$TarCompression$2.extract(FilePath.java:534)
at hudson.FilePath$32.invoke(FilePath.java:1463)
at hudson.FilePath$32.invoke(FilePath.java:1460)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
at hudson.remoting.UserRequest.perform(UserRequest.java:114)
at hudson.remoting.UserRequest.perform(UserRequest.java:48)
at hudson.remoting.Request$2.run(Request.java:270)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:138)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:619)
Caused by: java.io.IOException: Not in GZIP format
at java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:137)
at java.util.zip.GZIPInputStream.(GZIPInputStream.java:58)
at hudson.FilePath$TarCompression$2.extract(FilePath.java:530)
... 12 more

timja commented 13 years ago

pdark:

We have the same problems (Builds failing because of "IOException2: Not in GZIP format" and "ZipException: invalid block type").

I can confirm that the problem is intermittent and that it still exists in 1.386.

If you work with streams, do you flush them properly?

timja commented 13 years ago

alexandre_navarro:

We have the same problems with a slave and a master. It occurs sometimes (1/2).

HUDSON] Archiving site from /home/frtdevxpp/hudson.ctt.arc/workspace/dsp_main_nightly_site/trunk/irquoterRS/target/site to /home/frtdevxpp/hudson/jobs/dsp_main_nightly_site/site/irquoterRS FATAL: Unable to copy site from /home/frtdevxpp/hudson.ctt.arc/workspace/dsp_main_nightly_site/trunk/irquoterRS/target/site to /home/frtdevxpp/hudson/jobs/dsp_main_nightly_site/site/irquoterRS hudson.util.IOException2 (http://grepcode.com/search?query=hudson.util.IOException2): hudson.util.IOException2: Not in GZIP format stream=d9665bb8c62217b2eb1b23965c3d0a17cea9e692a3c920f282a04a413f29823e099563d9ffcb13cb629ff7787f2f9b0b0d385ba3be1b38bbce15601ec24c81fd915cb64227eeade56cf625936b45e17f65030580431e920adac34728864d8f38859bda0edbba25a551b539a9cdc2552bde1cdd892a74046e25de7cab9fc080c7f135ae21b4b92eaa93ed97b52d32ddffa6cfece1981936689804221d7f253c58bb0fc37cc253f653bd97c0cfb56ee65187179df1a6b371804354f15a7037b67c641e9e0e473d8c785e0605435da0b83782ba2657f89e218993ea344e7645c20d0933ca0a827636b0ee7df08e5d34e24966c4ae8e7408436e58da7cb7fecf1b14075bf8bec08eb09f14fabd58527a07f0aefae0d813d3d74693386e0432e0cf3ebd6a85bf55df3409cc72c41a24a18528fcd3f37029797124220b41594cf82824710f3e48e7dd68c71073de686b62f137fd378f431d6ca6dc81a7508d0ac3f1632164427b73e939c43371e6cce10e80d1a106bc03cc6d70af3aa9d4879b1cf60e50a8b963850023ce615632c96ecc4f8bd95b214a4d5676892fb7d647ad1affcc712e961c89d75759f7d01b72c1397b4d16c39703821e1ca4d7aee84ff34fa3e7b64c77133262387071b287e1a34f851f5013786680edd557c36cc54754eee1fd41ad740d2960c984d011448633cdd7f7efa797fa36db3ca5b81189b42bebf53786c35289693dae9bde1d9e307841ca76aa5844e6662dd9fe70a86ba43e7b52984ba196a8d91dbb3c4cbdc6bedcb5a33f536e5939e6e233ef9b67a736aaf6d1af208684e20827e320301316a0e31cadec3b1d4b68273263551dfdd1241291274b5d5941bdb841226653f9d2edcb8049100522603448d628d20a8f388782d1724837a6e4ecbb3b854d87eb6e286b9c4dafc2dbf5522acd10666194a395a9ff70918eeb0e79cf3a7e9962567b0b0188c641c7ee0024e32021063728467b7f42931bedb069997217c3417eb0dd41cbc7afeee10bbb3d44f02cc7f47fd87c27a26779ebd797672345486dba6df8ec17f7a9a6860464ef85cda81267bfc98750221e771218f0b35a7e17b9629b387ddb34caeb741aa103b9377c33b7453df9a5a7c07d792aa0cb9c5042e785dea8d2bb835998cc418bf437f7f029eba7a6f07b5745558cdde98e03a85f01e4fead546c86c984064ff3cf6af089da971e577c958b0893fe8940036648de304292bceb4c541a46928b7a95c995e6847c3a2dd173e4bd9c664f864d03bc41ec9b71e6edc96e196d9c5eaf02d77aa99474089930b614427082a5b47d4440d95db5577af46abc6c44ea2dbf4bb4e2eff920dff6de843c57da81e83e693a895d9cf06899a58cdfb10869deb66ea91101154734126b18ab803400bbd5064f800a778006f247f028379f4d500a4b5c08e8b1db5b5304e3bffd77 at hudson.FilePath.copyRecursiveTo(FilePath.java:1474) at hudson.FilePath.copyRecursiveTo(FilePath.java:1399) at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81) at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:828) at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)

timja commented 13 years ago

pafo:

Consolse dump from Hudson 1.386

FATAL: Unable to copy site from /home/ci-hudson/jobs//workspace/sources//target/site to /home/ci-hudson/jobs//site/
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=636366470c8b4e5080b5c73ed5afaad3f4e6f078928be4f7776ad56258cc5a55a7c9cc7a3c98c739fd9c2bf4d63d314e4c86213ac78b2ff9103147b8d7a56bba14fb28deaaf0d07e7b12646495853b0fb5aa524bfb11220fc137bc7b66cfa056556974995d839a5c5c3561be8170d83471be0152ce032c291c9e011d92ad189e41bc44017e8178083746a6eb348359bf20e2704edfe063b421abfc8344eae3ccb47ce87afc3e031df54d87cf90e616f7da745d28b3fb0de201e1b627417ada5c88df2017bf6da5df300e0e1d33c97211db84790e7251da84790ec2f1d8847a0e0b05cdd0b258138fcfc6a640e9506b85715f167c16e0c088c7646364bbce42a8150e4cc8e3fc2e4cb42932921c7474364d0e4b8a3bdcabdbb9d2ab9a78dcb7edb1a377a2f8aa2617942d6bff5be877f4d50099a77b769277a2d6aa2617708d52fe43a6a1f4e2e20906b275955b61aa7121de2dc4e837484c7cc85c0c54938bb326cc5f140ea326ce5f0cf60003d2e42906c200a13f59fedb1065e9a73bff2d39e4785399dc4d7dd86c69e347476853e76e9af6d8c9d162e13b417915f2ef7fa574debd49ecaa08ef541f025c7a97e83870f4be0cf4a1623766f01118c9d0c6ce8cbde89ce6eaca78916ccbd8fb21fa6cd9f4dad399ff887c69116d17353a149ea2be8b6cc8111c9c9ce146e0e684ef59f05754955886533ad3f92be38f24ab38748b70dcbd8860c60e941a1d2aafb07190786cbded49d8897ab19a2a1c3c8171902a603cce3848151c9ee0384815469edc38482e8e9eb0384838209ed0bc7918d4f4cd91a72516120ed6c76800e9a876c548bd0b0e6e0a825957cb055a978d1d0e0e0b1edc7011b8dbc10d1d0fafd8c14d4a15aa896eb461f6c98e6e8403f0f14637daa0f8d8a31b7d70793109d21d1721d18d7878ba75ce6cd00e338196e54c032dc14eb8cadb0876ff5538929c38ffd5439bf1096f45a4b0d92b47e96875c5f0ff88c4f1b87e99e5ea34d359134dd69633fdf829e003eff2759ade25b39b583ff7c2743583b35b3a3abc9d324b271c084e8ea5a303c5c9b0749f88987a02e670d4e8b86f85cae6890762cb91cd9b9173cf4eb3522096c423c8e2cd3d3802a62d444854a2b3b0bb4352c0c338208693fed09265c991d15b6aac0cec104b2e8f8e63a636a94447272b882f97dd2611193de180688ccca7439e2960be4280ed9a7858b4ed4990758d4c29c8711f23adc1a01dc4639d310aa8ce0e2cfcc0436ae6ee9a191831122d7a6b1a5d944741686b91cef05f77863835b03a398bee046f4bd999413ba99b39385e107ba815210c3f96e784033ca2a99564fdc60b0cf67d280862582d176458f62ee9756ded5d52fd85a23bad3c7424f77ce3f555e2e051de4b06b40ea1b3f8ccb21c09b9b3a24392293a1f242b943d107bab561b338de338
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
    at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
    at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:822)
    at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)
    at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
    at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeStandaloneGoal(DefaultLifecycleExecutor.java:569)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:539)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:180)
    at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
    at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
    at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
    at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
    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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
    at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
    at hudson.maven.agent.Main.launch(Main.java:165)
    at hudson.maven.MavenBuilder.call(MavenBuilder.java:165)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:744)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:688)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:619)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=636366470c8b4e5080b5c73ed5afaad3f4e6f078928be4f7776ad56258cc5a55a7c9cc7a3c98c739fd9c2bf4d63d314e4c86213ac78b2ff9103147b8d7a56bba14fb28deaaf0d07e7b12646495853b0fb5aa524bfb11220fc137bc7b66cfa056556974995d839a5c5c3561be8170d83471be0152ce032c291c9e011d92ad189e41bc44017e8178083746a6eb348359bf20e2704edfe063b421abfc8344eae3ccb47ce87afc3e031df54d87cf90e616f7da745d28b3fb0de201e1b627417ada5c88df2017bf6da5df300e0e1d33c97211db84790e7251da84790ec2f1d8847a0e0b05cdd0b258138fcfc6a640e9506b85715f167c16e0c088c7646364bbce42a8150e4cc8e3fc2e4cb42932921c7474364d0e4b8a3bdcabdbb9d2ab9a78dcb7edb1a377a2f8aa2617942d6bff5be877f4d50099a77b769277a2d6aa2617708d52fe43a6a1f4e2e20906b275955b61aa7121de2dc4e837484c7cc85c0c54938bb326cc5f140ea326ce5f0cf60003d2e42906c200a13f59fedb1065e9a73bff2d39e4785399dc4d7dd86c69e347476853e76e9af6d8c9d162e13b417915f2ef7fa574debd49ecaa08ef541f025c7a97e83870f4be0cf4a1623766f01118c9d0c6ce8cbde89ce6eaca78916ccbd8fb21fa6cd9f4dad399ff887c69116d17353a149ea2be8b6cc8111c9c9ce146e0e684ef59f05754955886533ad3f92be38f24ab38748b70dcbd8860c60e941a1d2aafb07190786cbded49d8897ab19a2a1c3c8171902a603cce3848151c9ee0384815469edc38482e8e9eb0384838209ed0bc7918d4f4cd91a72516120ed6c76800e9a876c548bd0b0e6e0a825957cb055a978d1d0e0e0b1edc7011b8dbc10d1d0fafd8c14d4a15aa896eb461f6c98e6e8403f0f14637daa0f8d8a31b7d70793109d21d1721d18d7878ba75ce6cd00e338196e54c032dc14eb8cadb0876ff5538929c38ffd5439bf1096f45a4b0d92b47e96875c5f0ff88c4f1b87e99e5ea34d359134dd69633fdf829e003eff2759ade25b39b583ff7c2743583b35b3a3abc9d324b271c084e8ea5a303c5c9b0749f88987a02e670d4e8b86f85cae6890762cb91cd9b9173cf4eb3522096c423c8e2cd3d3802a62d444854a2b3b0bb4352c0c338208693fed09265c991d15b6aac0cec104b2e8f8e63a636a94447272b882f97dd2611193de180688ccca7439e2960be4280ed9a7858b4ed4990758d4c29c8711f23adc1a01dc4639d310aa8ce0e2cfcc0436ae6ee9a191831122d7a6b1a5d944741686b91cef05f77863835b03a398bee046f4bd999413ba99b39385e107ba815210c3f96e784033ca2a99564fdc60b0cf67d280862582d176458f62ee9756ded5d52fd85a23bad3c7424f77ce3f555e2e051de4b06b40ea1b3f8ccb21c09b9b3a24392293a1f242b943d107bab561b338de338
    at hudson.remoting.Channel$2.adapt(Channel.java:662)
    at hudson.remoting.Channel$2.adapt(Channel.java:657)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1472)
    ... 35 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=636366470c8b4e5080b5c73ed5afaad3f4e6f078928be4f7776ad56258cc5a55a7c9cc7a3c98c739fd9c2bf4d63d314e4c86213ac78b2ff9103147b8d7a56bba14fb28deaaf0d07e7b12646495853b0fb5aa524bfb11220fc137bc7b66cfa056556974995d839a5c5c3561be8170d83471be0152ce032c291c9e011d92ad189e41bc44017e8178083746a6eb348359bf20e2704edfe063b421abfc8344eae3ccb47ce87afc3e031df54d87cf90e616f7da745d28b3fb0de201e1b627417ada5c88df2017bf6da5df300e0e1d33c97211db84790e7251da84790ec2f1d8847a0e0b05cdd0b258138fcfc6a640e9506b85715f167c16e0c088c7646364bbce42a8150e4cc8e3fc2e4cb42932921c7474364d0e4b8a3bdcabdbb9d2ab9a78dcb7edb1a377a2f8aa2617942d6bff5be877f4d50099a77b769277a2d6aa2617708d52fe43a6a1f4e2e20906b275955b61aa7121de2dc4e837484c7cc85c0c54938bb326cc5f140ea326ce5f0cf60003d2e42906c200a13f59fedb1065e9a73bff2d39e4785399dc4d7dd86c69e347476853e76e9af6d8c9d162e13b417915f2ef7fa574debd49ecaa08ef541f025c7a97e83870f4be0cf4a1623766f01118c9d0c6ce8cbde89ce6eaca78916ccbd8fb21fa6cd9f4dad399ff887c69116d17353a149ea2be8b6cc8111c9c9ce146e0e684ef59f05754955886533ad3f92be38f24ab38748b70dcbd8860c60e941a1d2aafb07190786cbded49d8897ab19a2a1c3c8171902a603cce3848151c9ee0384815469edc38482e8e9eb0384838209ed0bc7918d4f4cd91a72516120ed6c76800e9a876c548bd0b0e6e0a825957cb055a978d1d0e0e0b1edc7011b8dbc10d1d0fafd8c14d4a15aa896eb461f6c98e6e8403f0f14637daa0f8d8a31b7d70793109d21d1721d18d7878ba75ce6cd00e338196e54c032dc14eb8cadb0876ff5538929c38ffd5439bf1096f45a4b0d92b47e96875c5f0ff88c4f1b87e99e5ea34d359134dd69633fdf829e003eff2759ade25b39b583ff7c2743583b35b3a3abc9d324b271c084e8ea5a303c5c9b0749f88987a02e670d4e8b86f85cae6890762cb91cd9b9173cf4eb3522096c423c8e2cd3d3802a62d444854a2b3b0bb4352c0c338208693fed09265c991d15b6aac0cec104b2e8f8e63a636a94447272b882f97dd2611193de180688ccca7439e2960be4280ed9a7858b4ed4990758d4c29c8711f23adc1a01dc4639d310aa8ce0e2cfcc0436ae6ee9a191831122d7a6b1a5d944741686b91cef05f77863835b03a398bee046f4bd999413ba99b39385e107ba815210c3f96e784033ca2a99564fdc60b0cf67d280862582d176458f62ee9756ded5d52fd85a23bad3c7424f77ce3f555e2e051de4b06b40ea1b3f8ccb21c09b9b3a24392293a1f242b943d107bab561b338de338
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:534)
    at hudson.FilePath$32.invoke(FilePath.java:1463)
    at hudson.FilePath$32.invoke(FilePath.java:1460)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)
    ... 9 more
Caused by: java.io.IOException: Not in GZIP format
    at java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:137)
    at java.util.zip.GZIPInputStream.(GZIPInputStream.java:58)
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:530)
    ... 12 more

timja commented 13 years ago

jchristi:

I believe I may be seeing this sporadically as well, but with a different error.
I only run with a master, no slaves. I only run with one single executor.
This is on 1.386

 
FATAL: Unable to copy site from /opt/hudson/.hudson/jobs//workspace//target/site to /opt/hudson/.hudson/jobs//site/
hudson.util.IOException2: java.lang.IllegalArgumentException: Negative time
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1474)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
    at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
    at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:822)
    at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)
    at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
    at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalWithLifecycle(DefaultLifecycleExecutor.java:556)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:535)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:180)
    at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
    at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
    at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
    at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
    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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
    at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
    at hudson.maven.agent.Main.launch(Main.java:165)
    at hudson.maven.MavenBuilder.call(MavenBuilder.java:165)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:744)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:688)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:619)
Caused by: java.util.concurrent.ExecutionException: java.lang.IllegalArgumentException: Negative time
    at hudson.remoting.Channel$2.adapt(Channel.java:662)
    at hudson.remoting.Channel$2.adapt(Channel.java:657)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1472)
    ... 35 more
Caused by: java.lang.IllegalArgumentException: Negative time
    at java.io.File.setLastModified(File.java:1258)
    at hudson.FilePath.readFromTar(FilePath.java:1566)
    at hudson.FilePath.access$100(FilePath.java:159)
    at hudson.FilePath$32.invoke(FilePath.java:1463)
    at hudson.FilePath$32.invoke(FilePath.java:1460)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1899)

timja commented 13 years ago

jchristi:

An additional stacktrace on a different sporadic error.
Apologies if my issues are not similar enough, but I felt based on some of the other stacktraces in this issue that they are related.
Again, Im only using the master and have it configured to only have a single executor.

 
[HUDSON] Archiving site from /opt/hudson/.hudson/jobs//workspace//target/site to /opt/hudson/.hudson/jobs//site/
[HUDSON] Archiving disabled - not archiving /opt/hudson/.hudson/jobs//workspace//pom.xml
[INFO] ------------------------------------------------------------------------
[ERROR] FATAL ERROR
[INFO] ------------------------------------------------------------------------
[INFO] null
[INFO] ------------------------------------------------------------------------
[INFO] Trace
java.lang.NullPointerException
    at hudson.remoting.ProxyOutputStream._write(ProxyOutputStream.java:118)
    at hudson.remoting.ProxyOutputStream.write(ProxyOutputStream.java:103)
    at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65)
    at java.io.BufferedOutputStream.write(BufferedOutputStream.java:109)
    at java.util.zip.DeflaterOutputStream.deflate(DeflaterOutputStream.java:161)
    at java.util.zip.DeflaterOutputStream.write(DeflaterOutputStream.java:118)
    at java.util.zip.GZIPOutputStream.write(GZIPOutputStream.java:72)
    at java.io.BufferedOutputStream.write(BufferedOutputStream.java:105)
    at org.apache.tools.tar.TarBuffer.writeBlock(TarBuffer.java:410)
    at org.apache.tools.tar.TarBuffer.writeRecord(TarBuffer.java:388)
    at hudson.org.apache.tools.tar.TarOutputStream.write(TarOutputStream.java:337)
    at hudson.util.io.TarArchiver.visit(TarArchiver.java:103)
    at hudson.util.DirScanner$Glob.scan(DirScanner.java:104)
    at hudson.FilePath.writeToTar(FilePath.java:1543)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1470)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1399)
    at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
    at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:822)
    at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:300)
    at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
    at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalWithLifecycle(DefaultLifecycleExecutor.java:556)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:535)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:180)
    at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
    at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
    at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
    at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
    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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
    at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
    at hudson.maven.agent.Main.launch(Main.java:165)
    at hudson.maven.MavenBuilder.call(MavenBuilder.java:165)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:744)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:688)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:619)

timja commented 13 years ago

jchristi:

Looking at the code, if I'm hitting this error in FilePath.java:1474, then it looks like it believes its doing a local -> remote copy correct?
This is not right, I have no agents, just the master, so shouldn't this activity be able to be a local to local operation?

Is there any way to disable Hudson from archiving of the generated site to see if that will allow me to work around this issue here?

I've already got "Disable automatic artifact archiving" set for the job.

timja commented 13 years ago

scooper4711:

I'm getting this on site generation/archiving, it's the same stack trace as lynggaard. I'm on 1.383

timja commented 13 years ago

gpablo:

The same for me. The last exception is:

Caused by: java.util.zip.ZipException: too many length or distance symbols
at java.util.zip.InflaterInputStream.read(InflaterInputStream.java:140)
at java.util.zip.GZIPInputStream.read(GZIPInputStream.java:87)
at org.apache.tools.tar.TarBuffer.readBlock(TarBuffer.java:257)
at org.apache.tools.tar.TarBuffer.readRecord(TarBuffer.java:223)
at hudson.org.apache.tools.tar.TarInputStream.read(TarInputStream.java:345)
at java.io.FilterInputStream.read(FilterInputStream.java:90)
at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1025)
at org.apache.commons.io.IOUtils.copy(IOUtils.java:999)
at hudson.util.IOUtils.copy(IOUtils.java:33)
at hudson.FilePath.readFromTar(FilePath.java:1565)

timja commented 13 years ago

u333992:

I have the same problem on 1.386. I currently run about 20 projects on Hudson and from time to time some build failed with the error messages above as running mvn site.

timja commented 13 years ago

orrc:

I'm seeing the same issue on Hudson 1.392 when copying artifacts:

ERROR: Failed to copy artifacts from job-poll with filter: **/*.apk
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format

timja commented 13 years ago

jtheuer:

I have a similar issue when excuting mvn site:site

Unable to find source-code formatter for language: lob. Available languages are: actionscript, ada, applescript, bash, c, c#, c++, cpp, css, erlang, go, groovy, haskell, html, java, javascript, js, json, lua, none, nyan, objc, perl, php, python, r, rainbow, ruby, scala, sh, sql, swift, visualbasic, xml, yaml

hudson.util.IOException2: Not in GZIP format
stream=0db90b28ff3709330ca6afe82a0d7768dee603d267613201e1bdc37eb7db1e3e7c6a0f479d7e8f9eb0fabecb377ff9ad2c0f1e20d49500d0ed371b32852aecdb7ce1eadc353eb41f3e0eda1fc80ed17e5f040c839e0d02799b7315aba731dbbb109d2edee60b81dcfe457e18741b1dc215cefb7c61b81f761f068d61e3eee17ed41ec27250bb0a7e973f4c5e688a810372638c849bc8f5a1f0d535b82b3dd415b68ca97b8bf42b9474c58d20c9abebebfe2f0f778d5f1e7e210684fd3e3b29dd0ac767171c9f8b82a3d373e801ef0b84e3b30b8e02e8c12f5d91d544be65f698f8943f2c378dee882c27f4bf02461ff6efc8e0e46ffe637f68f7efdaf290f08278973f0cb7edce875b999915c406767dca1f964e8b189dad22c61d0902d86f0b808299db54229df7f9c3d1ed8ce40710084113df17054124f73df0888ff94373d7bfee74db0fadf64de3be2b3f7c6a74ef89fa0afbb630d838a1dc9ff287a5d77f180d3b2d018ce763fed0802c817e61ffe73ffeb0ddecdfddb57b2dea577818c90df9ded63a1b7ecc1f5238a7118039ef0b8003b885cb1381c4f5a9585884c407bf2b082e3157054a97979d0be6dffb6b1074fa5f21a30b5563bf2d028a417b08ce993bb2f304485c1ff387466e7c10ac61bf2d040a97a1e7fe54002c7d0241bf807187a0b9e06f01637f1ed8eb8af33e7f38ee7b4469777a6d22a1f6db02a0e09e534111efe7fce1a17e48018ceb43fe90fc52bb2ac0334336e19f33f11f47446a7f4d8ee1081453f19a52abe65ebe7b83e8bb9f3f8cfefe2e4ee931cfd54877d1317f8cd586aa635f419855d355766c4bb0d54e3eedeb2cc3d08377d85f85fd0215d0c2be179e7b285c46a13d62f755198becf33736e739f5d0b687f6f96f441f2ed3f1926869f2dba60c2082127ff5dd04a7f997e8c49bc06b63364150fac15620de9be64531351c712f276d4b991d3b4ad55cd1b20e987c2bb56525493175a73f5b04f6b91c40010989a2e73f0084758070cf887917c2b52be8cfb9820fdf796a42ec525422452dc0080c41c27bddba2882b08cc51979b91034ae90a54396417d6dcd74283e619793f0a4b5c84d5c8bcc5b1d598fcad38697a12a991e9961eb78947e359f9928f8ead623a59c9491a3324405c2ddcbcfec5443262d0de3ad1d6817a07956adb9a7fc9e541219fd9354b44b4b71b08b48a5531ed957060bd525e5a878a54eccaf446528087219425d50fb863dd31ceae45b139918b894271d56d098688465a5462a35929a1a6968da71067a83746bab8ebd8aca95454a5d95e5ccb208e0be3c9273f5edf231ff90cfa803277853b0918544448d958e9884be0a961d651228a66d620b522e987665eaf1da80dceab48222bdc64b4b6ddb26f4f152b78e60e7ae2e27ea933a592b1aabc3fdfa2b11c16c76562cd94439658e
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1502)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1427)
    at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
    at hudson.maven.MavenModuleSetBuild$Builder.postExecute(MavenModuleSetBuild.java:940)
    at hudson.maven.MavenBuilder$Adapter.postExecute(MavenBuilder.java:336)
    at hudson.maven.agent.PluginManagerInterceptor$1MojoIntercepterImpl.callPost(PluginManagerInterceptor.java:170)
    at hudson.maven.agent.PluginManagerInterceptor.executeMojo(PluginManagerInterceptor.java:183)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoals(DefaultLifecycleExecutor.java:694)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeStandaloneGoal(DefaultLifecycleExecutor.java:569)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoal(DefaultLifecycleExecutor.java:539)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeGoalAndHandleFailures(DefaultLifecycleExecutor.java:387)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.executeTaskSegments(DefaultLifecycleExecutor.java:348)
    at org.apache.maven.lifecycle.DefaultLifecycleExecutor.execute(DefaultLifecycleExecutor.java:180)
    at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:65)
    at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:328)
    at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:138)
    at org.apache.maven.cli.MavenCli.main(MavenCli.java:362)
    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.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315)
    at org.codehaus.classworlds.Launcher.launch(Launcher.java:255)
    at hudson.maven.agent.Main.launch(Main.java:173)
    at hudson.maven.MavenBuilder.call(MavenBuilder.java:164)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:861)
    at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:792)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:662)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=0db90b28ff3709330ca6afe82a0d7768dee603d267613201e1bdc37eb7db1e3e7c6a0f479d7e8f9eb0fabecb377ff9ad2c0f1e20d49500d0ed371b32852aecdb7ce1eadc353eb41f3e0eda1fc80ed17e5f040c839e0d02799b7315aba731dbbb109d2edee60b81dcfe457e18741b1dc215cefb7c61b81f761f068d61e3eee17ed41ec27250bb0a7e973f4c5e688a810372638c849bc8f5a1f0d535b82b3dd415b68ca97b8bf42b9474c58d20c9abebebfe2f0f778d5f1e7e210684fd3e3b29dd0ac767171c9f8b82a3d373e801ef0b84e3b30b8e02e8c12f5d91d544be65f698f8943f2c378dee882c27f4bf02461ff6efc8e0e46ffe637f68f7efdaf290f08278973f0cb7edce875b999915c406767dca1f964e8b189dad22c61d0902d86f0b808299db54229df7f9c3d1ed8ce40710084113df17054124f73df0888ff94373d7bfee74db0fadf64de3be2b3f7c6a74ef89fa0afbb630d838a1dc9ff287a5d77f180d3b2d018ce763fed0802c817e61ffe73ffeb0ddecdfddb57b2dea577818c90df9ded63a1b7ecc1f5238a7118039ef0b8003b885cb1381c4f5a9585884c407bf2b082e3157054a97979d0be6dffb6b1074fa5f21a30b5563bf2d028a417b08ce993bb2f304485c1ff387466e7c10ac61bf2d040a97a1e7fe54002c7d0241bf807187a0b9e06f01637f1ed8eb8af33e7f38ee7b4469777a6d22a1f6db02a0e09e534111efe7fce1a17e48018ceb43fe90fc52bb2ac0334336e19f33f11f47446a7f4d8ee1081453f19a52abe65ebe7b83e8bb9f3f8cfefe2e4ee931cfd54877d1317f8cd586aa635f419855d355766c4bb0d54e3eedeb2cc3d08377d85f85fd0215d0c2be179e7b285c46a13d62f755198becf33736e739f5d0b687f6f96f441f2ed3f1926869f2dba60c2082127ff5dd04a7f997e8c49bc06b63364150fac15620de9be64531351c712f276d4b991d3b4ad55cd1b20e987c2bb56525493175a73f5b04f6b91c40010989a2e73f0084758070cf887917c2b52be8cfb9820fdf796a42ec525422452dc0080c41c27bddba2882b08cc51979b91034ae90a54396417d6dcd74283e619793f0a4b5c84d5c8bcc5b1d598fcad38697a12a991e9961eb78947e359f9928f8ead623a59c9491a3324405c2ddcbcfec5443262d0de3ad1d6817a07956adb9a7fc9e541219fd9354b44b4b71b08b48a5531ed957060bd525e5a878a54eccaf446528087219425d50fb863dd31ceae45b139918b894271d56d098688465a5462a35929a1a6968da71067a83746bab8ebd8aca95454a5d95e5ccb208e0be3c9273f5edf231ff90cfa803277853b0918544448d958e9884be0a961d651228a66d620b522e987665eaf1da80dceab48222bdc64b4b6ddb26f4f152b78e60e7ae2e27ea933a592b1aabc3fdfa2b11c16c76562cd94439658e
    at hudson.remoting.Channel$2.adapt(Channel.java:662)
    at hudson.remoting.Channel$2.adapt(Channel.java:657)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1500)
    ... 35 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=0db90b28ff3709330ca6afe82a0d7768dee603d267613201e1bdc37eb7db1e3e7c6a0f479d7e8f9eb0fabecb377ff9ad2c0f1e20d49500d0ed371b32852aecdb7ce1eadc353eb41f3e0eda1fc80ed17e5f040c839e0d02799b7315aba731dbbb109d2edee60b81dcfe457e18741b1dc215cefb7c61b81f761f068d61e3eee17ed41ec27250bb0a7e973f4c5e688a810372638c849bc8f5a1f0d535b82b3dd415b68ca97b8bf42b9474c58d20c9abebebfe2f0f778d5f1e7e210684fd3e3b29dd0ac767171c9f8b82a3d373e801ef0b84e3b30b8e02e8c12f5d91d544be65f698f8943f2c378dee882c27f4bf02461ff6efc8e0e46ffe637f68f7efdaf290f08278973f0cb7edce875b999915c406767dca1f964e8b189dad22c61d0902d86f0b808299db54229df7f9c3d1ed8ce40710084113df17054124f73df0888ff94373d7bfee74db0fadf64de3be2b3f7c6a74ef89fa0afbb630d838a1dc9ff287a5d77f180d3b2d018ce763fed0802c817e61ffe73ffeb0ddecdfddb57b2dea577818c90df9ded63a1b7ecc1f5238a7118039ef0b8003b885cb1381c4f5a9585884c407bf2b082e3157054a97979d0be6dffb6b1074fa5f21a30b5563bf2d028a417b08ce993bb2f304485c1ff387466e7c10ac61bf2d040a97a1e7fe54002c7d0241bf807187a0b9e06f01637f1ed8eb8af33e7f38ee7b4469777a6d22a1f6db02a0e09e534111efe7fce1a17e48018ceb43fe90fc52bb2ac0334336e19f33f11f47446a7f4d8ee1081453f19a52abe65ebe7b83e8bb9f3f8cfefe2e4ee931cfd54877d1317f8cd586aa635f419855d355766c4bb0d54e3eedeb2cc3d08377d85f85fd0215d0c2be179e7b285c46a13d62f755198becf33736e739f5d0b687f6f96f441f2ed3f1926869f2dba60c2082127ff5dd04a7f997e8c49bc06b63364150fac15620de9be64531351c712f276d4b991d3b4ad55cd1b20e987c2bb56525493175a73f5b04f6b91c40010989a2e73f0084758070cf887917c2b52be8cfb9820fdf796a42ec525422452dc0080c41c27bddba2882b08cc51979b91034ae90a54396417d6dcd74283e619793f0a4b5c84d5c8bcc5b1d598fcad38697a12a991e9961eb78947e359f9928f8ead623a59c9491a3324405c2ddcbcfec5443262d0de3ad1d6817a07956adb9a7fc9e541219fd9354b44b4b71b08b48a5531ed957060bd525e5a878a54eccaf446528087219425d50fb863dd31ceae45b139918b894271d56d098688465a5462a35929a1a6968da71067a83746bab8ebd8aca95454a5d95e5ccb208e0be3c9273f5edf231ff90cfa803277853b0918544448d958e9884be0a961d651228a66d620b522e987665eaf1da80dceab48222bdc64b4b6ddb26f4f152b78e60e7ae2e27ea933a592b1aabc3fdfa2b11c16c76562cd94439658e
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:537)
    at hudson.FilePath$32.invoke(FilePath.java:1491)
    at hudson.FilePath$32.invoke(FilePath.java:1488)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1925)
    ... 9 more
Caused by: java.io.IOException: Not in GZIP format
    at java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:137)
    at java.util.zip.GZIPInputStream.(GZIPInputStream.java:58)
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:533)
    ... 12 more

It fails randomly on different submodules.

timja commented 13 years ago

jtheuer:

Forgot: Hudson ver. 1.393

timja commented 13 years ago

mlb5000:

When upgrading from 1.368 to 1.393 this error started rearing its ugly head, making all of our remote jobs extremely unreliable and nearly unusable. We are receiving both the

Not in GZIP format

and

Fatal: null NegativeArraySizeException

variations of the error and I can't seem to find any one thing that causes the error consistently.

timja commented 13 years ago

mlb5000:

@kohsuke

After investigating this issue a little further, it appears that this was a known issue as far back as 2009-03-11 when TAR support was initially added to FilePath.java.

timja commented 13 years ago

mlb5000:

Perhaps there is a mismatch in the handoff between the local and remote machine that is causing the code to try and decompress a TAR as a GZIP file?

timja commented 13 years ago

kevinp2:

The CopyArtifact plugin has been essentially broken for me with this error for the last few months I have had to stop using it.

Sadly, Hudson seems to be accumulating a long list of serious regressions in basic functionality. For instance, piping the console of a shell script running on a slave has stopped working too.

timja commented 13 years ago

mbaker000:

Ok, I've spent the better part of the last day looking into this issue and I've been able to eliminate two of the three failures I've seen listed in this post. I was able to eliminate the NullPointerException and NegativeArrayIndexException variants but I haven't been able to track down the "Not in GZIP format" error yet. That one will require more time, I believe, since it appears these were all the result of a race condition. Needless to say, those are notoriously difficult to track down. I'm not particularly happy with the way I had to fix it. I feel like I'm fixing the symptom instead of the problem, but it functions well enough for now. If I had the time I would actually prefer to rewrite all of the code in this particular part of the system. The unit tests only cover about 50% of the code and there are some design decisions with the buffer control I don't really agree with, but I would need to better understand the author's intent before I dove that deep.

I tested this using a Matrix job that is configured to run against a remote Windows slave and copies a 75MB self extracting executable (so it's already compressed) from the master Hudson server to the slave using the Copy Artifacts plugin. Without the fix it was failing roughly 2/10 times (20%), but that sample was relatively small (only 10 builds). After applying my fix I set the job to run every minute and walked away from it for a while. When I came back it had only failed 4/121 times (3.3%), three times with this error:

Started by upstream project "TestMatrix" build number 174
Building remotely on WindowsVista
ERROR: Failed to copy artifacts from Master with filter: selfextracting.exe
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=[snip....]
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1508)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1433)
    at hudson.plugins.copyartifact.FilePathCopyMethod.copyAll(FilePathCopyMethod.java:65)
    at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:194)
    at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:168)
    at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
    at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:622)
    at hudson.model.Build$RunnerImpl.build(Build.java:172)
    at hudson.model.Build$RunnerImpl.doRun(Build.java:137)
    at hudson.model.AbstractBuild$AbstractRunner.run(AbstractBuild.java:420)
    at hudson.model.Run.run(Run.java:1362)
    at hudson.matrix.MatrixRun.run(MatrixRun.java:137)
    at hudson.model.ResourceController.execute(ResourceController.java:88)
    at hudson.model.Executor.run(Executor.java:145)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=[snip....]
    at hudson.remoting.Channel$2.adapt(Channel.java:662)
    at hudson.remoting.Channel$2.adapt(Channel.java:657)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1506)
    ... 13 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=[snip....]
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:537)
    at hudson.FilePath$32.invoke(FilePath.java:1497)
    at hudson.FilePath$32.invoke(FilePath.java:1494)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1931)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
    at java.util.concurrent.FutureTask$Sync.innerRun(Unknown Source)
    at java.util.concurrent.FutureTask.run(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
    at hudson.remoting.Engine$1$1.run(Engine.java:59)
    at java.lang.Thread.run(Unknown Source)
Caused by: java.io.IOException: Not in GZIP format
    at java.util.zip.GZIPInputStream.readHeader(Unknown Source)
    at java.util.zip.GZIPInputStream.(Unknown Source)
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:533)
    ... 13 more
Archiving artifacts
Finished: FAILURE

and once with this error:

Started by upstream project "TestMatrix" build number 246
Building remotely on WindowsVista
ERROR: Failed to copy artifacts from Master with filter: selfextracting.exe
hudson.util.IOException2: hudson.util.IOException2: Failed to extract /Users/user/.hudson/jobs/Master/builds/2011-01-26_22-51-46/archive/selfextracting.exe
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1508)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1433)
    at hudson.plugins.copyartifact.FilePathCopyMethod.copyAll(FilePathCopyMethod.java:65)
    at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:194)
    at hudson.plugins.copyartifact.CopyArtifact.perform(CopyArtifact.java:168)
    at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
    at hudson.model.AbstractBuild$AbstractRunner.perform(AbstractBuild.java:622)
    at hudson.model.Build$RunnerImpl.build(Build.java:172)
    at hudson.model.Build$RunnerImpl.doRun(Build.java:137)
    at hudson.model.AbstractBuild$AbstractRunner.run(AbstractBuild.java:420)
    at hudson.model.Run.run(Run.java:1362)
    at hudson.matrix.MatrixRun.run(MatrixRun.java:137)
    at hudson.model.ResourceController.execute(ResourceController.java:88)
    at hudson.model.Executor.run(Executor.java:145)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Failed to extract /Users/user/.hudson/jobs/Master/builds/2011-01-26_22-51-46/archive/selfextracting.exe
    at hudson.remoting.Channel$2.adapt(Channel.java:662)
    at hudson.remoting.Channel$2.adapt(Channel.java:657)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1506)
    ... 13 more
Caused by: hudson.util.IOException2: Failed to extract /Users/user/.hudson/jobs/Master/builds/2011-01-26_22-51-46/archive/selfextracting.exe
    at hudson.FilePath.readFromTar(FilePath.java:1607)
    at hudson.FilePath.access$100(FilePath.java:162)
    at hudson.FilePath$32.invoke(FilePath.java:1497)
    at hudson.FilePath$32.invoke(FilePath.java:1494)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1931)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
    at java.util.concurrent.FutureTask$Sync.innerRun(Unknown Source)
    at java.util.concurrent.FutureTask.run(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
    at hudson.remoting.Engine$1$1.run(Engine.java:59)
    at java.lang.Thread.run(Unknown Source)
Caused by: java.util.zip.ZipException: oversubscribed dynamic bit lengths tree
    at java.util.zip.InflaterInputStream.read(Unknown Source)
    at java.util.zip.GZIPInputStream.read(Unknown Source)
    at org.apache.tools.tar.TarBuffer.readBlock(TarBuffer.java:257)
    at org.apache.tools.tar.TarBuffer.readRecord(TarBuffer.java:223)
    at hudson.org.apache.tools.tar.TarInputStream.read(TarInputStream.java:345)
    at java.io.FilterInputStream.read(Unknown Source)
    at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1025)
    at org.apache.commons.io.IOUtils.copy(IOUtils.java:999)
    at hudson.util.IOUtils.copy(IOUtils.java:33)
    at hudson.FilePath.readFromTar(FilePath.java:1599)
    ... 14 more
Archiving artifacts
Finished: FAILURE

I haven't tracked down either of these yet but I do believe that my fix should block the other two failures that were affecting people. Hopefully this can get integrated ASAP.

timja commented 13 years ago

mbaker000:

Also, the AssertionError people were seeing was the result of the buffer's available space counter being allowed to go negative. The assertion was just commented out but I believe my changes should legitimately fix that as well.

timja commented 13 years ago

mindless:

mbaker000, HUGE thanks for digging into this!
Where can we find your patch? A pull request on github would be great, but an attachment here is fine too.

timja commented 13 years ago

mbaker000:

@mindless - No problem, I'm glad to help. I'll submit a pull request later today

timja commented 13 years ago

mbaker000:

Pull request submitted (hopefully I send it to the right place).

timja commented 13 years ago

mindless:

Kohsuke will likely see it, but in future make the pull request against hudson/hudson instead of kohsuke/hudson, thanks!

timja commented 13 years ago

mbaker000:

My pleasure. FYI, do you think we should close this out and create an entirely separate issue for the "Not in GZIP format" problem? It's going to require its own work to track it down and appears to be a different issue than the one initially reported here.

timja commented 13 years ago

mbaker000:

Do you want me to close this request and open one against hudson/hudson?

timja commented 13 years ago

mindless:

@close-- once your patch is accepted, yes I think we should close this one.. if for no reason other than it being toooo wiiiide

timja commented 13 years ago

mbaker000:

@mindless - Does the Hudson group have any sort of bug triage procedures in place? It sounds like there are some people who feel like the bugs are piling up without any plan to address them. I doubt this is the best forum to have this discussion, so please let me know where you think I should bring up this discussion if necessary. I'm interested in contributing further and feel like I should familiarize myself with the Hudson (now Jenkins) team's modus operandi before I go in and start messing people up.

timja commented 13 years ago

mindless:

There haven't been enough bug fixers to have much of a process in place.. anything unassigned or long dormant in jira is up for grabs, so feel free to assign yourself anywhere you can help out! Use the dev list for any needed process discussion.

timja commented 13 years ago

lacostej:

I've just made the following ocmment on HUDSON-7745 (I meant to do it here)

I've created a simple setup that reproduces the problem (and several others...).

I have a master/slave running on the same machine, 3 projects

one upstream containing a WAR file artifact (11 M)
2 downstreams that use the copy artifact plugin to copy the upstream artifact
these projects are triggered by each other (i.e. downstream1 is triggered by downstream2 and vice versa)
one of the 2 downstream has also a cron to trigger a build every minute, just so that I don't have to
quiet period: 0
It takes about on average 10-15 seconds to trigger a failure.

So far I've reproduced many various failures:

Some causes:

Caused by: java.util.zip.ZipException: too many length or distance symbols
Caused by: java.io.IOException: Not in GZIP format
slave unavailable ?
Unable to access workspace for artifact copy. Slave node offline?
FATAL: null
java.lang.NullPointerException
Caused by: java.util.zip.ZipException: invalid stored block lengths
Caused by: java.util.zip.ZipException: invalid stored block lengths
then some new ones:

[Winstone 2011/02/03 03:29:23] - Untrapped Error in Servlet
javax.servlet.ServletException: java.lang.NullPointerException
at org.kohsuke.stapler.Stapler.tryInvoke(Stapler.java:597)
at org.kohsuke.stapler.Stapler.invoke(Stapler.java:640)
at org.kohsuke.stapler.MetaClass$13.dispatch(MetaClass.java:382)
at org.kohsuke.stapler.Stapler.tryInvoke(Stapler.java:562)
at org.kohsuke.stapler.Stapler.invoke(Stapler.java:640)
at org.kohsuke.stapler.MetaClass$7.doDispatch(MetaClass.java:242)
at org.kohsuke.stapler.NameBasedDispatcher.dispatch(NameBasedDispatcher.java:53)
at org.kohsuke.stapler.Stapler.tryInvoke(Stapler.java:562)
at org.kohsuke.stapler.Stapler.invoke(Stapler.java:640)
at org.kohsuke.stapler.Stapler.invoke(Stapler.java:478)
at org.kohsuke.stapler.Stapler.service(Stapler.java:160)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:45)
at winstone.ServletConfiguration.execute(ServletConfiguration.java:249)
at winstone.RequestDispatcher.forward(RequestDispatcher.java:335)
at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:378)
at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:94)
at hudson.util.PluginServletFilter.doFilter(PluginServletFilter.java:86)
at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
at hudson.security.csrf.CrumbFilter.doFilter(CrumbFilter.java:47)
at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:84)
at hudson.security.ChainedServletFilter.doFilter(ChainedServletFilter.java:76)
at hudson.security.HudsonFilter.doFilter(HudsonFilter.java:164)
at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
at hudson.util.CharacterEncodingFilter.doFilter(CharacterEncodingFilter.java:81)
at winstone.FilterConfiguration.execute(FilterConfiguration.java:195)
at winstone.RequestDispatcher.doFilter(RequestDispatcher.java:368)
at winstone.RequestDispatcher.forward(RequestDispatcher.java:333)
at winstone.RequestHandlerThread.processRequest(RequestHandlerThread.java:244)
at winstone.RequestHandlerThread.run(RequestHandlerThread.java:150)
at java.lang.Thread.run(Thread.java:662)
Caused by: java.lang.NullPointerException
at java.lang.String.compareTo(String.java:1167)
at hudson.model.Job$2.compare(Job.java:447)
at hudson.model.Job$2.compare(Job.java:441)
at hudson.widgets.HistoryWidget.doAjax(HistoryWidget.java:163)
at sun.reflect.GeneratedMethodAccessor110.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.kohsuke.stapler.Function$InstanceFunction.invoke(Function.java:282)
at org.kohsuke.stapler.Function.bindAndInvoke(Function.java:149)
at org.kohsuke.stapler.Function.bindAndInvokeAndServeResponse(Function.java:88)
at org.kohsuke.stapler.MetaClass$1.doDispatch(MetaClass.java:102)
at org.kohsuke.stapler.NameBasedDispatcher.dispatch(NameBasedDispatcher.java:53)
at org.kohsuke.stapler.Stapler.tryInvoke(Stapler.java:562)
... 33 more

Etc. All that in 15 minutes.

Note my environment is a Linux box with an encrypted file system. I know it created some issues to Intellij so.

timja commented 13 years ago

lacostej:

It's highly probable that koshuke accidentaly fixed that issue as part of 1.396.

The commit: https://github.com/lacostej/jenkins/commit/5c91eb1fe58b4f47b210a960ca2f9db6039507e9

The related commit https://github.com/jenkinsci/jenkins/commit/5f51597ad425e880ee347a8a71f39cfb38c5348d#diff-4 sounds appeared 4 days before 1.377 so it's probably the cause.

I can't reproduce the issue anymore on my test environment while I could do it every 10-14 seconds yesterday. I've passed over 3000 builds without failure now. And if I revert that particular commit on 1.397-HEAD the problems reappear right away.

mbaker000, we perhaps don't need your patches then. Can you test 1.396 in your environment (without your patches) ?

I would suggest anyone with this blocking issue to try the latest hudson release and report. We might have to update the release notes for 1.396.

timja commented 13 years ago

nparry:

Are you sure that made it into 1.396? Looking at the commit graph it looks like the RC branch for 396 split off before that commit was made, and it is part of the 1.397-SNAPSHOT series.

timja commented 13 years ago

kohsuke:

This will be a part of 1.397.

timja commented 13 years ago

mbaker000:

@lacostej that certainly looks like it would cause a problem. I'm eager to test out 1.397 so we can finally get off 1.370.

timja commented 13 years ago

mbaker000:

@lacostej When building the mainline I had to modify the jenkins/war/pom.xml file in the to this:

"org.jvnet.hudson" artifactId="executable-war" version="1.17" type="jar" property="executable-war.jar" />

instead of trying to pull version 1.18-SNAPSHOT, which doesn't exist. Also, it doesn't appear that a Jenkins build has run on ci.jenkins-ci.org for a few days. Is that common when preparing for a release or is it just because of the infrastructure transition? I tried to kick one off but remote-slave-2 (which I guess jenkins_main_trunk is tied to) is offline.

Anyway, testing with the same configuration as earlier: OS X 10.6.6 Master to Vista Slave, copying a 74MB file from an upstream project to the remote machine, downloading another file from the slave, and running every minute I ended up with the following results: 120 builds, no failures. As best I can tell from this testing the issue appears to be fixed. As of right now it looks like you won't need my patch after all. That's fine with me, I'll contribute some code eventually .

timja commented 13 years ago

kohsuke:

Marking this as fixed for 1.397, given the report.

timja commented 13 years ago

scm_issue_link:

Code changed in jenkins
User: Jerome Lacoste
Path:
remoting/src/main/java/hudson/remoting/ProxyInputStream.java
http://jenkins-ci.org/commit/core/31b8361d3152fb7970e1c11c906a763fa1aa5c25
Log:
~~JENKINS-7836~~ tentative fix for the copy from slave to master issues. The problem looks similar to ~~JENKINS-7745~~, so we might as well synchronized the ProxyInputStream.

timja commented 13 years ago

youngm:

I am still seeing this issue in Jenkins 1.397:

[HUDSON] Archiving site from /home/bldmgr/Hudson/workspace/stack-pet-store-was/ui/web/target/site to /home/bldmgr/Hudson/jobs/stack-pet-store-was/site/stack-pet-store-was-ui-web
FATAL: Unable to copy site from /home/bldmgr/Hudson/workspace/stack-pet-store-was/ui/web/target/site to /home/bldmgr/Hudson/jobs/stack-pet-store-was/site/stack-pet-store-was-ui-web
hudson.util.IOException2: hudson.util.IOException2: Not in GZIP format
stream=51345efc064da2bd9d992c49508e16ebd2227bf756668bca5d81bfe138a7d182c7f78f701ad50e8f552bc6d64be25a0fd0b5a8d3ba2724e5523884990505ad50f81910150dc269c9ea8992d54db6e0f1fd23bcc96a87c7aa2921ab0b9e1bac7b7193efc1bf4e76371e502ff50a412d2ef60c4849433f27aba5a585b4d424beb133298946ccb9ba8a6bb5459e019e811c84c9445b347b743403393dbd0fc7f07d8b602d82ad8e60491a0ce2708fc58b5450abf2e6192095ae2356b598f584a54db54a5c2b49afc311a683491d3b80c7cf8717e85bc80bb6c6d081c1eaa5dbce5818de5e291aaf8c5dcb0a3f079cc32bdd5a746b59f266a4740b483902ec0c3076ae8b71bd7b32b8778e94ee2bdc92524b4adf2d29613865e73c8ac3e9244e82e1defca3322d2d2ffd2c88a93dd77a1c659be24e94ec151fe790adf2f619201795b25be47a2ce4c20088bdf29739049b2bf12c90cc6951ac35e9b4424f1d6bb8e70245c91cee29f30cd8c3365a795af6d0b28747640f2cf9cb5e25134c9539d494780eaca1650c2d6378428ce1ef6013bef077f0f447f6e458ded528db837f336c8e3f7d0eac6d0bf5ee2d421feecdd5bdca267b3cf7e60c2ad594780668656c215a6dc591690569f6308b6b3d3ed157cf0091f4d6e8fc9d0a5f4a08a694dd7801dd944a3c03f231daa089ef947c9eaa88d6ea2e8f267ccedc3533c3f066de3e0366b78dbaccf7c2ecb6886c6eb26e9aed95d25857e966f6f5f3209c2d249dc52805abb2094ad194e50da354c95b75707bbe07ff3a69de39e739fb3b57c16d5a18975629fc0cd0cd68fdf2b6465c7b42dcb99e3a8ab45e4bc868544af0d592508b66eba11900cbf8151c4bf0ac54b245b49657b7aaf5b3650fa0097017c96e462fc9d993d7e5d4f1887b8a3f0346a177ad2db4356e0dcae1f02f8369d6bd0ae8ad3e7bfc6f8d06717fd167816a6ebb27b57b52cb20566210237a735e27c8e2d5b84451be6515ad51788b59e26310d7ed6035a2ba1db4c4f42c91eca9ee4eedbefb48fbaeb87e7e4f7ca83084b9b7cf800d185dbb6503eaf61a99b6754f7eea5c8bebbf2bc8756fc96780681666dee9be8b004db60edd5a11ee899155d10940dcc1344d31df3fef44e94927a3577157e86cbdaacf80f0ccad0cc7df1a91a1e8c4b0cf618b0cde0bf06eaedcf340b2ad43b196ab3f679de9e9b38961fffefd69bee0f36014dd365d79cb2a5a56b10eab902ae13256210b3e1356b17da6892d4433cc24cf80d33b0beedb93ea8a3e0f54db3a44dbba84658b306912e4387519a2d452b42b177e1e88b785caf996a35e9c5c608e5cde07fe6d01e6d5967d2688b77d9b6b2b873f5943ac60cc34f7c50caf86470bc86b49ad674068fa5612da3622e0aa741e06e9226c5ca38967809a652cd83a0c5db6150cc3499cdc6dbe1bb0fa4f05
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1508)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1433)
    at hudson.maven.reporters.MavenSiteArchiver.postExecute(MavenSiteArchiver.java:81)
    at hudson.maven.Maven3Builder$MavenExecutionListener.reccordMojoSucceeded(Maven3Builder.java:568)
    at hudson.maven.Maven3Builder$MavenExecutionListener.mojoSucceeded(Maven3Builder.java:531)
    at org.apache.maven.lifecycle.internal.DefaultExecutionEventCatapult.fire(DefaultExecutionEventCatapult.java:87)
    at org.apache.maven.lifecycle.internal.DefaultExecutionEventCatapult.fire(DefaultExecutionEventCatapult.java:42)
    at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:228)
    at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:153)
    at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:145)
    at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:84)
    at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:59)
    at org.apache.maven.lifecycle.internal.LifecycleStarter.singleThreadedBuild(LifecycleStarter.java:183)
    at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:161)
    at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:319)
    at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:156)
    at org.jvnet.hudson.maven3.launcher.Maven3Launcher.main(Maven3Launcher.java:79)
    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.codehaus.plexus.classworlds.launcher.Launcher.launchStandard(Launcher.java:329)
    at org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:239)
    at org.jvnet.hudson.maven3.agent.Maven3Main.launch(Maven3Main.java:145)
    at hudson.maven.Maven3Builder.call(Maven3Builder.java:124)
    at hudson.maven.Maven3Builder.call(Maven3Builder.java:71)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:662)
Caused by: java.util.concurrent.ExecutionException: hudson.util.IOException2: Not in GZIP format
stream=51345efc064da2bd9d992c49508e16ebd2227bf756668bca5d81bfe138a7d182c7f78f701ad50e8f552bc6d64be25a0fd0b5a8d3ba2724e5523884990505ad50f81910150dc269c9ea8992d54db6e0f1fd23bcc96a87c7aa2921ab0b9e1bac7b7193efc1bf4e76371e502ff50a412d2ef60c4849433f27aba5a585b4d424beb133298946ccb9ba8a6bb5459e019e811c84c9445b347b743403393dbd0fc7f07d8b602d82ad8e60491a0ce2708fc58b5450abf2e6192095ae2356b598f584a54db54a5c2b49afc311a683491d3b80c7cf8717e85bc80bb6c6d081c1eaa5dbce5818de5e291aaf8c5dcb0a3f079cc32bdd5a746b59f266a4740b483902ec0c3076ae8b71bd7b32b8778e94ee2bdc92524b4adf2d29613865e73c8ac3e9244e82e1defca3322d2d2ffd2c88a93dd77a1c659be24e94ec151fe790adf2f619201795b25be47a2ce4c20088bdf29739049b2bf12c90cc6951ac35e9b4424f1d6bb8e70245c91cee29f30cd8c3365a795af6d0b28747640f2cf9cb5e25134c9539d494780eaca1650c2d6378428ce1ef6013bef077f0f447f6e458ded528db837f336c8e3f7d0eac6d0bf5ee2d421feecdd5bdca267b3cf7e60c2ad594780668656c215a6dc591690569f6308b6b3d3ed157cf0091f4d6e8fc9d0a5f4a08a694dd7801dd944a3c03f231daa089ef947c9eaa88d6ea2e8f267ccedc3533c3f066de3e0366b78dbaccf7c2ecb6886c6eb26e9aed95d25857e966f6f5f3209c2d249dc52805abb2094ad194e50da354c95b75707bbe07ff3a69de39e739fb3b57c16d5a18975629fc0cd0cd68fdf2b6465c7b42dcb99e3a8ab45e4bc868544af0d592508b66eba11900cbf8151c4bf0ac54b245b49657b7aaf5b3650fa0097017c96e462fc9d993d7e5d4f1887b8a3f0346a177ad2db4356e0dcae1f02f8369d6bd0ae8ad3e7bfc6f8d06717fd167816a6ebb27b57b52cb20566210237a735e27c8e2d5b84451be6515ad51788b59e26310d7ed6035a2ba1db4c4f42c91eca9ee4eedbefb48fbaeb87e7e4f7ca83084b9b7cf800d185dbb6503eaf61a99b6754f7eea5c8bebbf2bc8756fc96780681666dee9be8b004db60edd5a11ee899155d10940dcc1344d31df3fef44e94927a3577157e86cbdaacf80f0ccad0cc7df1a91a1e8c4b0cf618b0cde0bf06eaedcf340b2ad43b196ab3f679de9e9b38961fffefd69bee0f36014dd365d79cb2a5a56b10eab902ae13256210b3e1356b17da6892d4433cc24cf80d33b0beedb93ea8a3e0f54db3a44dbba84658b306912e4387519a2d452b42b177e1e88b785caf996a35e9c5c608e5cde07fe6d01e6d5967d2688b77d9b6b2b873f5943ac60cc34f7c50caf86470bc86b49ad674068fa5612da3622e0aa741e06e9226c5ca38967809a652cd83a0c5db6150cc3499cdc6dbe1bb0fa4f05
    at hudson.remoting.Channel$2.adapt(Channel.java:662)
    at hudson.remoting.Channel$2.adapt(Channel.java:657)
    at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
    at hudson.FilePath.copyRecursiveTo(FilePath.java:1506)
    ... 34 more
Caused by: hudson.util.IOException2: Not in GZIP format
stream=51345efc064da2bd9d992c49508e16ebd2227bf756668bca5d81bfe138a7d182c7f78f701ad50e8f552bc6d64be25a0fd0b5a8d3ba2724e5523884990505ad50f81910150dc269c9ea8992d54db6e0f1fd23bcc96a87c7aa2921ab0b9e1bac7b7193efc1bf4e76371e502ff50a412d2ef60c4849433f27aba5a585b4d424beb133298946ccb9ba8a6bb5459e019e811c84c9445b347b743403393dbd0fc7f07d8b602d82ad8e60491a0ce2708fc58b5450abf2e6192095ae2356b598f584a54db54a5c2b49afc311a683491d3b80c7cf8717e85bc80bb6c6d081c1eaa5dbce5818de5e291aaf8c5dcb0a3f079cc32bdd5a746b59f266a4740b483902ec0c3076ae8b71bd7b32b8778e94ee2bdc92524b4adf2d29613865e73c8ac3e9244e82e1defca3322d2d2ffd2c88a93dd77a1c659be24e94ec151fe790adf2f619201795b25be47a2ce4c20088bdf29739049b2bf12c90cc6951ac35e9b4424f1d6bb8e70245c91cee29f30cd8c3365a795af6d0b28747640f2cf9cb5e25134c9539d494780eaca1650c2d6378428ce1ef6013bef077f0f447f6e458ded528db837f336c8e3f7d0eac6d0bf5ee2d421feecdd5bdca267b3cf7e60c2ad594780668656c215a6dc591690569f6308b6b3d3ed157cf0091f4d6e8fc9d0a5f4a08a694dd7801dd944a3c03f231daa089ef947c9eaa88d6ea2e8f267ccedc3533c3f066de3e0366b78dbaccf7c2ecb6886c6eb26e9aed95d25857e966f6f5f3209c2d249dc52805abb2094ad194e50da354c95b75707bbe07ff3a69de39e739fb3b57c16d5a18975629fc0cd0cd68fdf2b6465c7b42dcb99e3a8ab45e4bc868544af0d592508b66eba11900cbf8151c4bf0ac54b245b49657b7aaf5b3650fa0097017c96e462fc9d993d7e5d4f1887b8a3f0346a177ad2db4356e0dcae1f02f8369d6bd0ae8ad3e7bfc6f8d06717fd167816a6ebb27b57b52cb20566210237a735e27c8e2d5b84451be6515ad51788b59e26310d7ed6035a2ba1db4c4f42c91eca9ee4eedbefb48fbaeb87e7e4f7ca83084b9b7cf800d185dbb6503eaf61a99b6754f7eea5c8bebbf2bc8756fc96780681666dee9be8b004db60edd5a11ee899155d10940dcc1344d31df3fef44e94927a3577157e86cbdaacf80f0ccad0cc7df1a91a1e8c4b0cf618b0cde0bf06eaedcf340b2ad43b196ab3f679de9e9b38961fffefd69bee0f36014dd365d79cb2a5a56b10eab902ae13256210b3e1356b17da6892d4433cc24cf80d33b0beedb93ea8a3e0f54db3a44dbba84658b306912e4387519a2d452b42b177e1e88b785caf996a35e9c5c608e5cde07fe6d01e6d5967d2688b77d9b6b2b873f5943ac60cc34f7c50caf86470bc86b49ad674068fa5612da3622e0aa741e06e9226c5ca38967809a652cd83a0c5db6150cc3499cdc6dbe1bb0fa4f05
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:537)
    at hudson.FilePath$32.invoke(FilePath.java:1497)
    at hudson.FilePath$32.invoke(FilePath.java:1494)
    at hudson.FilePath$FileCallableWrapper.call(FilePath.java:1931)
    at hudson.remoting.UserRequest.perform(UserRequest.java:114)
    at hudson.remoting.UserRequest.perform(UserRequest.java:48)
    at hudson.remoting.Request$2.run(Request.java:270)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
    at java.util.concurrent.FutureTask.run(FutureTask.java:138)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:619)
Caused by: java.io.IOException: Not in GZIP format
    at java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:137)
    at java.util.zip.GZIPInputStream.(GZIPInputStream.java:58)
    at hudson.FilePath$TarCompression$2.extract(FilePath.java:533)
    ... 12 more

timja commented 2 years ago

[Originally duplicated by: JENKINS-7784]

timja commented 2 years ago

[Originally duplicated by: JENKINS-7783]

timja commented 2 years ago

[Originally related to: JENKINS-8286]