Bamboo Repository Polling & Automatic Deployment

[carpediemevive]

I'm having issues trying to get my project to deploy automatically when I make a commit to a branch.

 

I have a build project monitoring a branch in Plastic (/main/develop).

When a change is detected to the branch, Bamboo kicks off a build automatically.

After that build is successfully run, a deployment is supposed to happen automatically, but instead it never does.

 

I see this error in the bamboo logs:

Looking through the log files I see the following:
2015-06-10 13:14:09,831 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15][ChainExecutionManagerImpl] Plan SMIP-DEV-39: SMIP - DEV has finished executing
2015-06-10 13:14:09,878 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15][PostChainIndexAction] Indexing SMIP-DEV-39
2015-06-10 13:14:09,909 INFO [14-IndexerService.indexer:pool-30-thread-1][DefaultBuildResultsIndexer] Indexed SMIP-DEV-39
2015-06-10 13:14:10,096 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15][DashboardCacheListener] event: com.atlassian.bamboo.event.ChainCompletedEvent[source=com.atlassian.bamboo.chains.ChainExecutionManagerImpl@7023d459] plan=SMIP-DEV
2015-06-10 13:14:10,237 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15][DashboardCachingManagerImpl] Plan cache updated for 1 plans in 0:00:00.138
2015-06-10 13:14:10,237 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14][DependencyChainListener] Checking children plans of [sMIP-DEV] for plan SMIP-DEV-39
2015-06-10 13:14:10,299 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14][DependencyChainListener] Finished checking children plans of 'SMIP - DEV' for plan SMIP-DEV-39
2015-06-10 13:14:10,876 ERROR [8-BAM::PlanExec:pool-15-thread-1][AfterSuccessfulPlanEnvironmentTriggeringAction] Error while triggering environment 
org.hibernate.LazyInitializationException: failed to lazily initialize a collection of role: com.atlassian.bamboo.commit.CommitImpl.files, no session or session was closed
at org.hibernate.collection.AbstractPersistentCollection.throwLazyInitializationException(AbstractPersistentCollection.java:383)
at org.hibernate.collection.AbstractPersistentCollection.throwLazyInitializationExceptionIfNotConnected(AbstractPersistentCollection.java:375)
at org.hibernate.collection.AbstractPersistentCollection.initialize(AbstractPersistentCollection.java:368)
at org.hibernate.collection.AbstractPersistentCollection.read(AbstractPersistentCollection.java:111)
at org.hibernate.collection.PersistentList.iterator(PersistentList.java:138)
at com.atlassian.bamboo.commit.CommitImpl.guessChangeSetId(CommitImpl.java:96)
at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl$BuildCommit2DeploymentCommit.apply(MutableDeploymentVersionVcsChangesetImpl.java:42)
at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl$BuildCommit2DeploymentCommit.apply(MutableDeploymentVersionVcsChangesetImpl.java:30)
at com.google.common.collect.Iterators$8.next(Iterators.java:812)
at com.google.common.collect.Sets.newHashSet(Sets.java:232)
at com.google.common.collect.Sets.newHashSet(Sets.java:211)
at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl.<init>(MutableDeploymentVersionVcsChangesetImpl.java:59)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl$BuildChangeset2DeploymentChangeset.apply(DeploymentVersionChainResultDataCollectorImpl.java:99)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl$BuildChangeset2DeploymentChangeset.apply(DeploymentVersionChainResultDataCollectorImpl.java:87)
at com.google.common.collect.Iterators$8.next(Iterators.java:812)
at com.google.common.collect.Lists.newArrayList(Lists.java:139)
at com.google.common.collect.Lists.newArrayList(Lists.java:119)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.singleResultSummary2Changeset(DeploymentVersionChainResultDataCollectorImpl.java:106)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.createChangesetsFromRange(DeploymentVersionChainResultDataCollectorImpl.java:123)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.findChangesetsAndJiraIssues(DeploymentVersionChainResultDataCollectorImpl.java:249)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.createChangesetsAndJiraIssues(DeploymentVersionChainResultDataCollectorImpl.java:171)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.createDeploymentVersionInternal(DeploymentVersionServiceImpl.java:323)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.access$000(DeploymentVersionServiceImpl.java:96)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl$1.apply(DeploymentVersionServiceImpl.java:262)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl$1.apply(DeploymentVersionServiceImpl.java:257)
at com.atlassian.bamboo.core.ScopedExclusionServiceImpl.withLock(ScopedExclusionServiceImpl.java:75)
at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.getOrCreateDeploymentVersion(DeploymentVersionServiceImpl.java:256)
at com.atlassian.bamboo.deployments.execution.triggering.AfterSuccessfulPlanEnvironmentTriggeringAction.createDeploymentContext(AfterSuccessfulPlanEnvironmentTriggeringAction.java:113)
at com.atlassian.bamboo.plan.PlanExecutionManagerImpl$5.call(PlanExecutionManagerImpl.java:637)
at com.atlassian.bamboo.plan.PlanExecutionManagerImpl$5.call(PlanExecutionManagerImpl.java:626)
at com.atlassian.util.concurrent.ManagedLocks$ManagedLockImpl.withLock(ManagedLocks.java:312)
at com.atlassian.bamboo.plan.PlanExecutionLockServiceImpl.lock(PlanExecutionLockServiceImpl.java:85)
at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.doWithProcessLock(PlanExecutionManagerImpl.java:805)
at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.startDeployment(PlanExecutionManagerImpl.java:625)
at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.start(PlanExecutionManagerImpl.java:610)
at com.atlassian.bamboo.plan.DelegatingPlanExecutionManager.start(DelegatingPlanExecutionManager.java:91)
at com.atlassian.bamboo.plan.NonBlockingPlanExecutionServiceImpl$2.call(NonBlockingPlanExecutionServiceImpl.java:98)
at com.atlassian.bamboo.plan.NonBlockingPlanExecutionServiceImpl$2.call(NonBlockingPlanExecutionServiceImpl.java:91)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at com.atlassian.bamboo.utils.BambooRunnables$1.run(BambooRunnables.java:49)
at com.atlassian.bamboo.security.ImpersonationHelper.runWith(ImpersonationHelper.java:31)
at com.atlassian.bamboo.security.ImpersonationHelper.runWithSystemAuthority(ImpersonationHelper.java:20)
at com.atlassian.bamboo.security.ImpersonationHelper$1.run(ImpersonationHelper.java:52)
at java.lang.Thread.run(Thread.java:745)

 

