[11:43:58.362] New invocation is queued and will start shortly
[11:43:59.446] Starting the invocation (attempt 1)
[11:43:59.516] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:43:59.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:43:59.516] Buildbucket request:
{
"bucket": "luci.fuchsia.prod",
"client_operation_id": "9053186643841176336",
"parameters_json": "{\"builder_name\":\"gcc-arm64-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/releases/gcc-9\",\"repo\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"c080a6fb6f0cf402affc287fc600c189980cfb2d\"},\"id\":\"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c080a6fb6f0cf402affc287fc600c189980cfb2d\",\"title\":\"c080a6fb6f0cf402affc287fc600c189980cfb2d\",\"url\":\"https://gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d\"}]},\"branch\":\"refs/heads/releases/gcc-9\",\"repository\":\"https://gnu.googlesource.com/gcc\",\"revision\":\"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gcc-arm64-linux",
"scheduler_invocation_id:9053186643841176336",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"user_agent:luci-scheduler",
"buildset:commit/git/c080a6fb6f0cf402affc287fc600c189980cfb2d",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d",
"gitiles_ref:refs/heads/releases/gcc-9"
]
}
[11:44:00.252] Buildbucket response:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"created_by": "project:fuchsia",
"created_ts": "1582371839667244",
"id": "8887756581807227216",
"parameters_json": "{\"builder_name\": \"gcc-arm64-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c080a6fb6f0cf402affc287fc600c189980cfb2d\", \"title\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\", \"url\": \"https://gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}}",
"project": "fuchsia",
"result_details_json": "{\"properties\": {}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582371840031644",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/c080a6fb6f0cf402affc287fc600c189980cfb2d",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9053186643841176336",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8887756581807227216/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1582371840031788",
"url": "https://ci.chromium.org/b/8887756581807227216",
"utcnow_ts": "1582371840222302"
}
}
[11:44:00.252] Task URL: https://ci.chromium.org/b/8887756581807227216
[11:44:00.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:2:0) after 1m0s
[11:44:07.407] Received PubSub notification, asking Buildbucket for the build status
[11:44:07.557] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:00.393] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:2:0)
[11:45:00.393] Timer tick, asking Buildbucket for the build status
[11:45:00.509] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:00.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:4:0) after 1m0s
[11:46:00.545] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:4:0)
[11:46:00.545] Timer tick, asking Buildbucket for the build status
[11:46:00.705] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:00.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:5:0) after 1m0s
[11:47:00.813] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:5:0)
[11:47:00.813] Timer tick, asking Buildbucket for the build status
[11:47:00.919] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:00.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:6:0) after 1m0s
[11:48:01.048] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:6:0)
[11:48:01.048] Timer tick, asking Buildbucket for the build status
[11:48:01.328] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:01.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:7:0) after 1m0s
[11:49:01.478] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:7:0)
[11:49:01.478] Timer tick, asking Buildbucket for the build status
[11:49:01.595] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:01.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:8:0) after 1m0s
[11:50:01.697] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:8:0)
[11:50:01.697] Timer tick, asking Buildbucket for the build status
[11:50:02.061] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:02.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:9:0) after 1m0s
[11:51:02.112] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:9:0)
[11:51:02.112] Timer tick, asking Buildbucket for the build status
[11:51:02.394] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:02.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:10:0) after 1m0s
[11:52:02.415] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:10:0)
[11:52:02.415] Timer tick, asking Buildbucket for the build status
[11:52:02.581] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:02.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:11:0) after 1m0s
[11:53:02.663] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:11:0)
[11:53:02.663] Timer tick, asking Buildbucket for the build status
[11:53:02.998] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:02.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:12:0) after 1m0s
[11:54:03.126] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:12:0)
[11:54:03.126] Timer tick, asking Buildbucket for the build status
[11:54:03.239] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:03.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:13:0) after 1m0s
[11:55:03.290] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:13:0)
[11:55:03.290] Timer tick, asking Buildbucket for the build status
[11:55:03.389] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:03.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:14:0) after 1m0s
[11:56:03.417] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:14:0)
[11:56:03.417] Timer tick, asking Buildbucket for the build status
[11:56:03.560] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:03.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:15:0) after 1m0s
[11:57:03.605] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:15:0)
[11:57:03.605] Timer tick, asking Buildbucket for the build status
[11:57:03.876] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:03.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:16:0) after 1m0s
[11:58:03.924] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:16:0)
[11:58:03.924] Timer tick, asking Buildbucket for the build status
[11:58:04.019] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:04.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:17:0) after 1m0s
[11:59:04.039] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:17:0)
[11:59:04.039] Timer tick, asking Buildbucket for the build status
[11:59:04.401] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:04.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:18:0) after 1m0s
[12:00:04.379] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:18:0)
[12:00:04.379] Timer tick, asking Buildbucket for the build status
[12:00:04.458] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:04.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:19:0) after 1m0s
[12:01:04.516] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:19:0)
[12:01:04.516] Timer tick, asking Buildbucket for the build status
[12:01:04.602] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:04.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:20:0) after 1m0s
[12:02:04.625] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:20:0)
[12:02:04.625] Timer tick, asking Buildbucket for the build status
[12:02:04.733] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:04.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:21:0) after 1m0s
[12:03:04.789] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:21:0)
[12:03:04.789] Timer tick, asking Buildbucket for the build status
[12:03:04.892] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:04.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:22:0) after 1m0s
[12:04:05.015] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:22:0)
[12:04:05.015] Timer tick, asking Buildbucket for the build status
[12:04:05.109] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:05.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:23:0) after 1m0s
[12:05:05.254] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:23:0)
[12:05:05.254] Timer tick, asking Buildbucket for the build status
[12:05:05.368] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:05.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:24:0) after 1m0s
[12:06:05.461] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:24:0)
[12:06:05.461] Timer tick, asking Buildbucket for the build status
[12:06:05.610] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:05.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:25:0) after 1m0s
[12:07:05.703] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:25:0)
[12:07:05.703] Timer tick, asking Buildbucket for the build status
[12:07:05.803] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:05.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:26:0) after 1m0s
[12:08:05.842] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:26:0)
[12:08:05.842] Timer tick, asking Buildbucket for the build status
[12:08:06.103] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:06.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:27:0) after 1m0s
[12:09:06.168] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:27:0)
[12:09:06.168] Timer tick, asking Buildbucket for the build status
[12:09:06.261] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:06.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:28:0) after 1m0s
[12:10:06.287] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:28:0)
[12:10:06.287] Timer tick, asking Buildbucket for the build status
[12:10:06.390] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:06.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:29:0) after 1m0s
[12:11:06.447] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:29:0)
[12:11:06.447] Timer tick, asking Buildbucket for the build status
[12:11:06.990] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:06.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:30:0) after 1m0s
[12:12:07.090] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:30:0)
[12:12:07.090] Timer tick, asking Buildbucket for the build status
[12:12:07.237] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:07.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:31:0) after 1m0s
[12:13:07.263] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:31:0)
[12:13:07.263] Timer tick, asking Buildbucket for the build status
[12:13:07.357] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:07.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:32:0) after 1m0s
[12:14:07.447] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:32:0)
[12:14:07.447] Timer tick, asking Buildbucket for the build status
[12:14:07.559] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:07.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:33:0) after 1m0s
[12:15:07.630] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:33:0)
[12:15:07.630] Timer tick, asking Buildbucket for the build status
[12:15:07.752] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:07.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:34:0) after 1m0s
[12:16:07.801] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:34:0)
[12:16:07.801] Timer tick, asking Buildbucket for the build status
[12:16:07.943] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:07.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:35:0) after 1m0s
[12:17:07.984] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:35:0)
[12:17:07.984] Timer tick, asking Buildbucket for the build status
[12:17:08.290] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:08.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:36:0) after 1m0s
[12:18:08.381] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:36:0)
[12:18:08.381] Timer tick, asking Buildbucket for the build status
[12:18:08.662] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:08.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:37:0) after 1m0s
[12:19:08.725] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:37:0)
[12:19:08.725] Timer tick, asking Buildbucket for the build status
[12:19:08.847] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:08.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:38:0) after 1m0s
[12:20:08.867] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:38:0)
[12:20:08.867] Timer tick, asking Buildbucket for the build status
[12:20:09.044] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:09.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:39:0) after 1m0s
[12:21:09.089] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:39:0)
[12:21:09.089] Timer tick, asking Buildbucket for the build status
[12:21:09.718] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:09.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:40:0) after 1m0s
[12:22:09.836] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:40:0)
[12:22:09.836] Timer tick, asking Buildbucket for the build status
[12:22:09.986] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:09.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:41:0) after 1m0s
[12:23:10.044] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:41:0)
[12:23:10.044] Timer tick, asking Buildbucket for the build status
[12:23:10.151] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:10.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:42:0) after 1m0s
[12:24:10.184] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:42:0)
[12:24:10.184] Timer tick, asking Buildbucket for the build status
[12:24:10.295] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:10.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:43:0) after 1m0s
[12:25:10.404] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:43:0)
[12:25:10.404] Timer tick, asking Buildbucket for the build status
[12:25:10.663] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:10.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:44:0) after 1m0s
[12:26:10.724] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:44:0)
[12:26:10.724] Timer tick, asking Buildbucket for the build status
[12:26:10.925] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:10.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:45:0) after 1m0s
[12:27:10.970] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:45:0)
[12:27:10.970] Timer tick, asking Buildbucket for the build status
[12:27:11.062] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:11.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:46:0) after 1m0s
[12:28:11.116] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:46:0)
[12:28:11.116] Timer tick, asking Buildbucket for the build status
[12:28:11.179] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:11.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:47:0) after 1m0s
[12:29:11.223] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:47:0)
[12:29:11.224] Timer tick, asking Buildbucket for the build status
[12:29:11.309] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:11.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:48:0) after 1m0s
[12:30:11.339] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:48:0)
[12:30:11.339] Timer tick, asking Buildbucket for the build status
[12:30:11.434] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:11.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:49:0) after 1m0s
[12:31:11.456] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:49:0)
[12:31:11.456] Timer tick, asking Buildbucket for the build status
[12:31:11.587] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:11.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:50:0) after 1m0s
[12:32:11.638] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:50:0)
[12:32:11.638] Timer tick, asking Buildbucket for the build status
[12:32:11.794] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:11.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:51:0) after 1m0s
[12:33:11.815] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:51:0)
[12:33:11.815] Timer tick, asking Buildbucket for the build status
[12:33:12.064] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:12.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:52:0) after 1m0s
[12:34:12.092] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:52:0)
[12:34:12.092] Timer tick, asking Buildbucket for the build status
[12:34:12.301] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:12.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:53:0) after 1m0s
[12:35:12.337] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:53:0)
[12:35:12.337] Timer tick, asking Buildbucket for the build status
[12:35:12.444] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:12.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:54:0) after 1m0s
[12:36:12.525] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:54:0)
[12:36:12.525] Timer tick, asking Buildbucket for the build status
[12:36:12.627] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:12.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:55:0) after 1m0s
[12:37:12.793] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:55:0)
[12:37:12.793] Timer tick, asking Buildbucket for the build status
[12:37:13.066] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:13.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:56:0) after 1m0s
[12:38:13.088] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:56:0)
[12:38:13.088] Timer tick, asking Buildbucket for the build status
[12:38:13.188] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:13.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:57:0) after 1m0s
[12:39:13.305] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:57:0)
[12:39:13.305] Timer tick, asking Buildbucket for the build status
[12:39:13.874] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:13.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:58:0) after 1m0s
[12:40:14.063] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:58:0)
[12:40:14.063] Timer tick, asking Buildbucket for the build status
[12:40:14.172] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:14.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:59:0) after 1m0s
[12:41:14.247] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:59:0)
[12:41:14.247] Timer tick, asking Buildbucket for the build status
[12:41:14.360] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:14.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:60:0) after 1m0s
[12:42:14.370] Handling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:60:0)
[12:42:14.370] Timer tick, asking Buildbucket for the build status
[12:42:14.542] Build 8887756581807227216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:14.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-gcc-arm64-linux:9053186643841176336:61:0) after 1m0s
[12:42:36.087] Received PubSub notification, asking Buildbucket for the build status
[12:42:36.231] Build 8887756581807227216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:42:36.231] Buildbucket build:
{
"build": {
"bucket": "luci.fuchsia.prod",
"canary_preference": "PROD",
"completed_ts": "1582375355286193",
"created_by": "project:fuchsia",
"created_ts": "1582371839667244",
"id": "8887756581807227216",
"parameters_json": "{\"builder_name\": \"gcc-arm64-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c080a6fb6f0cf402affc287fc600c189980cfb2d\", \"title\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\", \"url\": \"https://gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d\"}]}, \"branch\": \"refs/heads/releases/gcc-9\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}}",
"project": "fuchsia",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/releases/gcc-9\", \"repo\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}, \"id\": \"https://gnu.googlesource.com/gcc/+/refs/heads/releases/gcc-9@c080a6fb6f0cf402affc287fc600c189980cfb2d\", \"title\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\", \"url\": \"https://gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"build413-a9\", \"branch\": \"refs/heads/releases/gcc-9\", \"buildername\": \"gcc-arm64-linux\", \"git_revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d,7b3c27152b5695177a2cd5adc0d7b0255f99aca0\", \"instance_id\": \"D6ciaraeFxRZpKPGYQ1RB2UcUNlpqkwWMpcMJiJ8GuwC\", \"isolated\": \"d5e2ed11a140c09b3e93541a6bde2f234448efd9\", \"mastername\": \"gcc\", \"package\": \"fuchsia/third_party/gcc/linux-arm64\", \"path_config\": \"generic\", \"recipe\": \"gcc_toolchain\", \"repository\": \"https://gnu.googlesource.com/gcc\", \"revision\": \"c080a6fb6f0cf402affc287fc600c189980cfb2d\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"vpython\"], \"cores\": [\"256\"], \"cpu\": [\"arm\", \"arm-64\", \"arm64\", \"arm64-64\"], \"gce\": [\"0\"], \"gpu\": [\"1a03\", \"1a03:2000\"], \"id\": [\"build413-a9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-highcpu-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-18.04\"], \"pool\": [\"luci.fuchsia.prod\"], \"python\": [\"2.7.15+\"], \"server_version\": [\"4825-3d129d6\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-mtv\", \"us-mtv-chops\", \"us-mtv-chops-a9\"]}}}",
"service_account": "fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com",
"started_ts": "1582371845662767",
"status": "COMPLETED",
"status_changed_ts": "1582375355656618",
"tags": [
"builder:gcc-arm64-linux",
"buildset:commit/git/c080a6fb6f0cf402affc287fc600c189980cfb2d",
"buildset:commit/gitiles/gnu.googlesource.com/gcc/+/c080a6fb6f0cf402affc287fc600c189980cfb2d",
"gitiles_ref:refs/heads/releases/gcc-9",
"scheduler_invocation_id:9053186643841176336",
"scheduler_job_id:fuchsia/prod-gcc-arm64-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/fuchsia/buildbucket/cr-buildbucket.appspot.com/8887756581807227216/+/annotations",
"swarming_tag:luci_project:fuchsia",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:gcc_toolchain",
"swarming_tag:recipe_package:fuchsia/infra/recipe_bundles/fuchsia.googlesource.com/infra/recipes",
"swarming_task_id:4a8587a98abb2d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582375355719020",
"url": "https://ci.chromium.org/b/8887756581807227216",
"utcnow_ts": "1582375356222841"
}
}
[12:42:36.231] Invocation finished in 58m37.887013433s with status SUCCEEDED