[18:59:38.529] New invocation is queued and will start shortly
[18:59:39.609] Starting the invocation (attempt 1)
[18:59:39.656] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:59:39.656] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:59:39.656] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021178504747303040",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c76ad6ffc3294254f9e5b7361861ec2596174e5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021178504747303040",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c76ad6ffc3294254f9e5b7361861ec2596174e5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c76ad6ffc3294254f9e5b7361861ec2596174e5c",
"gitiles_ref:refs/heads/master"
]
}
[18:59:40.353] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612897179804382",
"id": "8855748442748547264",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c76ad6ffc3294254f9e5b7361861ec2596174e5c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612897180178077",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180429",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c76ad6ffc3294254f9e5b7361861ec2596174e5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c76ad6ffc3294254f9e5b7361861ec2596174e5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021178504747303040",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855748442748547264/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1612897180178181",
"url": "https://ci.chromium.org/b/8855748442748547264",
"utcnow_ts": "1612897180346623"
}
}
[18:59:40.353] Task URL: https://ci.chromium.org/b/8855748442748547264
[18:59:40.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:2:0) after 1m0s
[18:59:51.453] Received PubSub notification, asking Buildbucket for the build status
[18:59:51.595] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:40.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:2:0)
[19:00:40.403] Timer tick, asking Buildbucket for the build status
[19:00:41.714] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:41.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:4:0) after 1m0s
[19:01:41.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:4:0)
[19:01:41.810] Timer tick, asking Buildbucket for the build status
[19:01:42.131] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:42.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:5:0) after 1m0s
[19:02:42.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:5:0)
[19:02:42.164] Timer tick, asking Buildbucket for the build status
[19:02:43.584] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:43.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:6:0) after 1m0s
[19:03:43.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:6:0)
[19:03:43.582] Timer tick, asking Buildbucket for the build status
[19:03:44.306] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:7:0) after 1m0s
[19:04:44.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:7:0)
[19:04:44.409] Timer tick, asking Buildbucket for the build status
[19:04:46.509] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:8:0) after 1m0s
[19:05:46.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:8:0)
[19:05:46.601] Timer tick, asking Buildbucket for the build status
[19:05:48.094] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:48.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:9:0) after 1m0s
[19:06:48.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:9:0)
[19:06:48.112] Timer tick, asking Buildbucket for the build status
[19:06:48.175] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:48.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:10:0) after 1m0s
[19:07:48.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:10:0)
[19:07:48.245] Timer tick, asking Buildbucket for the build status
[19:07:48.460] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:48.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:11:0) after 1m0s
[19:08:48.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:11:0)
[19:08:48.541] Timer tick, asking Buildbucket for the build status
[19:08:48.651] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:48.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:12:0) after 1m0s
[19:09:48.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:12:0)
[19:09:48.714] Timer tick, asking Buildbucket for the build status
[19:09:49.210] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:49.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:13:0) after 1m0s
[19:10:49.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:13:0)
[19:10:49.363] Timer tick, asking Buildbucket for the build status
[19:10:49.664] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:49.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:14:0) after 1m0s
[19:11:49.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:14:0)
[19:11:49.809] Timer tick, asking Buildbucket for the build status
[19:11:49.926] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:49.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:15:0) after 1m0s
[19:12:50.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:15:0)
[19:12:50.044] Timer tick, asking Buildbucket for the build status
[19:12:50.124] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:50.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:16:0) after 1m0s
[19:13:50.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:16:0)
[19:13:50.121] Timer tick, asking Buildbucket for the build status
[19:13:50.524] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:50.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:17:0) after 1m0s
[19:14:50.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:17:0)
[19:14:50.544] Timer tick, asking Buildbucket for the build status
[19:14:51.044] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:51.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:18:0) after 1m0s
[19:15:51.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:18:0)
[19:15:51.096] Timer tick, asking Buildbucket for the build status
[19:15:51.842] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:51.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:19:0) after 1m0s
[19:16:51.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:19:0)
[19:16:51.933] Timer tick, asking Buildbucket for the build status
[19:16:54.422] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:54.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:20:0) after 1m0s
[19:17:54.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:20:0)
[19:17:54.685] Timer tick, asking Buildbucket for the build status
[19:17:54.781] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:54.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:21:0) after 1m0s
[19:18:54.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:21:0)
[19:18:54.895] Timer tick, asking Buildbucket for the build status
[19:18:58.595] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:58.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:22:0) after 1m0s
[19:19:58.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:22:0)
[19:19:58.643] Timer tick, asking Buildbucket for the build status
[19:19:58.957] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:58.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:23:0) after 1m0s
[19:20:58.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:23:0)
[19:20:58.997] Timer tick, asking Buildbucket for the build status
[19:20:59.116] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:59.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:24:0) after 1m0s
[19:21:59.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:24:0)
[19:21:59.240] Timer tick, asking Buildbucket for the build status
[19:22:00.099] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:25:0) after 1m0s
[19:23:00.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:25:0)
[19:23:00.243] Timer tick, asking Buildbucket for the build status
[19:23:00.649] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:00.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:26:0) after 1m0s
[19:24:00.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:26:0)
[19:24:00.924] Timer tick, asking Buildbucket for the build status
[19:24:01.259] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:01.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:27:0) after 1m0s
[19:25:01.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:27:0)
[19:25:01.559] Timer tick, asking Buildbucket for the build status
[19:25:02.322] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:02.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:28:0) after 1m0s
[19:26:02.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:28:0)
[19:26:02.388] Timer tick, asking Buildbucket for the build status
[19:26:02.642] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:02.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:29:0) after 1m0s
[19:27:02.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:29:0)
[19:27:02.619] Timer tick, asking Buildbucket for the build status
[19:27:02.934] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:30:0) after 1m0s
[19:28:02.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:30:0)
[19:28:02.921] Timer tick, asking Buildbucket for the build status
[19:28:03.236] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:03.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:31:0) after 1m0s
[19:29:03.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:31:0)
[19:29:03.773] Timer tick, asking Buildbucket for the build status
[19:29:03.871] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:03.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:32:0) after 1m0s
[19:30:03.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:32:0)
[19:30:03.916] Timer tick, asking Buildbucket for the build status
[19:30:04.378] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:04.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:33:0) after 1m0s
[19:31:04.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:33:0)
[19:31:04.463] Timer tick, asking Buildbucket for the build status
[19:31:04.568] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:04.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:34:0) after 1m0s
[19:32:04.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:34:0)
[19:32:04.627] Timer tick, asking Buildbucket for the build status
[19:32:04.729] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:04.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:35:0) after 1m0s
[19:33:04.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:35:0)
[19:33:04.910] Timer tick, asking Buildbucket for the build status
[19:33:05.011] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:05.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:36:0) after 1m0s
[19:34:05.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:36:0)
[19:34:05.337] Timer tick, asking Buildbucket for the build status
[19:34:05.415] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:05.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:37:0) after 1m0s
[19:35:05.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:37:0)
[19:35:05.540] Timer tick, asking Buildbucket for the build status
[19:35:05.912] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:05.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:38:0) after 1m0s
[19:36:05.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:38:0)
[19:36:05.971] Timer tick, asking Buildbucket for the build status
[19:36:06.103] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:06.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:39:0) after 1m0s
[19:37:06.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:39:0)
[19:37:06.178] Timer tick, asking Buildbucket for the build status
[19:37:07.017] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:07.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:40:0) after 1m0s
[19:38:07.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:40:0)
[19:38:07.141] Timer tick, asking Buildbucket for the build status
[19:38:07.763] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:07.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:41:0) after 1m0s
[19:39:07.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:41:0)
[19:39:07.836] Timer tick, asking Buildbucket for the build status
[19:39:07.906] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:07.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:42:0) after 1m0s
[19:40:08.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:42:0)
[19:40:08.026] Timer tick, asking Buildbucket for the build status
[19:40:08.227] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:08.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:43:0) after 1m0s
[19:41:08.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:43:0)
[19:41:08.267] Timer tick, asking Buildbucket for the build status
[19:41:08.438] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:08.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:44:0) after 1m0s
[19:42:08.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:44:0)
[19:42:08.765] Timer tick, asking Buildbucket for the build status
[19:42:08.910] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:08.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:45:0) after 1m0s
[19:43:09.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:45:0)
[19:43:09.023] Timer tick, asking Buildbucket for the build status
[19:43:09.179] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:09.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:46:0) after 1m0s
[19:44:09.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:46:0)
[19:44:09.207] Timer tick, asking Buildbucket for the build status
[19:44:09.329] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:09.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:47:0) after 1m0s
[19:45:09.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:47:0)
[19:45:09.665] Timer tick, asking Buildbucket for the build status
[19:45:09.892] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:09.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:48:0) after 1m0s
[19:46:10.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:48:0)
[19:46:10.344] Timer tick, asking Buildbucket for the build status
[19:46:10.405] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:10.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:49:0) after 1m0s
[19:47:10.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:49:0)
[19:47:10.579] Timer tick, asking Buildbucket for the build status
[19:47:10.720] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:10.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:50:0) after 1m0s
[19:48:10.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:50:0)
[19:48:10.828] Timer tick, asking Buildbucket for the build status
[19:48:11.022] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:11.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:51:0) after 1m0s
[19:49:11.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:51:0)
[19:49:11.054] Timer tick, asking Buildbucket for the build status
[19:49:22.300] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:22.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:52:0) after 1m0s
[19:50:22.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:52:0)
[19:50:22.342] Timer tick, asking Buildbucket for the build status
[19:50:22.570] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:22.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:53:0) after 1m0s
[19:51:22.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:53:0)
[19:51:22.611] Timer tick, asking Buildbucket for the build status
[19:51:22.808] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:22.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:54:0) after 1m0s
[19:52:22.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:54:0)
[19:52:22.847] Timer tick, asking Buildbucket for the build status
[19:52:23.026] Build 8855748442748547264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:23.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021178504747303040:55:0) after 1m0s
[19:53:16.197] Received PubSub notification, asking Buildbucket for the build status
[19:53:16.411] Build 8855748442748547264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:53:16.411] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612900395517871",
"created_by": "project:chromium",
"created_ts": "1612897179804382",
"id": "8855748442748547264",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c76ad6ffc3294254f9e5b7361861ec2596174e5c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"c76ad6ffc3294254f9e5b7361861ec2596174e5c\", \"project\": \"chromium/src\"}], \"$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}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-13-dhxs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180429, \"got_angle_revision\": \"b7d441e662a1839b941b1ddd6ca04f68aecfbabc\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"c76ad6ffc3294254f9e5b7361861ec2596174e5c\", \"got_revision_cp\": \"refs/heads/master@{#852272}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"9d35d544ce966098fdcb36107835d57a4dc1f32d\", \"got_v8_revision\": \"3da71e5e39df4bd049bfe2576033cbcbca8f3aa8\", \"got_v8_revision_cp\": \"refs/heads/9.0.145@{#1}\", \"got_webrtc_revision\": \"54ea85c2cd3a2cb1b8f440a71aa9676a9b88135c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33190}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c76ad6ffc3294254f9e5b7361861ec2596174e5c\", \"swarm_hashes_refs/heads/master(at){#852272}_without_patch\": {\"absl_hardening_tests\": \"7860913d81d41b9d378ccf511f2b9f9e8a74d935\", \"accessibility_unittests\": \"064f194765880219e768f390d26824ba47461ff0\", \"angle_unittests\": \"3a666e86079cbddbef6b0c1fbea50118385c82bd\", \"app_shell_unittests\": \"553e51f2177f7a5701813388df7482138fe9f4e6\", \"aura_unittests\": \"bef19b47fe31c97efd615ffb51288e09c8953093\", \"base_unittests\": \"7eed000116d0e1690bd442d584ac1e4bd57cbefb\", \"base_util_unittests\": \"3360f1a96e12fbeda817e7ec90df750f412ce462\", \"blink_common_unittests\": \"4e909d18db832ef631d0d60ae5c780bead67ad52\", \"blink_fuzzer_unittests\": \"0d67006a7aaed2ed14f0dd86aa89af01751d2968\", \"blink_heap_unittests\": \"9df84eb5fa855bb7122e16cb503a76db80f321cd\", \"blink_platform_unittests\": \"6f8ebc4d6ef4934bb01d3115b1e357ef87b1977b\", \"blink_python_tests\": \"1e97df2f057dd59404dce17a625488455ccd9cae\", \"blink_unittests\": \"db16bd9c4d0be40de9697a475e900a2b5c741a38\", \"blink_web_tests\": \"0e1be3da897cd0b4d9c8e36fc8f5bae769297123\", \"boringssl_crypto_tests\": \"f262b4bd69bb4bc44163637eb63480b85be7686d\", \"boringssl_ssl_tests\": \"e8d3db9c74d4682d1b55a49dd98c3297bdb07f78\", \"browser_tests\": \"1f789edff9f447d590c0643f3cf525dc3d65b34c\", \"capture_unittests\": \"7a52b5574f563453708f682db1334c84e96041ab\", \"cast_unittests\": \"98a16334a91d37dce362945ba24c8d523e5c2874\", \"cc_unittests\": \"a4e704360b5577b7f32c9bb61cc356b8969067ce\", \"chrome_app_unittests\": \"0952f52a72f8a976c168ebcb9ae55c29b3aee0c9\", \"chromedriver_unittests\": \"4b1d12e1b7431f82956851182f58a55c0fd1cc64\", \"components_browsertests\": \"0b4b2ecad1fe5899a4f27fc00c051eb65d38b2f2\", \"components_unittests\": \"c3628456b9a7bbe1b962ef354103b89b11adeac3\", \"compositor_unittests\": \"1b51e9b29af58bc1bcca0b3c41e312dc7e4471c5\", \"content_browsertests\": \"48b9ea3e953a23b22aa61993a7f8461bf0c63c0d\", \"content_shell_crash_test\": \"4dd283e6b628ce7a585e8c6edae260918cf7157c\", \"content_unittests\": \"6d1a0981ba408ce4adf12fba8b2dcb6c954ca5c4\", \"crashpad_tests\": \"854b63f4f8f8e44532427d0e0cd505af24314100\", \"cronet_tests\": \"41669da088fb73d0dd18ead14975236bdd801d5f\", \"cronet_unittests\": \"660006655de0c441c86df08b30b06050287d2abd\", \"crypto_unittests\": \"2a686f53fc183630169739b05216b5664201179e\", \"dbus_unittests\": \"e945fccf2c6c21b37a61202ecfe96d3489c17fed\", \"device_unittests\": \"0f3281c6a1980a4fb85eb2312b885a3ff2c0cc12\", \"display_unittests\": \"e21f8c1806b1e20cdfed8e9083177404dd4408b1\", \"events_unittests\": \"968b49f480470abe9d3cfe5e9637436980dec95c\", \"extensions_browsertests\": \"675b6286ac7ba64b96cdd07ac48d7d46a74db5a4\", \"extensions_unittests\": \"83e3566a15924612fc35591bca3dd70d05843c35\", \"filesystem_service_unittests\": \"03e8e8dac7af481c5d7f1389da0e766a51c0e94f\", \"flatbuffers_unittests\": \"58976a0c9ae5674987a52610b5f40e2c6cc5fd08\", \"gcm_unit_tests\": \"e78850db84732017ca006ff25f0e2c3c41ab0406\", \"gfx_unittests\": \"d04a7f7ede3eb160f74fdc4fe10ff10477a22d38\", \"gin_unittests\": \"85e4d525722ac1a3c525627f1b8ca106a914d1a4\", \"google_apis_unittests\": \"3530b2829d621863deebfbaf9dcb83e624d2fa63\", \"gpu_unittests\": \"a009bc65ffc9142b487b78d4eb7a9c0fea90f2c4\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"c4f156ceef09f9404e97b40e11070acac90afdb0\", \"headless_browsertests\": \"47ec078de15da6cb08ffdd4d9cff11c4ba26a1ac\", \"headless_unittests\": \"351d51f4de5b59c7ffe2d84476b25e4641eee1d8\", \"interactive_ui_tests\": \"cd8d333511ef3c9957702f74f236955448d2687c\", \"ipc_tests\": \"fd944d24e695d5a2a874705aaa50544a1fec9910\", \"jingle_unittests\": \"002045e6705732188ebc3bfd682fa8fddd3ddde4\", \"latency_unittests\": \"5ffa3f2e4da579bcd3a85b0bfd0a0278e42c9621\", \"libjingle_xmpp_unittests\": \"c5462d55a744573308f7dfb4d4be8b421a010881\", \"liburlpattern_unittests\": \"7638e91b88638c27753f6eef5a7d70b96ac4ee4d\", \"media_blink_unittests\": \"5555b156053d6b79b7fa5e9725cbd1cfc58b5d33\", \"media_unittests\": \"9d8aac16b8dec6af0c75fb2d9afe221e253d4949\", \"message_center_unittests\": \"c830180e9cb3826b0d023ebb6427c1509991416a\", \"metrics_python_tests\": \"6f9b5383260f565a611298572fe0438c5f3eeab6\", \"midi_unittests\": \"3c902fe5dd85c9c3f279a9cf3382e8fcb076516b\", \"mojo_core_unittests\": \"0e5f66f24591be0caf3ebcc28d6760048ce8c4de\", \"mojo_unittests\": \"44ac5a90a2bb5031a3fb1a69ddbb0f0e0f2dca0a\", \"nacl_helper_nonsfi_unittests\": \"3fca56d0a49292b5f72754643f8f6e723bba80c5\", \"nacl_loader_unittests\": \"2393a8ae827357705bf674c36eeac673e60a9a4a\", \"native_theme_unittests\": \"1b55aa12904c0f560469027f810b7261917b6dff\", \"net_unittests\": \"269ee6fa4333ee5778d809f5e7913576a948740c\", \"openscreen_unittests\": \"033c53a2b44da7d259ab6d5ad432b660a4bca71a\", \"pdf_unittests\": \"9bc2a3b4dc62a16931f5dea3e276fbfa71edc1cc\", \"perfetto_unittests\": \"3ce2c810be753506c31032b664f4dc21927c9a67\", \"ppapi_unittests\": \"f61f5b9cb6da36553d916dc1edb40ae26b158622\", \"printing_unittests\": \"e0de52b137170328ab5db24c08f5f9b69a3e6eaf\", \"remoting_unittests\": \"25b111aafd74b22745e5a56b0ce0546bbffbe4c2\", \"sandbox_linux_unittests\": \"6f8a7443364b8da816eb2f27e7e9ea679d9f34c2\", \"service_manager_unittests\": \"06eaf29d6747f18c8e42e790cf49e334d5e290e2\", \"services_unittests\": \"ad53eb9807a4b1acb3452546e277798f76aafd3e\", \"shell_dialogs_unittests\": \"5d474230bc4ce6211c02fd4edca8ff900a372ffa\", \"skia_unittests\": \"334b27aa6b9054a40d86fd2ceb8ca9e67b1b1e68\", \"snapshot_unittests\": \"a6d69437ffff0c2586b8eccba0cad50b49db4e7b\", \"sql_unittests\": \"2869581cfdf89cd5bac5bc31820d0ed905d9e9c7\", \"storage_unittests\": \"4957282852228af7f6232cf7c80409beb59db6a4\", \"sync_integration_tests\": \"2fe9484bf5eb46412755056f51284b6db0251f03\", \"telemetry_gpu_unittests\": \"4a18cb3ce4b10e2b1733f11ef211b3ca04e6c6de\", \"telemetry_perf_unittests\": \"4df208c8f77f206d8201234a29d26e15d7b7ffa4\", \"telemetry_unittests\": \"513b936f3da514005689a239b7c61928f1af9ac7\", \"traffic_annotation_auditor_unittests\": \"405cdc286f94da1dbf8d0156d78f0e1883b94562\", \"ui_base_unittests\": \"2cd45c0feaa909900784f56ef8bf6cff7a1bd289\", \"ui_touch_selection_unittests\": \"331f2c4485cc524ff7f5eb5201be7981d548d229\", \"unit_tests\": \"092366e89e733695b96a215ccbe037771de48a40\", \"url_unittests\": \"f2eb57a4887e241226bd6547528aff9accfe2c07\", \"views_perftests\": \"d7a8c8c6bcc6b5c080a9c17f8c99f98e5911233a\", \"views_unittests\": \"e2e7a7c697469a0d0ca19ab2dd41f9e21af20562\", \"viz_unittests\": \"ad0ffe01b3f916745bf105c6501ed302f37ca6fe\", \"vr_common_unittests\": \"be2d472b3de4f193734e26b271d6a0cf7ba979a1\", \"vr_pixeltests\": \"ea9664583f962a689145556c9bd69ac5d0e76992\", \"webdriver_wpt_tests\": \"cd69c08878d9e80b4d0a5586ac7184b40c1ba55c\", \"weblayer_browsertests\": \"7c5aa6db94638bc583029995fc26134f10834b46\", \"weblayer_unittests\": \"746460106039d788712ecb959b9317be3b44b239\", \"wm_unittests\": \"e08675faea709cfe0db3bba115ba298366100eea\", \"wtf_unittests\": \"1ab4aa47260bad3199adc7ad5d4887d34a531237\", \"x11_unittests\": \"f768ed17a92dc3051f6f7756daea58106f59e014\", \"xr_browser_tests\": \"b14670172ddcde75e1a142e779e21723219e19e0\", \"zlib_unittests\": \"3045d92020a65974b8b7f354b608983b7f6807bf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_11b57e6d03428c2faa53796866d496d474313651f92f95ab80780c64b3558ac7_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_b492a6a54599c40c9efefa6e5d1cdf990fad3125ae5ed8fb1c6f132ff9c1d569_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_v2\", \"builder_ce22d0fc5c297d03141230de59f52ebaf9005395a667e8b14df59e499796620f_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-13-dhxs\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612897190631620",
"status": "COMPLETED",
"status_changed_ts": "1612900395923313",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180429",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c76ad6ffc3294254f9e5b7361861ec2596174e5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c76ad6ffc3294254f9e5b7361861ec2596174e5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021178504747303040",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855748442748547264/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:51a0fb7a85f6a410",
"user_agent:luci-scheduler"
],
"updated_ts": "1612900395929090",
"url": "https://ci.chromium.org/b/8855748442748547264",
"utcnow_ts": "1612900396384061"
}
}
[19:53:16.411] Invocation finished in 53m37.897046008s with status SUCCEEDED