I've already submitted a ticket with Bamboo support, but they seem to think the problem is with the plugin.

 

Every attempt at kicking off the build via another method works perfectly all the way through deployment, but repository polling seems broken.

 

Some quick searches related to the "no session or session was closed" text brought me to people have problems with plugins that were attempting to pull data from the database without enclosing it in a session, but I wasn't able to figure out what was really going on.

 

Any help?

[calbzam]

HI,

 

I haven´t seen this error before. Could you post your build configurationd details (and deploy details as well) in order to reproduce it in our labs?

 

Regards,

Carlos.

[carpediemevive]

I'll post as much information as I can. If I miss anything, please let me know.

 

I have one project, with one plan. This plan has one stage and one job. The one job has three steps:

1. Source Code Checkout - I'm checking out the /main/develop branch and forcing a clean build.
2. NuGet Restore running the command "nuget restore Solution.sln"
3. MSBuild Solution.sln - the following flags are used: /p:PlatformTarget="x86" /p:Configuration="IIS-Dev" /p:DeployOnBuild=True /p:PublishProfile="IIS-Dev" /verbosity:detailed

This job has one published artifact and that's every file within a subfolder inside the build directory (i.e.: project_folder/deploy/iis-dev/*.*)

 

This plan has one trigger on it: "Repository polling". It's polling periodically at every 180 seconds.

 

I made no changes at all to the branches and I'm not using any form of branching in the build server at all as of yet.

 

I have one deployment project and it's related to this build project. This deployment project has one environment on it. There are three tasks on the deployment:

1. Clean working directory task
2. Artifact Download - I selected the artifact from my build project (the only one listed)
3. Run Powershell Script: ${bamboo.working.directory}\Project.deploy.cmd /Y /M:TARGET-MACHINE

This deployment has one trigger on it: "After successful build plan".

 

That's how I setup everything from start to finish. I hope I gave you enough information. If you need any more information let me know and I'll do my best.

[calbzam]

Hi,

 

I´m trying to reproduce your issue, but no luck yet. Could you edit your configuration in order to debug where the issue is coming from? 

 

- You could disable the deployment project and check if the issue is happening in the initial plan or not. The goal should be to know what´s is the singularity of your configuration that is producing an issue.

 

Regards,

Carlos.

[carpediemevive]

All I did was disable the trigger and the resultant log files changed and did not show the error:

 

2015-06-16 09:24:29,788 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-6] [ChainExecutionManagerImpl] Plan SMIP-DEV-42: SMIP - DEV has finished executing

2015-06-16 09:24:29,867 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-6] [PostChainIndexAction] Indexing SMIP-DEV-42

2015-06-16 09:24:29,910 INFO [13-IndexerService.indexer:pool-29-thread-1] [DefaultBuildResultsIndexer] Indexed SMIP-DEV-42

2015-06-16 09:24:30,022 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-6] [DashboardCacheListener] event: com.atlassian.bamboo.event.ChainCompletedEvent[source=com.atlassian.bamboo.chains.ChainExecutionManagerImpl@47893b02] plan=SMIP-DEV

2015-06-16 09:24:30,056 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-12] [DependencyChainListener] Checking children plans of [sMIP-DEV] for plan SMIP-DEV-42

2015-06-16 09:24:30,107 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-12] [DependencyChainListener] Finished checking children plans of 'SMIP - DEV' for plan SMIP-DEV-42

2015-06-16 09:24:30,164 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-6] [DashboardCachingManagerImpl] Plan cache updated for 1 plans in 0:00:00.140

 

I've already attempted using a scheduled trigger on the deployment and that worked just fine.

 

I got it to successfully run a deployment after a build by manually initiating the build in the Bamboo UI, but I haven't been able to re-create this. The log entries for that instance are below:

2015-06-11 12:17:04,724 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-5] [ChainExecutionManagerImpl] Plan SMIP-DEV-41: SMIP - DEV has finished executing

2015-06-11 12:17:04,799 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-5] [PostChainIndexAction] Indexing SMIP-DEV-41

2015-06-11 12:17:04,860 INFO [13-IndexerService.indexer:pool-29-thread-1] [DefaultBuildResultsIndexer] Indexed SMIP-DEV-41

