Just upgraded to 1.485, and I'm seeing the same issue, but a slightly
different stack trace:
Oct 09, 2012 5:59:39 PM hudson.model.Executor run
SEVERE: Executor threw an exception
java.lang.NullPointerException
at hudson.tasks.LogRotator.perform(LogRotator.java:119)
at hudson.model.Job.logRotate(Job.java:338)
at hudson.model.Run.execute(Run.java:1581)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:236)
Oct 09, 2012 5:59:38 PM hudson.model.Run execute
INFO: common-cndomain-3.13.5 #1235 main build action completed: FAILURE
Oct 09, 2012 5:58:43 PM hudson.model.Executor run
SEVERE: Executor threw an exception
java.lang.NullPointerException
at hudson.tasks.LogRotator.perform(LogRotator.java:119)
at hudson.model.Job.logRotate(Job.java:338)
at hudson.model.Run.execute(Run.java:1581)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:236)
Oct 09, 2012 5:58:43 PM hudson.model.Run execute
INFO: fax-trunk6 #87 main build action completed: SUCCESS
Oct 09, 2012 5:58:14 PM hudson.model.Executor run
SEVERE: Executor threw an exception
java.lang.NullPointerException
at hudson.tasks.LogRotator.perform(LogRotator.java:119)
at hudson.model.Job.logRotate(Job.java:338)
at hudson.model.Run.execute(Run.java:1581)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
at hudson.model.ResourceController.execute(ResourceController.java:88)
at hudson.model.Executor.run(Executor.java:236)
...
I see the same output on just about every single one of our builds. I also
see other exceptions in the log, but I don't know if they're related:
Oct 09, 2012 5:50:55 PM hudson.triggers.SCMTrigger$Runner run
INFO: SCM changes detected in nexus-3.13.3. Triggering #936
Oct 09, 2012 5:50:55 PM hudson.model.RunMap retrieve
WARNING: could not load E:\Jenkins\jobs\nexus-3.13.3\builds\934
hudson.util.IOException2: Invalid directory name
E:\Jenkins\jobs\nexus-3.13.3\builds\934
at hudson.model.Run.parseTimestampFromBuildDir(Run.java:332)
at hudson.model.Run.<init>(Run.java:278)
at hudson.model.AbstractBuild.<init>(AbstractBuild.java:182)
at hudson.model.Build.<init>(Build.java:103)
at hudson.model.FreeStyleBuild.<init>(FreeStyleBuild.java:41)
at sun.reflect.GeneratedConstructorAccessor52.newInstance(Unknown
Source)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(Unknown
Source)
at java.lang.reflect.Constructor.newInstance(Unknown Source)
at hudson.model.AbstractProject.loadBuild(AbstractProject.java:1061)
at hudson.model.AbstractProject$1.create(AbstractProject.java:275)
at hudson.model.AbstractProject$1.create(AbstractProject.java:273)
at hudson.model.RunMap.retrieve(RunMap.java:217)
at hudson.model.RunMap.retrieve(RunMap.java:58)
at
jenkins.model.lazy.AbstractLazyLoadRunMap.load(AbstractLazyLoadRunMap.java:596)
at
jenkins.model.lazy.AbstractLazyLoadRunMap.load(AbstractLazyLoadRunMap.java:566)
at
jenkins.model.lazy.AbstractLazyLoadRunMap.search(AbstractLazyLoadRunMap.java:334)
at
jenkins.model.lazy.AbstractLazyLoadRunMap.getByNumber(AbstractLazyLoadRunMap.java:467)
at
jenkins.model.lazy.AbstractLazyLoadRunMap.search(AbstractLazyLoadRunMap.java:345)
at
jenkins.model.lazy.AbstractLazyLoadRunMap.newestBuild(AbstractLazyLoadRunMap.java:287)
at hudson.model.AbstractProject.getLastBuild(AbstractProject.java:998)
at hudson.model.AbstractProject.poll(AbstractProject.java:1364)
at hudson.triggers.SCMTrigger$Runner.runPolling(SCMTrigger.java:420)
at hudson.triggers.SCMTrigger$Runner.run(SCMTrigger.java:449)
at
hudson.util.SequentialExecutionQueue$QueueEntry.run(SequentialExecutionQueue.java:118)
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.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)
Caused by: java.text.ParseException: Unparseable date: "934"
at java.text.DateFormat.parse(Unknown Source)
at hudson.model.Run.parseTimestampFromBuildDir(Run.java:330)
... 29 more
I see that in addition to the timestamped folders in the /builds directory,
there are also links with the revision number. i.e.:
14 <-link
15 <-link
...
2012-10-09_16-25-28 <- dir
2012-10-09_16-44-19 <- dir
parseTimestampFromBuildDir seems to be trying to read the linked directories
instead of the timestamped ones.
This Jenkins installation is running on Windows Server 2008
~Loren
On Tuesday, October 9, 2012 11:50:11 AM UTC-7, Larry Shatzer, Jr. wrote:
>
> I forgot to mention, this was during a m2-release build.
>
> On Tue, Oct 9, 2012 at 12:45 PM, Larry Shatzer, Jr.
> <lar...@gmail.com<javascript:>
> > wrote:
>
>> I saw a few of these during startup, and now when a job ran, I saw this:
>> (Using latest jenkins 1.485)
>>
>> 12:40:04 Waiting for Jenkins to finish collecting data
>> 12:40:04 ERROR: Processing failed due to a bug in the code. Please report
>> this to jenkins...@googlegroups.com <javascript:>
>> 12:40:04 java.lang.NullPointerException
>> 12:40:04 at hudson.tasks.LogRotator.perform(LogRotator.java:140)
>> 12:40:04 at hudson.model.Job.logRotate(Job.java:338)
>> 12:40:04 at hudson.model.Run.execute(Run.java:1581)
>> 12:40:04 at hudson.maven.MavenBuild.access$600(MavenBuild.java:83)
>> 12:40:04 at hudson.maven.MavenBuild$ProxyImpl2.close(MavenBuild.java:545)
>> 12:40:04 at
>> hudson.maven.AbstractMavenBuilder.end(AbstractMavenBuilder.java:106)
>> 12:40:04 at
>> hudson.maven.MavenModuleSetBuild$MavenModuleSetBuildExecution.doRun(MavenModuleSetBuild.java:794)
>> 12:40:04 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:589)
>> 12:40:04 at hudson.model.Run.execute(Run.java:1516)
>> 12:40:04 at
>> hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:477)
>> 12:40:04 at
>> hudson.model.ResourceController.execute(ResourceController.java:88)
>> 12:40:04 at hudson.model.Executor.run(Executor.java:236)
>> 12:40:04
>> project=hudson.maven.MavenModuleSet@7aa9ec03[com.company.service_service]
>> 12:40:04
>> project.getModules()=[hudson.maven.MavenModule@394ed452[com.company.service_service/com.company.service:service-client][com.company.service_service/com.company.service:service-client][relativePath:client],
>>
>> hudson.maven.MavenModule@4d1aaeee[com.company.service_service/com.company.service:service-interfaces][com.company.service_service/com.company.service:service-interfaces][relativePath:interfaces],
>>
>> hudson.maven.MavenModule@66d7ba5b[com.company.service_service/com.company.service:service-services][com.company.service_service/com.company.service:service-services][relativePath:services],
>>
>> hudson.maven.MavenModule@21d8ee20[com.company.service_service/com.company.service:service][com.company.service_service/com.company.service:service][relativePath:]]
>> 12:40:04
>> project.getRootModule()=hudson.maven.MavenModule@21d8ee20[com.company.service_service/com.company.service:service][com.company.service_service/com.company.service:service][relativePath:]
>> 12:40:04 FATAL: null
>> 12:40:04 java.lang.NullPointerException
>> 12:40:04 at hudson.tasks.LogRotator.perform(LogRotator.java:140)
>> 12:40:04 at hudson.model.Job.logRotate(Job.java:338)
>> 12:40:04 at hudson.model.Run.execute(Run.java:1581)
>> 12:40:04 at hudson.maven.MavenBuild.access$600(MavenBuild.java:83)
>> 12:40:04 at hudson.maven.MavenBuild$ProxyImpl2.close(MavenBuild.java:545)
>> 12:40:04 at
>> hudson.maven.AbstractMavenBuilder.end(AbstractMavenBuilder.java:106)
>> 12:40:04 at
>> hudson.maven.MavenModuleSetBuild$MavenModuleSetBuildExecution.doRun(MavenModuleSetBuild.java:794)
>> 12:40:04 at
>> hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:589)
>> 12:40:04 at hudson.model.Run.execute(Run.java:1516)
>> 12:40:04 at
>> hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:477)
>> 12:40:04 at
>> hudson.model.ResourceController.execute(ResourceController.java:88)
>> 12:40:04 at hudson.model.Executor.run(Executor.java:236)
>>
>
>
