Loading...

XML

Word

Printable

Type: Bug
Resolution: Timed out
Priority: Low
Fix Version/s: None
Affects Version/s: 5.7.2
Component/s: Build Queues, Import / Export
Labels:
- bamboo-bugs-grooming
- support

Symptom Severity:
Severity 3 - Minor
UIS:
0

Investigation done

installed Bamboo v5.7.2

created Project - Plan with a Script task:

echo "hello"

echo "hello" > greeting.txt

sleep 60

echo "goodbye"

run build and during the build attempt on pausing Bamboo:

2016-03-04 11:57:31,245 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/ 98566kb
2016-03-04 11:57:31,256 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/allPlans.action 97973kb
2016-03-04 11:57:31,584 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/rest/pref/latest/user/?expand=preferences.preference 90280kb
2016-03-04 11:57:33,577 INFO [http-bio-8085-exec-13] [AccessLogFilter] admin POST http://bamboo.webserver/build/admin/ajax/startPlan.action?planKey=PROJ-PLAN 88712kb
2016-03-04 11:57:33,646 INFO [http-bio-8085-exec-13] [AccessLogFilter] admin GET http://bamboo.webserver/chain/result/viewChainResult.action?planKey=PROJ-PLAN&buildNumber=3 72978kb
2016-03-04 11:57:33,661 INFO [3-DelayedChangeDetectionThread:pool-7-thread-2] [ChainExecutionManagerImpl] Build PROJ-PLAN-JOB1-3 has been dispatched
2016-03-04 11:57:33,661 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-16] [BuildQueueManagerImpl] Attempting to queue Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3).
2016-03-04 11:57:33,662 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-16] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) queued
2016-03-04 11:57:33,677 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-9] [BuildAgentControllerImpl] A new executable may be available on the server.
2016-03-04 11:57:33,677 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-16] [BuildQueueManagerImpl] Sent ExecutableQueueUpdate: addToQueue
2016-03-04 11:57:33,677 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildAgentControllerImpl] Agent 131073 checking build queue for executables...
2016-03-04 11:57:33,677 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildQueueManagerImpl] Sending PROJ-PLAN-JOB1-3 to agent 131073
2016-03-04 11:57:33,677 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildAgentControllerImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) taken from queue.
2016-03-04 11:57:33,677 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) assigned to agent 131073
2016-03-04 11:57:33,678 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [CurrentlyBuildingContainer] startBuildingOnAgent called for [PROJ-PLAN-JOB1-3], agent 131073
2016-03-04 11:57:33,678 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [DefaultBuildAgent] Changing context: null -> PROJ-PLAN-JOB1-3 on Default Agent/7fe216d5
2016-03-04 11:57:33,681 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildAgentControllerImpl] PROJ-PLAN-JOB1-3: Build Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) started building on agent Default Agent
2016-03-04 11:57:33,681 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [DefaultBuildAgent] Running build phase: com.atlassian.bamboo.v2.build.task.InitializeBuild
2016-03-04 11:57:33,682 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) VCS sync started
2016-03-04 11:57:33,690 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [CheckoutDirectoriesSnapshotHelper] PROJ-PLAN-JOB1-3: Build working directory is /opt/atlassian/home/atlassian-bamboo-5.7.2/xml-data/build-dir/PROJ-PLAN-JOB1
2016-03-04 11:57:33,693 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [DefaultBuildAgent] Running build phase: com.atlassian.bamboo.build.pipeline.tasks.PrepareBuildTask
2016-03-04 11:57:33,693 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PrepareBuildTask] PROJ-PLAN-JOB1-3: Executing build Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3)
2016-03-04 11:57:33,693 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PrepareBuildTask] PROJ-PLAN-JOB1-3: Running pre-build action: Clover Grails PreBuild Action
2016-03-04 11:57:33,694 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PrepareBuildTask] PROJ-PLAN-JOB1-3: Running pre-build action: VCS Version Collector
2016-03-04 11:57:33,694 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [DefaultBuildAgent] Running build phase: com.atlassian.bamboo.build.pipeline.tasks.ExecuteBuildTask
2016-03-04 11:57:33,694 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecuteBuildTask] Starting execution: PROJ-PLAN-JOB1-3, logger: 204519289
2016-03-04 11:57:33,694 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) execution started
2016-03-04 11:57:33,700 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [TaskExecutorImpl] PROJ-PLAN-JOB1-3: Starting task 'Script' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
2016-03-04 11:57:33,701 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ProcessServiceImpl] Beginning to execute external process for build 'Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3)'\n ... running command line: \n/bin/sh /opt/atlassian/install/atlassian-bamboo-5.7.2/temp/PROJ-PLAN-JOB1-3-ScriptBuildTask-1578037030909802183.sh\n ... in: /opt/atlassian/home/atlassian-bamboo-5.7.2/xml-data/build-dir/PROJ-PLAN-JOB1\n ... using extra environment variables: \nbamboo_buildPlanName=Project - Plan - Default Job\nbamboo_capability_system_jdk_JDK_1_7=/Library/Java/JavaVirtualMachines/jdk1.7.0_79.jdk/Contents/Home\nbamboo_shortPlanName=Plan\nbamboo_resultsUrl=http://bamboo.webserver/browse/PROJ-PLAN-JOB1-3\nbamboo_planKey=PROJ-PLAN\nbamboo_ManualBuildTriggerReason_userName=admin\nbamboo_capability_system_jdk_JDK_1_7_0_79=/Library/Java/JavaVirtualMachines/jdk1.7.0_79.jdk/Contents/Home\nbamboo_shortPlanKey=PLAN\nbamboo_shortJobKey=JOB1\nbamboo_build_working_directory=/opt/atlassian/home/atlassian-bamboo-5.7.2/xml-data/build-dir/PROJ-PLAN-JOB1\nbamboo_capability_system_jdk_JDK=/Library/Java/JavaVirtualMachines/jdk1.7.0_79.jdk/Contents/Home\nbamboo_shortJobName=Default Job\nbamboo_capability_system_builder_mvn3_Maven_3=/opt/apache-maven-3.3.9\nbamboo_agentId=131073\nbamboo_planName=Project - Plan\nbamboo_buildResultsUrl=http://bamboo.webserver/browse/PROJ-PLAN-JOB1-3\nbamboo_buildResultKey=PROJ-PLAN-JOB1-3\nbamboo_capability_system_git_executable=/usr/bin/git\nbamboo_buildKey=PROJ-PLAN-JOB1\nbamboo_dependenciesDisabled=false\nbamboo_working_directory=/opt/atlassian/home/atlassian-bamboo-5.7.2/xml-data/build-dir/PROJ-PLAN-JOB1\nbamboo_buildNumber=3\nbamboo_capability_system_builder_ant_Ant=/opt/apache-ant-1.9.6\nbamboo_agentWorkingDirectory=/opt/atlassian/home/atlassian-bamboo-5.7.2/xml-data/build-dir\nbamboo_buildTimeStamp=2016-03-04T11:57:33.661-06:00\n
2016-03-04 11:57:33,903 INFO [http-bio-8085-exec-13] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=0&lastProject= 143952kb
2016-03-04 11:57:42,980 INFO [http-bio-8085-exec-9] [ServerLifecycleManagerImpl] Server state changed to 'PAUSING' from 'RUNNING' by 'admin'
2016-03-04 11:57:42,980 DEBUG [2-Server Lifecycle Manager:pool-6-thread-1] [ServerLifecycleManagerImpl] We can't yet pause the server because 1 builds are executing
2016-03-04 11:57:55,014 INFO [http-bio-8085-exec-9] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114253905&lastProject= 140716kb
2016-03-04 11:58:15,690 INFO [http-bio-8085-exec-4] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114275017&lastProject= 138763kb
2016-03-04 11:58:33,718 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-3: Running post build plugin 'Clover Results Collector'
2016-03-04 11:58:33,720 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-3: Running post build plugin 'Artifact Copier'
2016-03-04 11:58:33,721 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildArtifactPostProcessor] Copying the build artifacts for build: PROJ-PLAN-JOB1-3
2016-03-04 11:58:33,721 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-3: Running post build plugin 'NCover Results Collector'
2016-03-04 11:58:33,721 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [NCoverBuildProcessor] inside NCoverBuildProcessor.call()
2016-03-04 11:58:33,721 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-3: Running post build plugin 'npm Cache Cleanup'
2016-03-04 11:58:33,723 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) execution finished
2016-03-04 11:58:33,723 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [LocalBuildResultProcessor] Processing build result PROJ-PLAN-JOB1-3...
2016-03-04 11:58:33,723 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #3 (PROJ-PLAN-JOB1-3) execution finished
2016-03-04 11:58:33,723 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-3: Running on server: post build plugin 'Clover Delta Calculator'
2016-03-04 11:58:33,730 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-3: Running on server: post build plugin 'Build Hanging Detection Configuration'
2016-03-04 11:58:33,732 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-3: Running on server: post build plugin 'NCover Results Collector'
2016-03-04 11:58:33,738 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-3: Running on server: post build plugin 'Maven Dependencies Postprocessor'
2016-03-04 11:58:33,743 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-3: All post build plugins have finished
2016-03-04 11:58:33,746 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-3: Generating build results summary...
2016-03-04 11:58:33,754 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-3: Saving build results to disk...
2016-03-04 11:58:33,760 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PlanStatePersisterImpl] Indexing PROJ-PLAN-JOB1-3
2016-03-04 11:58:33,764 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PlanStatePersisterImpl] Finished build: PROJ-PLAN-JOB1-3
2016-03-04 11:58:33,764 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-3: Finished building PROJ-PLAN-JOB1-3.
2016-03-04 11:58:33,773 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [CurrentlyBuildingContainer] removeCurrentlyBuilding called for [PROJ-PLAN-JOB1-3]
2016-03-04 11:58:33,780 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-3] [BuildCompletedEventListener] Running build post actions 'PROJ-PLAN-JOB1'
2016-03-04 11:58:33,781 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-5] [SecureTokenEventListener] received BuildFinishedEvent
2016-03-04 11:58:33,782 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [DefaultBuildAgent] Changing context: PROJ-PLAN-JOB1-3 -> null on Default Agent/7fe216d5
2016-03-04 11:58:33,782 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildAgentControllerImpl] Agent 'Default Agent' ready to take build from queue...
2016-03-04 11:58:33,782 INFO [10-BAM::Default Agent::Agent:pool-25-thread-1] [BuildAgentControllerImpl] Agent 131073 checking build queue for executables...
2016-03-04 11:58:33,782 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-13] [PostBuildCompletedEventListener] Running build post actions 'Project - Plan - Default Job'
2016-03-04 11:58:33,785 INFO [12-IndexerService.indexer:pool-28-thread-1] [DefaultBuildResultsIndexer] Indexed PROJ-PLAN-JOB1-3
2016-03-04 11:58:33,812 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [ChainExecutionManagerImpl] Plan PROJ-PLAN-3: Project - Plan has finished executing
2016-03-04 11:58:33,839 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [PostChainIndexAction] Indexing PROJ-PLAN-3
2016-03-04 11:58:33,859 INFO [12-IndexerService.indexer:pool-28-thread-1] [DefaultBuildResultsIndexer] Indexed PROJ-PLAN-3
2016-03-04 11:58:33,862 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [DashboardCacheListener] event: com.atlassian.bamboo.event.ChainCompletedEvent[source=com.atlassian.bamboo.chains.ChainExecutionManagerImpl@1a8a79ae] plan=PROJ-PLAN
2016-03-04 11:58:33,878 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-15] [DashboardCachingManagerImpl] Plan cache updated for 1 plans in 0:00:00.013
2016-03-04 11:58:33,879 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-10] [DependencyChainListener] Checking children plans of [PROJ-PLAN] for plan PROJ-PLAN-3
2016-03-04 11:58:33,880 INFO [AtlassianEvent::0-BAM::EVENTS:pool-3-thread-10] [DependencyChainListener] Finished checking children plans of 'Project - Plan' for plan PROJ-PLAN-3
2016-03-04 11:58:36,790 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114295695&lastProject= 110975kb
2016-03-04 11:58:56,810 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114316793&lastProject= 108667kb
2016-03-04 11:59:16,833 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114336815&lastProject= 106443kb
2016-03-04 11:59:36,855 INFO [http-bio-8085-exec-12] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114356835&lastProject= 103448kb
2016-03-04 11:59:49,780 INFO [http-bio-8085-exec-21] [AccessLogFilter] admin GET http://bamboo.webserver/allPlans.action 100664kb
2016-03-04 11:59:50,100 INFO [http-bio-8085-exec-9] [AccessLogFilter] admin GET http://bamboo.webserver/rest/pref/latest/user/?expand=preferences.preference 91180kb
2016-03-04 12:00:10,141 INFO [http-bio-8085-exec-20] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=0&lastProject= 87790kb
2016-03-04 12:00:30,159 INFO [http-bio-8085-exec-14] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114410144&lastProject= 84345kb
2016-03-04 12:00:50,180 INFO [http-bio-8085-exec-13] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114430163&lastProject= 82346kb
2016-03-04 12:00:55,614 INFO [http-bio-8085-exec-6] [AccessLogFilter] admin GET http://bamboo.webserver/chain/admin/config/editChainConfiguration.action?buildKey=PROJ-PLAN 81144kb
2016-03-04 12:00:55,628 INFO [http-bio-8085-exec-6] [AccessLogFilter] admin GET http://bamboo.webserver/chain/admin/config/defaultStages.action?buildKey=PROJ-PLAN 80836kb
2016-03-04 12:00:56,036 INFO [http-bio-8085-exec-6] [AccessLogFilter] admin GET http://bamboo.webserver/rest/pref/latest/user/?expand=preferences.preference 66695kb
2016-03-04 12:00:57,489 INFO [http-bio-8085-exec-3] [AccessLogFilter] admin GET http://bamboo.webserver/build/admin/edit/editBuildConfiguration.action?buildKey=PROJ-PLAN-JOB1 66017kb
2016-03-04 12:00:57,504 INFO [http-bio-8085-exec-3] [AccessLogFilter] admin GET http://bamboo.webserver/build/admin/edit/editBuildTasks.action?buildKey=PROJ-PLAN-JOB1 65476kb
2016-03-04 12:00:57,917 INFO [http-bio-8085-exec-6] [AccessLogFilter] admin GET http://bamboo.webserver/rest/pref/latest/user/?expand=preferences.preference 133973kb
2016-03-04 12:00:58,843 INFO [http-bio-8085-exec-20] [AccessLogFilter] admin GET http://bamboo.webserver/build/admin/edit/editTask.action?planKey=PROJ-PLAN-JOB1&taskId=1&decorator=nothing&confirm=true&_=1457114457820 133183kb
2016-03-04 12:01:10,690 INFO [http-bio-8085-exec-2] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114450183&lastProject= 126851kb
2016-03-04 12:01:12,960 INFO [http-bio-8085-exec-2] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457823 126445kb
2016-03-04 12:01:27,986 INFO [http-bio-8085-exec-25] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457827 122870kb
2016-03-04 12:01:31,992 INFO [http-bio-8085-exec-6] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114470694&lastProject= 121536kb
2016-03-04 12:01:43,016 INFO [http-bio-8085-exec-10] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457831 120533kb
2016-03-04 12:01:52,689 INFO [http-bio-8085-exec-24] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114491995&lastProject= 118035kb
2016-03-04 12:01:58,039 INFO [http-bio-8085-exec-19] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457836 116486kb
2016-03-04 12:02:13,060 INFO [http-bio-8085-exec-8] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457840 114089kb
2016-03-04 12:02:13,966 INFO [http-bio-8085-exec-11] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114512691&lastProject= 112541kb
2016-03-04 12:02:28,083 INFO [http-bio-8085-exec-16] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457844 110353kb
2016-03-04 12:02:34,730 INFO [http-bio-8085-exec-7] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114533969&lastProject= 108611kb
2016-03-04 12:02:43,106 INFO [http-bio-8085-exec-11] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457848 108050kb
2016-03-04 12:02:55,698 INFO [http-bio-8085-exec-7] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/viewPlanUpdates.action?sinceSystemTime=1457114554733&lastProject= 105069kb
2016-03-04 12:02:58,131 INFO [http-bio-8085-exec-7] [AccessLogFilter] admin GET http://bamboo.webserver/ajax/planStatusHistoryNeighbouringSummaries.action?planKey=PROJ-PLAN&_=1457114457852 104696kb
2