2015-06-11 12:17:04,873 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-5] [DashboardCacheListener] event: com.atlassian.bamboo.event.ChainCompletedEvent[source=com.atlassian.bamboo.chains.ChainExecutionManagerImpl@47893b02] plan=SMIP-DEV

2015-06-11 12:17:04,939 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-9] [DependencyChainListener] Checking children plans of [sMIP-DEV] for plan SMIP-DEV-41

2015-06-11 12:17:04,965 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-9] [DependencyChainListener] Finished checking children plans of 'SMIP - DEV' for plan SMIP-DEV-41

2015-06-11 12:17:05,020 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-5] [DashboardCachingManagerImpl] Plan cache updated for 1 plans in 0:00:00.130

2015-06-11 12:17:05,646 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildQueueManagerImpl] Attempting to queue Deployment of 'release-9' on 'IIS-Dev'.

2015-06-11 12:17:05,646 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [ExecutionPhaseServiceImpl] Deployment of 'release-9' on 'IIS-Dev' queued

2015-06-11 12:17:05,701 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildQueueManagerImpl] Sent ExecutableQueueUpdate: addToQueue

2015-06-11 12:17:05,701 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildAgentControllerImpl] A new executable may be available on the server.

2015-06-11 12:17:05,707 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildAgentControllerImpl] Agent 131073 checking build queue for executables...

2015-06-11 12:17:05,707 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildQueueManagerImpl] Sending 5832705-5963777-6651908 to agent 131073

 

There's more as it goes through the entire deployment process but this captures it starting up. If you need more I can provide it.

 

I haven't experimented with any other build triggers, but I can if you think it would be helpful.

[carpediemevive]

I ran another scheduled deployment trigger and it did work successfully. Here are the log entries for that:

 

2015-06-16 09:45:00,067 INFO [scheduler_Worker-10] [QuartzTriggerJob] Running quartz strategy job for ENVIRONMENT:5963777

2015-06-16 09:45:00,425 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildQueueManagerImpl] Attempting to queue Deployment of 'release-10' on 'IIS-Dev'.

2015-06-16 09:45:00,425 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [ExecutionPhaseServiceImpl] Deployment of 'release-10' on 'IIS-Dev' queued

2015-06-16 09:45:00,476 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildQueueManagerImpl] Sent ExecutableQueueUpdate: addToQueue

2015-06-16 09:45:00,476 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildAgentControllerImpl] A new executable may be available on the server.

2015-06-16 09:45:00,476 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildAgentControllerImpl] Agent 131073 checking build queue for executables...

2015-06-16 09:45:00,476 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildQueueManagerImpl] Sending 5832705-5963777-6651909 to agent 131073

[carpediemevive]

The final test recommended from the Bamboo folks was that I should re-create everything but not using Plastic as a repository. I just finally got that finished and it's able to checkout from git, build, and automatically deploy correctly. The logs for that deployment are below:

 

2015-06-16 10:18:09,393 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-12] [ChainExecutionManagerImpl] Plan GIT-JUS-2: GitProject - JustForTesting has finished executing

2015-06-16 10:18:09,443 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-12] [PostChainIndexAction] Indexing GIT-JUS-2

2015-06-16 10:18:09,479 INFO [13-IndexerService.indexer:pool-29-thread-1] [DefaultBuildResultsIndexer] Indexed GIT-JUS-2

2015-06-16 10:18:09,487 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-12] [DashboardCacheListener] event: com.atlassian.bamboo.event.ChainCompletedEvent[source=com.atlassian.bamboo.chains.ChainExecutionManagerImpl@47893b02] plan=GIT-JUS

2015-06-16 10:18:09,554 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-10] [DependencyChainListener] Checking children plans of [GIT-JUS] for plan GIT-JUS-2

2015-06-16 10:18:09,573 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-12] [DashboardCachingManagerImpl] Plan cache updated for 1 plans in 0:00:00.084

2015-06-16 10:18:09,578 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-10] [DependencyChainListener] Finished checking children plans of 'GitProject - JustForTesting' for plan GIT-JUS-2

2015-06-16 10:18:09,915 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-7] [buildQueueManagerImpl] Attempting to queue Deployment of 'release-1' on 'IIS-DEV'.

2015-06-16 10:18:09,916 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-7] [ExecutionPhaseServiceImpl] Deployment of 'release-1' on 'IIS-DEV' queued

2015-06-16 10:18:09,999 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [buildAgentControllerImpl] A new executable may be available on the server.

2015-06-16 10:18:09,999 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildAgentControllerImpl] Agent 131073 checking build queue for executables...

2015-06-16 10:18:10,000 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildQueueManagerImpl] Sending 7143426-7241730-6651910 to agent 131073

[carpediemevive]

I was going to leave it alone, but I noticed something curious and had to update one more time. I was able to re-create the automatic deployment after the manual build, and what's even stranger is that it includes the error I saw above. This is making me thing that the error I've recorded doesn't actually prevent the deployment. There must be something else going on. This is what I saw from a manual build:

2015-06-16 09:33:42,982 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [ChainExecutionManagerImpl] Plan SMIP-DEV-43: SMIP - DEV has finished executing

2015-06-16 09:33:43,030 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [PostChainIndexAction] Indexing SMIP-DEV-43

