[18:41:54.988] New invocation is queued and will start shortly
[18:41:56.102] Starting the invocation (attempt 1)
[18:41:56.171] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:41:56.171] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:41:56.171] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030148719627149376",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"be3c7144b71cf61f2b294f11e083c2af5a7a8970\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9030148719627149376",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/be3c7144b71cf61f2b294f11e083c2af5a7a8970",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be3c7144b71cf61f2b294f11e083c2af5a7a8970",
"gitiles_ref:refs/heads/master"
]
}
[18:41:57.225] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604342516319687",
"id": "8864718657566748928",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"be3c7144b71cf61f2b294f11e083c2af5a7a8970\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604342516869634",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177264",
"builder:Linux Builder (dbg)",
"buildset:commit/git/be3c7144b71cf61f2b294f11e083c2af5a7a8970",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be3c7144b71cf61f2b294f11e083c2af5a7a8970",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030148719627149376",
"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/8864718657566748928/+/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": "1604342516869795",
"url": "https://ci.chromium.org/b/8864718657566748928",
"utcnow_ts": "1604342517214963"
}
}
[18:41:57.225] Task URL: https://ci.chromium.org/b/8864718657566748928
[18:41:57.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:2:0) after 1m0s
[18:42:10.849] Received PubSub notification, asking Buildbucket for the build status
[18:42:10.936] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:57.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:2:0)
[18:42:57.294] Timer tick, asking Buildbucket for the build status
[18:42:58.392] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:4:0) after 1m0s
[18:43:58.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:4:0)
[18:43:58.472] Timer tick, asking Buildbucket for the build status
[18:43:58.628] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:58.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:5:0) after 1m0s
[18:44:58.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:5:0)
[18:44:58.683] Timer tick, asking Buildbucket for the build status
[18:44:58.916] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:58.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:6:0) after 1m0s
[18:45:58.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:6:0)
[18:45:58.970] Timer tick, asking Buildbucket for the build status
[18:45:59.148] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:59.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:7:0) after 1m0s
[18:46:59.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:7:0)
[18:46:59.233] Timer tick, asking Buildbucket for the build status
[18:46:59.366] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:59.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:8:0) after 1m0s
[18:47:59.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:8:0)
[18:47:59.543] Timer tick, asking Buildbucket for the build status
[18:47:59.760] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:59.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:9:0) after 1m0s
[18:48:59.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:9:0)
[18:48:59.789] Timer tick, asking Buildbucket for the build status
[18:49:00.585] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:00.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:10:0) after 1m0s
[18:50:01.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:10:0)
[18:50:01.614] Timer tick, asking Buildbucket for the build status
[18:50:01.673] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:01.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:11:0) after 1m0s
[18:51:01.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:11:0)
[18:51:01.705] Timer tick, asking Buildbucket for the build status
[18:51:01.953] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:01.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:12:0) after 1m0s
[18:52:02.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:12:0)
[18:52:02.084] Timer tick, asking Buildbucket for the build status
[18:52:02.148] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:02.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:13:0) after 1m0s
[18:53:02.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:13:0)
[18:53:02.202] Timer tick, asking Buildbucket for the build status
[18:53:02.352] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:02.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:14:0) after 1m0s
[18:54:02.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:14:0)
[18:54:02.375] Timer tick, asking Buildbucket for the build status
[18:54:02.460] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:02.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:15:0) after 1m0s
[18:55:02.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:15:0)
[18:55:02.753] Timer tick, asking Buildbucket for the build status
[18:55:02.831] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:02.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:16:0) after 1m0s
[18:56:02.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:16:0)
[18:56:02.993] Timer tick, asking Buildbucket for the build status
[18:56:03.069] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:03.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:17:0) after 1m0s
[18:57:03.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:17:0)
[18:57:03.132] Timer tick, asking Buildbucket for the build status
[18:57:03.351] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:03.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:18:0) after 1m0s
[18:58:03.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:18:0)
[18:58:03.510] Timer tick, asking Buildbucket for the build status
[18:58:03.878] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:03.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:19:0) after 1m0s
[18:59:04.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:19:0)
[18:59:04.112] Timer tick, asking Buildbucket for the build status
[18:59:04.348] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:04.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:20:0) after 1m0s
[19:00:04.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:20:0)
[19:00:04.379] Timer tick, asking Buildbucket for the build status
[19:00:04.485] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:04.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:21:0) after 1m0s
[19:01:04.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:21:0)
[19:01:04.549] Timer tick, asking Buildbucket for the build status
[19:01:04.680] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:04.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:22:0) after 1m0s
[19:02:04.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:22:0)
[19:02:04.766] Timer tick, asking Buildbucket for the build status
[19:02:04.870] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:04.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:23:0) after 1m0s
[19:03:04.925] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:23:0)
[19:03:04.925] Timer tick, asking Buildbucket for the build status
[19:03:05.106] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:05.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:24:0) after 1m0s
[19:04:05.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:24:0)
[19:04:05.131] Timer tick, asking Buildbucket for the build status
[19:04:05.220] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:05.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:25:0) after 1m0s
[19:05:05.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:25:0)
[19:05:05.291] Timer tick, asking Buildbucket for the build status
[19:05:05.428] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:05.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:26:0) after 1m0s
[19:06:05.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:26:0)
[19:06:05.507] Timer tick, asking Buildbucket for the build status
[19:06:05.843] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:05.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:27:0) after 1m0s
[19:07:05.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:27:0)
[19:07:05.880] Timer tick, asking Buildbucket for the build status
[19:07:05.962] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:05.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:28:0) after 1m0s
[19:08:05.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:28:0)
[19:08:05.995] Timer tick, asking Buildbucket for the build status
[19:08:06.936] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:06.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:29:0) after 1m0s
[19:09:07.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:29:0)
[19:09:07.033] Timer tick, asking Buildbucket for the build status
[19:09:07.137] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:07.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:30:0) after 1m0s
[19:10:07.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:30:0)
[19:10:07.149] Timer tick, asking Buildbucket for the build status
[19:10:07.224] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:07.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:31:0) after 1m0s
[19:11:07.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:31:0)
[19:11:07.380] Timer tick, asking Buildbucket for the build status
[19:11:07.485] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:07.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:32:0) after 1m0s
[19:12:07.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:32:0)
[19:12:07.569] Timer tick, asking Buildbucket for the build status
[19:12:07.709] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:07.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:33:0) after 1m0s
[19:13:07.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:33:0)
[19:13:07.798] Timer tick, asking Buildbucket for the build status
[19:13:08.171] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:08.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:34:0) after 1m0s
[19:14:08.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:34:0)
[19:14:08.277] Timer tick, asking Buildbucket for the build status
[19:14:08.375] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:08.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:35:0) after 1m0s
[19:15:08.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:35:0)
[19:15:08.507] Timer tick, asking Buildbucket for the build status
[19:15:08.611] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:08.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:36:0) after 1m0s
[19:16:08.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:36:0)
[19:16:08.955] Timer tick, asking Buildbucket for the build status
[19:16:09.042] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:09.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:37:0) after 1m0s
[19:17:09.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:37:0)
[19:17:09.339] Timer tick, asking Buildbucket for the build status
[19:17:09.466] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:09.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:38:0) after 1m0s
[19:18:09.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:38:0)
[19:18:09.739] Timer tick, asking Buildbucket for the build status
[19:18:09.834] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:09.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:39:0) after 1m0s
[19:19:10.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:39:0)
[19:19:10.408] Timer tick, asking Buildbucket for the build status
[19:19:10.544] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:10.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:40:0) after 1m0s
[19:20:11.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:40:0)
[19:20:11.161] Timer tick, asking Buildbucket for the build status
[19:20:11.284] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:11.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:41:0) after 1m0s
[19:21:11.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:41:0)
[19:21:11.686] Timer tick, asking Buildbucket for the build status
[19:21:11.844] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:11.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:42:0) after 1m0s
[19:22:12.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:42:0)
[19:22:12.058] Timer tick, asking Buildbucket for the build status
[19:22:12.219] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:12.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:43:0) after 1m0s
[19:23:12.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:43:0)
[19:23:12.304] Timer tick, asking Buildbucket for the build status
[19:23:12.465] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:12.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:44:0) after 1m0s
[19:24:12.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:44:0)
[19:24:12.749] Timer tick, asking Buildbucket for the build status
[19:24:12.870] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:12.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:45:0) after 1m0s
[19:25:13.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:45:0)
[19:25:13.106] Timer tick, asking Buildbucket for the build status
[19:25:13.193] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:13.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:46:0) after 1m0s
[19:26:13.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:46:0)
[19:26:13.366] Timer tick, asking Buildbucket for the build status
[19:26:13.434] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:13.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:47:0) after 1m0s
[19:27:13.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:47:0)
[19:27:13.570] Timer tick, asking Buildbucket for the build status
[19:27:13.685] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:13.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:48:0) after 1m0s
[19:28:13.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:48:0)
[19:28:13.744] Timer tick, asking Buildbucket for the build status
[19:28:13.820] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:13.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:49:0) after 1m0s
[19:29:13.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:49:0)
[19:29:13.941] Timer tick, asking Buildbucket for the build status
[19:29:14.147] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:14.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:50:0) after 1m0s
[19:30:14.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:50:0)
[19:30:14.177] Timer tick, asking Buildbucket for the build status
[19:30:14.392] Build 8864718657566748928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:14.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9030148719627149376:51:0) after 1m0s
[19:31:10.880] Received PubSub notification, asking Buildbucket for the build status
[19:31:11.018] Build 8864718657566748928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:31:11.018] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604345469946157",
"created_by": "project:chromium",
"created_ts": "1604342516319687",
"id": "8864718657566748928",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"be3c7144b71cf61f2b294f11e083c2af5a7a8970\"}}",
"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\": \"be3c7144b71cf61f2b294f11e083c2af5a7a8970\", \"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-86-hldt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177264, \"got_angle_revision\": \"f34ba6464f317ccfdc07928939962d026119f02f\", \"got_dawn_revision\": \"71d2e1d23d49c3616209dbf4776fd720aaa11560\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"be3c7144b71cf61f2b294f11e083c2af5a7a8970\", \"got_revision_cp\": \"refs/heads/master@{#823224}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"7751fe38f4744c7126a137d4d7955c29c19f4662\", \"got_v8_revision\": \"be169f638f5edd2af0946618b0c98c9339f33627\", \"got_v8_revision_cp\": \"refs/heads/8.8.215@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"be3c7144b71cf61f2b294f11e083c2af5a7a8970\", \"swarm_hashes_refs/heads/master(at){#823224}_without_patch\": {\"absl_hardening_tests\": \"b0453f1b684852f8a1375f84a13fed4f7b775292\", \"accessibility_unittests\": \"1f0a809c2956c48262ded9aa57a9a9067c3fd787\", \"angle_unittests\": \"15156e92b44e61a7a6baa441ceb267e3d750387a\", \"app_shell_unittests\": \"d12bcf507ead46026cc398a3f3e4e0c794b1a9a0\", \"aura_unittests\": \"1d372b0597b16834ee4246db5a8b6ba1abe633e1\", \"base_unittests\": \"73255fde4c0647dbaca1dfde7dfb4077763965ef\", \"base_util_unittests\": \"a599a7713ffd87bded4ab3097c18723750c9ad22\", \"blink_common_unittests\": \"962193a0e981da6d491e88f717fc125702b186ce\", \"blink_fuzzer_unittests\": \"edb48aff27695bbfe5c10d802fd820129d6ccce0\", \"blink_heap_unittests\": \"26473f39bbfe020d3fa63b0ce2656af40211108e\", \"blink_platform_unittests\": \"ec0b05785d012b4d98a1df916c80f4df4427d28c\", \"blink_python_tests\": \"72fc5797ca7868da477de0d4b056167799c2ce33\", \"blink_unittests\": \"fd2f69aed24c21c35dbd6ed93b6e3e1be84f76d0\", \"blink_web_tests\": \"33cd636823741bd523ca47d277ff4179538e0f8d\", \"boringssl_crypto_tests\": \"323599808066591419e152a5b0899ee0603a7395\", \"boringssl_ssl_tests\": \"c3b91d535332f3f8a19031d46a995f6c60467356\", \"browser_tests\": \"42cbcf9616de15a4460d8421465f138ad81d1072\", \"capture_unittests\": \"00fa763dec25d6cf4ed4e83d2b8fb35751a3fa74\", \"cast_unittests\": \"e4e84071217e1b8b243f4b6baaa2bc41dbf4e359\", \"cc_unittests\": \"b883e597a43b4eb81f21bb95af57db5e68302396\", \"chrome_app_unittests\": \"4475e0696bd5d8b1752be9f475362bbf4ac31015\", \"chromedriver_unittests\": \"666d4a66646dc7141763f11503d7fa06efb1bd4f\", \"components_browsertests\": \"06496eda59e4e11bca425bd2b8df42f09076500a\", \"components_unittests\": \"22ec948459c92f89cc2bd7174a26797087e70561\", \"compositor_unittests\": \"70fbc226d83221e4780b37c452233f838d98f843\", \"content_browsertests\": \"eb6394ea2c937ea12c1140cf66caec734942caf9\", \"content_shell_crash_test\": \"44a4fd9449e8a5ae8cc731f54deb3d352c930473\", \"content_unittests\": \"f9328cffa712f67c1eef388ce84fa715ef4b1761\", \"crashpad_tests\": \"f9f78b93c03cb66b3c4b4d015a98a272e34758fe\", \"cronet_tests\": \"305f9d1eb2e8c1b42ccca00abc4f0ab3a9cbd751\", \"cronet_unittests\": \"a15b07a11cb06c528e22cd1b56d69359abc26525\", \"crypto_unittests\": \"bcf84cbce120c22757abfe6b393b68735fbbabe0\", \"dbus_unittests\": \"1c0195dbe3e3a3a4c823a5583a49f1fa53a70445\", \"device_unittests\": \"f4a52b3a22d6eab0b09636e74a380c68a16aa467\", \"display_unittests\": \"c0690c7fce7acea8dd2843d1adf581d081c3597c\", \"events_unittests\": \"4d4bc09d3b035f659f58324dfa7b07b8b16f8260\", \"extension_docserver_python_unittests\": \"8d4a64161f40db026796f6f454a5d91b7edf946b\", \"extensions_browsertests\": \"8df08b8f598a1f15a0499a3d6599b2e8c50dc665\", \"extensions_unittests\": \"e9660bc69531edc504e5ce1563d172c9eba29954\", \"filesystem_service_unittests\": \"38a0ad7b236935087b7462fe2d45755cd7bbd4f6\", \"flatbuffers_unittests\": \"ca986cd6c8ae1796858da669da1b4475f0113d71\", \"gcm_unit_tests\": \"cd8250e5b7115bcdc7783d02fec4fc8782a364ba\", \"gfx_unittests\": \"c57fb612ef5c9320df73670162bfee84876b5b73\", \"gin_unittests\": \"9f9fbc96d703c27198827acb2776df985e2882cd\", \"google_apis_unittests\": \"95c2de94f993399761ca46747f13e27a303b6d9d\", \"gpu_unittests\": \"82e1eaf58918c2faf63d96b4f3365cb92b63a751\", \"grit_python_unittests\": \"c57107c549d400957552f9572189db48595072fe\", \"gwp_asan_unittests\": \"49c620946fd1922fdfaa4fdbd15874deb8396b72\", \"headless_browsertests\": \"4d5f2e05efaacb23fd7d254762a8fe4d3e8485a4\", \"headless_unittests\": \"b9ceded4c9affd885acde8ef18af73b37f1f76cd\", \"interactive_ui_tests\": \"63669c08a99b25a221cecb17811c742994f728c7\", \"ipc_tests\": \"fbece4cb5687b835eb9db5e17d59c8a1ce315bbf\", \"jingle_unittests\": \"66c6d84550a18182e30e15ecc68e55a68688d2cf\", \"latency_unittests\": \"c3ce7dee3a85d846f06629bf5eb81beffbfa67b5\", \"libjingle_xmpp_unittests\": \"3bcb8e11f4a0f265b842aa1ed0c849abe1b87cca\", \"liburlpattern_unittests\": \"669c244c2e0445d68754f29faa733e593a006351\", \"media_blink_unittests\": \"590615d5099b75b083011c0b115bc6321152ed85\", \"media_unittests\": \"f8d5b0791b5bdf428564498bed70da30ed909566\", \"message_center_unittests\": \"9ec01ce43443b6d61eeb3c085e8d724473b8ab54\", \"metrics_python_tests\": \"c5d7b8ec458f484b1fa53a82cf96a98fcb1f7322\", \"midi_unittests\": \"bd2e327aea402aae746f30e9c26d29c939c5537c\", \"mojo_core_unittests\": \"6a05875e34002de6716a9b558ca5fe6959f47692\", \"mojo_unittests\": \"a11c1901c8ba6fcb5acb312d56492868e144b84e\", \"nacl_helper_nonsfi_unittests\": \"f47e39286c3b116f52293513a5312b2867a21fba\", \"nacl_loader_unittests\": \"e4c29c55d1d8521ab3700336525dcc3bd74558b1\", \"native_theme_unittests\": \"aaa02846cccf3b9621dce2fb7b8e9744e803ffa7\", \"net_unittests\": \"f8c59451fe86be6bd5bd3a69cf86c8e793c1593e\", \"openscreen_unittests\": \"bdcd73c80abbc119d267b95031c12a5d3084eb93\", \"pdf_unittests\": \"6adf3250f0671eb12d6d8d1ad8b484a6a3978528\", \"perfetto_unittests\": \"8e11a09c1a9f2e14ddb87bcce32dfb78daa9ecfb\", \"ppapi_unittests\": \"cd53b57d159d23aae9821d3e15d032700de2ceef\", \"printing_unittests\": \"5f8ebc260acf68e051c7459c623502c06de6d860\", \"remoting_unittests\": \"2f5ed90b4ce2d41aef9f8e42ef5b69a8cc6aa200\", \"sandbox_linux_unittests\": \"fd669c122b820611e54ea15660dc645cad5648dd\", \"service_manager_unittests\": \"006f37b12987d127324793c722818a56dab0a3de\", \"services_unittests\": \"ebf8d1032252e9c48994cf8826d2e8def4102c5f\", \"shell_dialogs_unittests\": \"c025f61d05e5fd7b40ec87c61decfccd3696fb8a\", \"skia_unittests\": \"4d6b61085fff0e7a5a5f99f09a4e52c433a5c32d\", \"snapshot_unittests\": \"372ae940c62ab1d12b273441f8054871ef56352d\", \"sql_unittests\": \"e74482f5641baa968175b7e66cdda3da41e6e4f7\", \"storage_unittests\": \"0bbf60258ad8e421a3a1c1fc32693ddf5969f519\", \"sync_integration_tests\": \"06115ccda1e87cb70eeb32367b3377ea5308400f\", \"telemetry_gpu_unittests\": \"6aae059420d2ed447924ad5d8c65dcdab4759c9c\", \"telemetry_perf_unittests\": \"b2d536fb275b4585f1d2f7af5967b80e90ab6ccf\", \"telemetry_unittests\": \"f1176e006dadfaceec1b898dc3f77001fd9371fe\", \"traffic_annotation_auditor_unittests\": \"b7ae0c45c0465d081f83037562caeccbf4eca64d\", \"ui_base_unittests\": \"b06d6f9ef17d8133d7878e53717d8832b7f7e2f4\", \"ui_touch_selection_unittests\": \"14083e18a9dbbe610c7d2b199e5b9eb5c931a132\", \"unit_tests\": \"dd7f332e4544c58a1ccec897aa6887d92e629fad\", \"url_unittests\": \"5f893f0636f995e7f5aa56c325f85e6e0cc8b874\", \"views_perftests\": \"12df30d12605d0a72b0f82234d18f04816fd9ab2\", \"views_unittests\": \"cc978a803fa2145a4a7755f58da004aacc1066a4\", \"viz_unittests\": \"7c68ea60c06a12246e7c37be9e100ff9260d0833\", \"vr_common_unittests\": \"e4d764594304b20a47a10d050930ed851212d9f1\", \"vr_pixeltests\": \"17f4137bb2bcb2dec478cceda60d0b6eef849c6f\", \"webdriver_wpt_tests\": \"56939950a0fbd292c79b9cc47e76c02e121583e4\", \"weblayer_browsertests\": \"215e32266ef06b532f6af3629091ed0b91aca90b\", \"weblayer_unittests\": \"c2cd07c4e7b889749827c6e1b7a53b95ebff8798\", \"wm_unittests\": \"797eca94fb3c094838a80b59e4a5c3db99bae169\", \"wtf_unittests\": \"8eae424507ad097308f83e2d48d4436193e3c796\", \"x11_unittests\": \"7831dd1fb9132d29ba726c8fab8821f92849dcc5\", \"xr_browser_tests\": \"c132dc5d2628ff6d6084331535c8e153d53da0f9\", \"zlib_unittests\": \"8dad5ebd0ebc5469ec0caf0654f72c2c165c3a97\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-86-hldt\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604342529851562",
"status": "COMPLETED",
"status_changed_ts": "1604345470371027",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177264",
"builder:Linux Builder (dbg)",
"buildset:commit/git/be3c7144b71cf61f2b294f11e083c2af5a7a8970",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be3c7144b71cf61f2b294f11e083c2af5a7a8970",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030148719627149376",
"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/8864718657566748928/+/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:4fa315b0e73b0110",
"user_agent:luci-scheduler"
],
"updated_ts": "1604345470375309",
"url": "https://ci.chromium.org/b/8864718657566748928",
"utcnow_ts": "1604345470990420"
}
}
[19:31:11.018] Invocation finished in 49m16.048024382s with status SUCCEEDED