As per the log above describes, Bamboo does not change to PAUSE state

[ServerLifecycleManagerImpl] Server state changed to 'PAUSED' from 'PAUSING'

Workaround

Make sure there are no builds/deployments running when requesting Bamboo to go to 'PAUSE' state OR;

Upgrade Bamboo
Ran the same test against Bamboo version (v5.8.1 - v5.10.2) and the issue could not be reproduced.

2016-03-04 12:22:29,920 DEBUG [5-Server Lifecycle Manager:pool-11-thread-1] [ServerLifecycleManagerImpl] Bamboo is still building - can't pause yet
2016-03-04 12:22:32,246 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-1: Running post build plugin 'NCover Results Collector'
2016-03-04 12:22:32,261 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [NCoverBuildProcessor] inside NCoverBuildProcessor.call()
2016-03-04 12:22:32,262 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-1: Running post build plugin 'Artifact Copier'
2016-03-04 12:22:32,271 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [BuildArtifactPostProcessor] Copying the build artifacts for build: PROJ-PLAN-JOB1-1
2016-03-04 12:22:32,272 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-1: Running post build plugin 'npm Cache Cleanup'
2016-03-04 12:22:32,278 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-1: Running post build plugin 'Clover Results Collector'
2016-03-04 12:22:32,282 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecuteBuildTask] PROJ-PLAN-JOB1-1: Running post build plugin 'Docker Container Cleanup'
2016-03-04 12:22:32,286 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #1 (PROJ-PLAN-JOB1-1) execution finished
2016-03-04 12:22:32,291 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [LocalBuildResultProcessor] Processing build result PROJ-PLAN-JOB1-1...
2016-03-04 12:22:32,291 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [ExecutionPhaseServiceImpl] Project - Plan - Default Job #1 (PROJ-PLAN-JOB1-1) execution finished
2016-03-04 12:22:32,294 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-1: Running on server: post build plugin 'NCover Results Collector'
2016-03-04 12:22:32,312 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-1: Running on server: post build plugin 'Build Hanging Detection Configuration'
2016-03-04 12:22:32,328 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-1: Running on server: post build plugin 'Clover Delta Calculator'
2016-03-04 12:22:32,333 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-1: Running on server: post build plugin 'Maven Dependencies Postprocessor'
2016-03-04 12:22:32,337 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [LocalBuildResultProcessor] PROJ-PLAN-JOB1-1: All post build plugins have finished
2016-03-04 12:22:32,342 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-1: Generating build results summary...
2016-03-04 12:22:32,352 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-1: Saving build results to disk...
2016-03-04 12:22:32,358 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-1: Logging substituted variables...
2016-03-04 12:22:32,367 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [PlanStatePersisterImpl] Indexing PROJ-PLAN-JOB1-1
2016-03-04 12:22:32,386 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [PlanStatePersisterImpl] Finished build: PROJ-PLAN-JOB1-1
2016-03-04 12:22:32,386 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [PlanStatePersisterImpl] PROJ-PLAN-JOB1-1: Finished building PROJ-PLAN-JOB1-1.
2016-03-04 12:22:32,400 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [CurrentlyBuildingContainer] removeCurrentlyBuilding called for [PROJ-PLAN-JOB1-1]
2016-03-04 12:22:32,408 INFO [16-IndexerService.indexer:pool-32-thread-1] [DefaultBuildResultsIndexer] Indexed PROJ-PLAN-JOB1-1
2016-03-04 12:22:32,411 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [DefaultBuildAgent] Changing context: PROJ-PLAN-JOB1-1 -> null on Default Agent/16efdd
2016-03-04 12:22:32,411 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [BuildAgentControllerImpl] Agent 'Default Agent' ready to take build from queue...
2016-03-04 12:22:32,411 INFO [13-BAM::Default Agent::Agent:pool-28-thread-1] [BuildAgentControllerImpl] Agent 163841 checking build queue for executables...
2016-03-04 12:22:32,411 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-1] [PostBuildCompletedEventListener] Running build post actions 'Project - Plan - Default Job'
2016-03-04 12:22:32,434 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-8] [BuildCompletedEventListener] Running build post actions 'PROJ-PLAN-JOB1'
2016-03-04 12:22:32,492 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-6] [ChainExecutionManagerImpl] Plan PROJ-PLAN-1: Project - Plan has finished executing
2016-03-04 12:22:32,538 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-6] [PostChainIndexAction] Indexing PROJ-PLAN-1
2016-03-04 12:22:32,575 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-6] [DashboardCachingManagerImpl] Plan result updated for PROJ-PLAN in 00:00:00.000
2016-03-04 12:22:32,576 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-10] [DependencyChainListener] Checking children plans of [PROJ-PLAN] for plan PROJ-PLAN-1
2016-03-04 12:22:32,587 INFO [16-IndexerService.indexer:pool-32-thread-1] [DefaultBuildResultsIndexer] Indexed PROJ-PLAN-1
2016-03-04 12:22:32,590 INFO [AtlassianEvent::0-BAM::EVENTS:pool-2-thread-10] [DependencyChainListener] Finished checking children plans of 'Project - Plan' for plan PROJ-PLAN-1
2016-03-04 12:22:34,927 INFO [5-Server Lifecycle Manager:pool-11-thread-1] [ServerLifecycleManagerImpl] Server state changed to 'PAUSED' from 'PAUSING'

Assignee:: Unassigned
Reporter:: Rafael Sperafico (Inactive)
Votes:: 0 Vote for this issue
Watchers:: 2 Start watching this issue

Created:: 04/Mar/2016 6:14 PM
Updated:: 19/Aug/2019 2:00 AM
Resolved:: 20/Mar/2018 8:47 AM

Details

Description

Investigation done

Workaround

Attachments

Forms

Activity

People

Dates