2015-06-16 09:33:43,089 INFO [13-IndexerService.indexer:pool-29-thread-1] [DefaultBuildResultsIndexer] Indexed SMIP-DEV-43

2015-06-16 09:33:43,099 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [DashboardCacheListener] event: com.atlassian.bamboo.event.ChainCompletedEvent[source=com.atlassian.bamboo.chains.ChainExecutionManagerImpl@47893b02] plan=SMIP-DEV

2015-06-16 09:33:43,104 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-16] [DependencyChainListener] Checking children plans of [sMIP-DEV] for plan SMIP-DEV-43

2015-06-16 09:33:43,143 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-16] [DependencyChainListener] Finished checking children plans of 'SMIP - DEV' for plan SMIP-DEV-43

2015-06-16 09:33:43,208 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [DashboardCachingManagerImpl] Plan cache updated for 1 plans in 0:00:00.101

2015-06-16 09:33:43,322 ERROR [8-BAM::PlanExec:pool-15-thread-3] [AfterSuccessfulPlanEnvironmentTriggeringAction] Error while triggering environment 

org.hibernate.LazyInitializationException: failed to lazily initialize a collection of role: com.atlassian.bamboo.commit.CommitImpl.files, no session or session was closed

at org.hibernate.collection.AbstractPersistentCollection.throwLazyInitializationException(AbstractPersistentCollection.java:383)

at org.hibernate.collection.AbstractPersistentCollection.throwLazyInitializationExceptionIfNotConnected(AbstractPersistentCollection.java:375)

at org.hibernate.collection.AbstractPersistentCollection.initialize(AbstractPersistentCollection.java:368)

at org.hibernate.collection.AbstractPersistentCollection.read(AbstractPersistentCollection.java:111)

at org.hibernate.collection.PersistentList.iterator(PersistentList.java:138)

at com.atlassian.bamboo.commit.CommitImpl.guessChangeSetId(CommitImpl.java:96)

at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl$BuildCommit2DeploymentCommit.apply(MutableDeploymentVersionVcsChangesetImpl.java:42)

at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl$BuildCommit2DeploymentCommit.apply(MutableDeploymentVersionVcsChangesetImpl.java:30)

at com.google.common.collect.Iterators$8.next(Iterators.java:812)

at com.google.common.collect.Iterators.addAll(Iterators.java:356)

at com.google.common.collect.Iterables.addAll(Iterables.java:332)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.addChangesetToMap(DeploymentVersionChainResultDataCollectorImpl.java:151)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.createChangesetsFromRange(DeploymentVersionChainResultDataCollectorImpl.java:133)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.findChangesetsAndJiraIssues(DeploymentVersionChainResultDataCollectorImpl.java:249)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.createChangesetsAndJiraIssues(DeploymentVersionChainResultDataCollectorImpl.java:171)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.createDeploymentVersionInternal(DeploymentVersionServiceImpl.java:323)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.access$000(DeploymentVersionServiceImpl.java:96)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl$1.apply(DeploymentVersionServiceImpl.java:262)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl$1.apply(DeploymentVersionServiceImpl.java:257)

at com.atlassian.bamboo.core.ScopedExclusionServiceImpl.withLock(ScopedExclusionServiceImpl.java:75)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.getOrCreateDeploymentVersion(DeploymentVersionServiceImpl.java:256)

at com.atlassian.bamboo.deployments.execution.triggering.AfterSuccessfulPlanEnvironmentTriggeringAction.createDeploymentContext(AfterSuccessfulPlanEnvironmentTriggeringAction.java:113)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl$5.call(PlanExecutionManagerImpl.java:637)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl$5.call(PlanExecutionManagerImpl.java:626)

at com.atlassian.util.concurrent.ManagedLocks$ManagedLockImpl.withLock(ManagedLocks.java:312)

at com.atlassian.bamboo.plan.PlanExecutionLockServiceImpl.lock(PlanExecutionLockServiceImpl.java:85)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.doWithProcessLock(PlanExecutionManagerImpl.java:805)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.startDeployment(PlanExecutionManagerImpl.java:625)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.start(PlanExecutionManagerImpl.java:610)

at com.atlassian.bamboo.plan.DelegatingPlanExecutionManager.start(DelegatingPlanExecutionManager.java:91)

at com.atlassian.bamboo.plan.NonBlockingPlanExecutionServiceImpl$2.call(NonBlockingPlanExecutionServiceImpl.java:98)

at com.atlassian.bamboo.plan.NonBlockingPlanExecutionServiceImpl$2.call(NonBlockingPlanExecutionServiceImpl.java:91)

at java.util.concurrent.FutureTask.run(FutureTask.java:262)

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)

at com.atlassian.bamboo.utils.BambooRunnables$1.run(BambooRunnables.java:49)

at com.atlassian.bamboo.security.ImpersonationHelper.runWith(ImpersonationHelper.java:31)

at com.atlassian.bamboo.security.ImpersonationHelper.runWithSystemAuthority(ImpersonationHelper.java:20)

at com.atlassian.bamboo.security.ImpersonationHelper$1.run(ImpersonationHelper.java:52)

at java.lang.Thread.run(Thread.java:745)

2015-06-16 09:33:44,076 INFO [http-apr-8085-exec-3] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461593967 195363kb

2015-06-16 09:33:44,480 INFO [http-apr-8085-exec-24] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/result/status/SMIP-DEV-43?expand=stages.stage.results.result&_=1434461593968 191816kb

2015-06-16 09:33:44,511 INFO [http-apr-8085-exec-18] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/chain/result/viewChainResult.action?planKey=SMIP-DEV&buildNumber=43 191567kb

2015-06-16 09:33:44,925 INFO [http-apr-8085-exec-19] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/result/SMIP-DEV-JOB1-43?expand=logEntries%5B-25%3A%5D&max-results=25&_=1434461593969 165335kb

2015-06-16 09:33:45,279 INFO [http-apr-8085-exec-14] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 142510kb

2015-06-16 09:33:45,308 INFO [http-apr-8085-exec-15] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461625344 142264kb

2015-06-16 09:33:45,476 INFO [http-apr-8085-exec-8] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 141503kb

2015-06-16 09:33:45,500 INFO [http-apr-8085-exec-25] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/result/SMIP-DEV-43?expand=jiraIssues%5B0%3A4%5D&returnUrl=http%3A%2F%2Fjira.jnet.biz%3A8085%2Fchain%2Fresult%2FviewChainResult.action%3FplanKey%3DSMIP-DEV%26buildNumber%3D43&_=1434461625346 141437kb

2015-06-16 09:34:00,349 INFO [http-apr-8085-exec-4] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461625348 139378kb

2015-06-16 09:34:03,542 INFO [http-apr-8085-exec-23] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/chain/result/viewChainResult.action?planKey=SMIP-DEV&buildNumber=43 135830kb

2015-06-16 09:34:04,569 INFO [http-apr-8085-exec-5] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 110681kb

2015-06-16 09:34:04,712 INFO [http-apr-8085-exec-10] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461644631 109344kb

2015-06-16 09:34:04,806 INFO [http-apr-8085-exec-15] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/result/SMIP-DEV-43?expand=jiraIssues%5B0%3A4%5D&returnUrl=http%3A%2F%2Fjira.jnet.biz%3A8085%2Fchain%2Fresult%2FviewChainResult.action%3FplanKey%3DSMIP-DEV%26buildNumber%3D43&_=1434461644633 108447kb

2015-06-16 09:34:04,863 INFO [http-apr-8085-exec-21] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 107232kb

2015-06-16 09:34:09,140 INFO [http-apr-8085-exec-22] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/chain/result/viewChainResult.action?planKey=SMIP-DEV&buildNumber=43 106235kb

2015-06-16 09:34:10,425 INFO [http-apr-8085-exec-7] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 235321kb

2015-06-16 09:34:10,453 INFO [http-apr-8085-exec-8] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461650492 234871kb

2015-06-16 09:34:10,606 INFO [http-apr-8085-exec-6] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 232468kb

2015-06-16 09:34:10,633 INFO [http-apr-8085-exec-14] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/result/SMIP-DEV-43?expand=jiraIssues%5B0%3A4%5D&returnUrl=http%3A%2F%2Fjira.jnet.biz%3A8085%2Fchain%2Fresult%2FviewChainResult.action%3FplanKey%3DSMIP-DEV%26buildNumber%3D43&_=1434461650494 232320kb

2015-06-16 09:34:11,120 INFO [http-apr-8085-exec-5] [AccessLogFilter] 10.24.10.141 GET http://jira.jnet.biz:8085/plugins/servlet/streams?use-accept-lang=true&local=true&maxResults=20 230427kb

2015-06-16 09:34:25,476 INFO [http-apr-8085-exec-24] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650496 197649kb

2015-06-16 09:34:28,303 INFO [scheduler_Worker-1] [ExpiryTickerImpl] Live expiry handlers: 0

2015-06-16 09:34:40,650 INFO [http-apr-8085-exec-3] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650497 193552kb

2015-06-16 09:34:48,914 INFO [http-apr-8085-exec-19] [AccessLogFilter] 10.24.10.141 GET http://jira.jnet.biz:8085/rest/capabilities 190091kb

2015-06-16 09:34:55,800 INFO [http-apr-8085-exec-1] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650499 189811kb

2015-06-16 09:35:10,894 INFO [http-apr-8085-exec-2] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650500 186191kb

2015-06-16 09:35:26,044 INFO [http-apr-8085-exec-4] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650502 180982kb

2015-06-16 09:35:41,180 INFO [http-apr-8085-exec-8] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650503 177467kb

2015-06-16 09:35:56,334 INFO [http-apr-8085-exec-23] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650505 173759kb

2015-06-16 09:37:44,465 INFO [http-apr-8085-exec-14] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=SMIP-DEV&buildNumber=43&_=1434461650509 166999kb

2015-06-16 09:37:46,353 INFO [http-apr-8085-exec-9] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/viewAllDeploymentProjects.action 163375kb

2015-06-16 09:37:46,916 INFO [http-apr-8085-exec-5] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 155812kb

2015-06-16 09:37:46,951 INFO [http-apr-8085-exec-24] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461866969 155573kb

2015-06-16 09:37:46,961 INFO [http-apr-8085-exec-3] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/deploy/dashboard/?_=1434461866970 155458kb

2015-06-16 09:37:47,310 INFO [http-apr-8085-exec-4] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 152841kb

2015-06-16 09:37:49,984 INFO [http-apr-8085-exec-8] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/viewDeploymentResult.action?deploymentResultId=6651908 151019kb

2015-06-16 09:37:51,360 INFO [http-apr-8085-exec-25] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 122030kb

2015-06-16 09:37:51,381 INFO [http-apr-8085-exec-23] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461871400 121750kb

2015-06-16 09:37:51,503 INFO [http-apr-8085-exec-21] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 120493kb

2015-06-16 09:37:51,525 INFO [http-apr-8085-exec-17] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/deploy/result/6651908?includeLogs=true&max-results=50&_=1434461871402 120280kb

2015-06-16 09:37:56,562 INFO [http-apr-8085-exec-6] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461876581 117635kb

2015-06-16 09:37:56,594 INFO [http-apr-8085-exec-11] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/deploy/dashboard/?_=1434461876582 117425kb

2015-06-16 09:37:56,701 INFO [http-apr-8085-exec-22] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 114743kb

2015-06-16 09:38:02,734 INFO [http-apr-8085-exec-5] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/viewEnvironment.action?id=5963777 113720kb

2015-06-16 09:38:04,216 INFO [http-apr-8085-exec-20] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 209537kb

2015-06-16 09:38:04,242 INFO [http-apr-8085-exec-24] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461884256 209308kb

2015-06-16 09:38:04,356 INFO [http-apr-8085-exec-19] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 208306kb

2015-06-16 09:38:42,907 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildAgentControllerImpl] Agent 131073 checking build queue for executables...

2015-06-16 09:38:44,192 INFO [http-apr-8085-exec-25] [AuthenticatorImpl] Authenticated app 'jira:5212892' as user 'ahanson' successfully

2015-06-16 09:38:44,196 INFO [http-apr-8085-exec-25] [AccessLogFilter] 10.24.10.141 GET http://jira.jnet.biz:8085/plugins/servlet/streams?use-accept-lang=true&local=true&maxResults=99 203894kb

2015-06-16 09:38:59,879 INFO [http-apr-8085-exec-12] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/viewAllDeploymentProjects.action 102603kb

2015-06-16 09:39:00,486 INFO [http-apr-8085-exec-13] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 95089kb

2015-06-16 09:39:00,511 INFO [http-apr-8085-exec-21] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461940529 94454kb

2015-06-16 09:39:00,542 INFO [http-apr-8085-exec-17] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/api/latest/deploy/dashboard/?_=1434461940530 94233kb

2015-06-16 09:39:00,794 INFO [http-apr-8085-exec-5] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 91873kb

2015-06-16 09:39:03,055 INFO [http-apr-8085-exec-20] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/config/configureDeploymentProject.action?id=5832705&environmentId=5963777&returnUrl=/deploy/viewAllDeploymentProjects.action 89503kb

2015-06-16 09:39:03,085 WARN [http-apr-8085-exec-20] [TextProviderHelper] The first TextProvider in the ValueStack (com.atlassian.bamboo.deployments.projects.actions.ConfigureDeploymentProject) could not locate the message resource with key 'Config'

2015-06-16 09:39:03,085 WARN [http-apr-8085-exec-20] [TextProviderHelper] The default value expression 'Config' was evaluated and did not match a property.  The literal value 'Config' will be used.

2015-06-16 09:39:03,603 INFO [http-apr-8085-exec-24] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 78751kb

2015-06-16 09:39:03,628 INFO [http-apr-8085-exec-10] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461943647 78548kb

2015-06-16 09:39:03,772 INFO [http-apr-8085-exec-19] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 77909kb

2015-06-16 09:39:05,554 INFO [http-apr-8085-exec-4] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/config/configureEnvironmentTriggers.action?environmentId=5963777 77762kb

2015-06-16 09:39:06,211 INFO [http-apr-8085-exec-1] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 69249kb

2015-06-16 09:39:06,234 INFO [http-apr-8085-exec-3] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434461946207 69077kb

2015-06-16 09:39:06,387 INFO [http-apr-8085-exec-12] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 224353kb

2015-06-16 09:39:07,340 INFO [http-apr-8085-exec-13] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/config/viewEnvironmentTriggerTypes.action?environmentId=5963777&decorator=nothing&confirm=true&_=1434461946209 224159kb

2015-06-16 09:39:08,184 INFO [http-apr-8085-exec-16] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/deploy/config/addEnvironmentTrigger.action?environmentId=5963777&createTriggerKey=com.atlassian.bamboo.triggers.atlassian-bamboo-triggers:schedule&decorator=nothing&confirm=true&_=1434461946210 222480kb

2015-06-16 09:39:08,360 INFO [http-apr-8085-exec-21] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/getPrettyCronExpression.action?cronExpression=0%200%200%20%3F%20*%20* 218859kb

2015-06-16 09:39:10,290 INFO [http-apr-8085-exec-6] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/ajax/editCronExpression.action?cronExpression=0%200%200%20%3F%20*%20* 218623kb

2015-06-16 09:39:21,747 INFO [http-apr-8085-exec-9] [AccessLogFilter] ahanson POST http://jira.jnet.biz:8085/ajax/returnCronExpression.action 205273kb

2015-06-16 09:39:22,714 INFO [http-apr-8085-exec-14] [AccessLogFilter] ahanson POST http://jira.jnet.biz:8085/deploy/config/createEnvironmentTrigger.action 192898kb

2015-06-16 09:40:29,633 INFO [http-apr-8085-exec-17] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/allPlans.action 186274kb

2015-06-16 09:40:30,495 INFO [http-apr-8085-exec-20] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 177540kb

2015-06-16 09:40:30,519 INFO [http-apr-8085-exec-10] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434462030533 177264kb

2015-06-16 09:40:30,680 INFO [http-apr-8085-exec-4] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 176348kb

2015-06-16 09:40:36,901 INFO [http-apr-8085-exec-3] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/build/admin/create/newPlan.action?existingProjectKey= 175944kb

2015-06-16 09:40:39,439 INFO [http-apr-8085-exec-12] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/pref/latest/user/?expand=preferences.preference 85118kb

2015-06-16 09:40:39,460 INFO [http-apr-8085-exec-8] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/appswitcher?_=1434462039465 84954kb

2015-06-16 09:40:39,651 INFO [http-apr-8085-exec-6] [AccessLogFilter] ahanson GET http://jira.jnet.biz:8085/rest/menu/latest/isAppSuggestionAvailable 84567kb

2015-06-16 09:43:16,635 WARN [http-apr-8085-exec-10] [AuthenticatorImpl] No executing user assigned for 2LO requests

2015-06-16 09:43:16,635 INFO [http-apr-8085-exec-10] [AuthenticatorImpl] Authenticated app 'jira:5212892' as user 'null' successfully

2015-06-16 09:43:16,636 INFO [http-apr-8085-exec-10] [AccessLogFilter] 10.24.10.141 GET http://jira.jnet.biz:8085/rest/remote-link-aggregation/latest/aggregation?globalId=JOE-720 79746kb

2015-06-16 09:43:16,649 INFO [http-apr-8085-exec-10] [indexedBuildResultsSearcherImpl] Search took 0:00:00.007

2015-06-16 09:43:42,920 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildAgentControllerImpl] Agent 131073 checking build queue for executables...

2015-06-16 09:44:48,943 INFO [http-apr-8085-exec-23] [AccessLogFilter] 10.24.10.141 GET http://jira.jnet.biz:8085/rest/capabilities 75797kb

2015-06-16 09:45:00,067 INFO [scheduler_Worker-10] [QuartzTriggerJob] Running quartz strategy job for ENVIRONMENT:5963777

2015-06-16 09:45:00,425 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildQueueManagerImpl] Attempting to queue Deployment of 'release-10' on 'IIS-Dev'.

2015-06-16 09:45:00,425 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [ExecutionPhaseServiceImpl] Deployment of 'release-10' on 'IIS-Dev' queued

2015-06-16 09:45:00,476 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildQueueManagerImpl] Sent ExecutableQueueUpdate: addToQueue

2015-06-16 09:45:00,476 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-14] [buildAgentControllerImpl] A new executable may be available on the server.

2015-06-16 09:45:00,476 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildAgentControllerImpl] Agent 131073 checking build queue for executables...

2015-06-16 09:45:00,476 INFO [11-BAM::Default Agent::Agent:pool-26-thread-1] [buildQueueManagerImpl] Sending 5832705-5963777-6651909 to agent 131073

 

 

[carpediemevive]

This magically started working a while ago, and so I didn't really care. I just upgraded to bamboo 5.10 and the latest bamboo plugin and this issue is back. It's the exact same error in the log files, and only happens for builds are run automatically when the repository changes. If I manually do a build, the automatic deployment starts up exactly like it used to. 

 

Were you ever able to recreate this problem and figure out what happened? Is it possible something reverted in the latest release to make it stop working again?

[manu]

Hello,

 

i'm sorry but we didn't fix something related with you issue.

 

Do you have an stacktrace or a log file with the error details?

[carpediemevive]

Here's a copy of the latest stack trace:

 

2016-01-26 09:10:29,863 ERROR [10-BAM::PlanExec:pool-17-thread-2] [AfterSuccessfulPlanEnvironmentTriggeringAction] Error while triggering environment 

org.hibernate.LazyInitializationException: failed to lazily initialize a collection of role: com.atlassian.bamboo.commit.CommitImpl.files, no session or session was closed

at org.hibernate.collection.AbstractPersistentCollection.throwLazyInitializationException(AbstractPersistentCollection.java:383)

at org.hibernate.collection.AbstractPersistentCollection.throwLazyInitializationExceptionIfNotConnected(AbstractPersistentCollection.java:375)

at org.hibernate.collection.AbstractPersistentCollection.initialize(AbstractPersistentCollection.java:368)

at org.hibernate.collection.AbstractPersistentCollection.read(AbstractPersistentCollection.java:111)

at org.hibernate.collection.PersistentList.iterator(PersistentList.java:138)

at com.atlassian.bamboo.commit.CommitImpl.guessChangeSetId(CommitImpl.java:103)

at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl$BuildCommit2DeploymentCommit.apply(MutableDeploymentVersionVcsChangesetImpl.java:44)

at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl$BuildCommit2DeploymentCommit.apply(MutableDeploymentVersionVcsChangesetImpl.java:30)

at com.google.common.collect.Iterators$8.transform(Iterators.java:799)

at com.google.common.collect.TransformedIterator.next(TransformedIterator.java:48)

at com.google.common.collect.Iterators.addAll(Iterators.java:362)

at com.google.common.collect.Sets.newHashSet(Sets.java:238)

at com.google.common.collect.Sets.newHashSet(Sets.java:218)

at com.atlassian.bamboo.deployments.versions.persistence.commits.MutableDeploymentVersionVcsChangesetImpl.<init>(MutableDeploymentVersionVcsChangesetImpl.java:59)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl$BuildChangeset2DeploymentChangeset.apply(DeploymentVersionChainResultDataCollectorImpl.java:99)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl$BuildChangeset2DeploymentChangeset.apply(DeploymentVersionChainResultDataCollectorImpl.java:87)

at com.google.common.collect.Iterators$8.transform(Iterators.java:799)

at com.google.common.collect.TransformedIterator.next(TransformedIterator.java:48)

at com.google.common.collect.Iterators.addAll(Iterators.java:362)

at com.google.common.collect.Lists.newArrayList(Lists.java:160)

at com.google.common.collect.Lists.newArrayList(Lists.java:144)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.singleResultSummary2Changeset(DeploymentVersionChainResultDataCollectorImpl.java:106)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.createChangesetsFromRange(DeploymentVersionChainResultDataCollectorImpl.java:123)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.findChangesetsAndJiraIssues(DeploymentVersionChainResultDataCollectorImpl.java:249)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionChainResultDataCollectorImpl.createChangesetsAndJiraIssues(DeploymentVersionChainResultDataCollectorImpl.java:172)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.createDeploymentVersionInternal(DeploymentVersionServiceImpl.java:336)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.access$000(DeploymentVersionServiceImpl.java:110)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl$1.apply(DeploymentVersionServiceImpl.java:285)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl$1.apply(DeploymentVersionServiceImpl.java:280)

at com.atlassian.bamboo.core.ScopedExclusionServiceImpl.withLock(ScopedExclusionServiceImpl.java:75)

at com.atlassian.bamboo.deployments.versions.service.DeploymentVersionServiceImpl.getOrCreateDeploymentVersion(DeploymentVersionServiceImpl.java:279)

at com.atlassian.bamboo.deployments.execution.triggering.AfterSuccessfulPlanEnvironmentTriggeringAction.createDeploymentContext(AfterSuccessfulPlanEnvironmentTriggeringAction.java:113)

at com.atlassian.bamboo.deployments.execution.service.DeploymentExecutionServiceImpl$1.call(DeploymentExecutionServiceImpl.java:246)

at com.atlassian.bamboo.deployments.execution.service.DeploymentExecutionServiceImpl$1.call(DeploymentExecutionServiceImpl.java:240)

at com.atlassian.util.concurrent.ManagedLocks$ManagedLockImpl.withLock(ManagedLocks.java:312)

at com.atlassian.bamboo.plan.PlanExecutionLockServiceImpl.lock(PlanExecutionLockServiceImpl.java:85)

at com.atlassian.bamboo.deployments.execution.service.DeploymentExecutionServiceImpl.execute(DeploymentExecutionServiceImpl.java:239)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl$5.call(PlanExecutionManagerImpl.java:633)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl$5.call(PlanExecutionManagerImpl.java:622)

at com.atlassian.util.concurrent.ManagedLocks$ManagedLockImpl.withLock(ManagedLocks.java:312)

at com.atlassian.bamboo.plan.PlanExecutionLockServiceImpl.lock(PlanExecutionLockServiceImpl.java:85)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.doWithProcessLock(PlanExecutionManagerImpl.java:796)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.startDeployment(PlanExecutionManagerImpl.java:621)

at com.atlassian.bamboo.plan.PlanExecutionManagerImpl.start(PlanExecutionManagerImpl.java:606)

at com.atlassian.bamboo.plan.DelegatingPlanExecutionManager.start(DelegatingPlanExecutionManager.java:95)

at com.atlassian.bamboo.plan.NonBlockingPlanExecutionServiceImpl$2.call(NonBlockingPlanExecutionServiceImpl.java:100)

at com.atlassian.bamboo.plan.NonBlockingPlanExecutionServiceImpl$2.call(NonBlockingPlanExecutionServiceImpl.java:93)

at java.util.concurrent.FutureTask.run(FutureTask.java:266)

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)

at com.atlassian.bamboo.utils.BambooRunnables$1.run(BambooRunnables.java:49)

at com.atlassian.bamboo.security.ImpersonationHelper.runWith(ImpersonationHelper.java:31)

at com.atlassian.bamboo.security.ImpersonationHelper.runWithSystemAuthority(ImpersonationHelper.java:20)

at com.atlassian.bamboo.security.ImpersonationHelper$1.run(ImpersonationHelper.java:52)

at java.lang.Thread.run(Thread.java:745)

 

If I figure out how to upload the log file I'll attach it soon.

[carpediemevive]

Here's the log file.

forplastic.zip

[bamboo]

Hi,

I'm a Bamboo developer. What we found out is that problem happens if Commit object returned from repository plugin has changesetId set to null.

In the next point release (5.10.1) we will add a workaround for that but it would be for the best if you found the code path in Plastic plugin that produces such an object.

 

Cheers

[carpediemevive]

Just to update the thread a little bit, I reached out to Atlassian support for this initially back in June, and they were able to supply me with a temporary patch as a workaround. I had forgotten about that when I saw it happen again and came here for advice. When I looked back and saw that patch, I again reached out to them. So their next version (5.10.1) will include a workaround for this, but I don't have an ETA on that. If the Plastic team is able to resolve the issue here faster I could integrate that and get automatic deployments working again.

[manu]

Thank you very much for the information.

 

Let us try to schedule a fix.