[08:28:34.227] New invocation is queued and will start shortly
[08:28:35.354] Starting the invocation (attempt 1)
[08:28:35.410] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:28:35.410] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:28:35.410] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026382235428942624",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7f889d40b46bdff902a72eb44bdfb4a5f61f646d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9026382235428942624",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/7f889d40b46bdff902a72eb44bdfb4a5f61f646d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f889d40b46bdff902a72eb44bdfb4a5f61f646d",
"gitiles_ref:refs/heads/master"
]
}
[08:28:36.081] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607934515515665",
"id": "8860952173417175904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f889d40b46bdff902a72eb44bdfb4a5f61f646d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607934515938555",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178629",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7f889d40b46bdff902a72eb44bdfb4a5f61f646d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f889d40b46bdff902a72eb44bdfb4a5f61f646d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026382235428942624",
"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/8860952173417175904/+/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": "1607934515938702",
"url": "https://ci.chromium.org/b/8860952173417175904",
"utcnow_ts": "1607934516074046"
}
}
[08:28:36.081] Task URL: https://ci.chromium.org/b/8860952173417175904
[08:28:36.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:2:0) after 1m0s
[08:28:39.211] Received PubSub notification, asking Buildbucket for the build status
[08:28:39.436] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:2:0)
[08:29:36.171] Timer tick, asking Buildbucket for the build status
[08:29:36.281] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:4:0) after 1m0s
[08:30:36.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:4:0)
[08:30:36.298] Timer tick, asking Buildbucket for the build status
[08:30:36.395] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:36.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:5:0) after 1m0s
[08:31:36.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:5:0)
[08:31:36.444] Timer tick, asking Buildbucket for the build status
[08:31:36.539] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:36.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:6:0) after 1m0s
[08:32:36.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:6:0)
[08:32:36.626] Timer tick, asking Buildbucket for the build status
[08:32:36.835] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:36.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:7:0) after 1m0s
[08:33:36.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:7:0)
[08:33:36.913] Timer tick, asking Buildbucket for the build status
[08:33:36.976] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:36.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:8:0) after 1m0s
[08:34:36.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:8:0)
[08:34:36.955] Timer tick, asking Buildbucket for the build status
[08:34:37.072] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:37.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:9:0) after 1m0s
[08:35:37.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:9:0)
[08:35:37.046] Timer tick, asking Buildbucket for the build status
[08:35:37.141] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:37.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:10:0) after 1m0s
[08:36:37.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:10:0)
[08:36:37.178] Timer tick, asking Buildbucket for the build status
[08:36:37.251] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:37.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:11:0) after 1m0s
[08:37:37.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:11:0)
[08:37:37.262] Timer tick, asking Buildbucket for the build status
[08:37:37.406] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:37.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:12:0) after 1m0s
[08:38:37.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:12:0)
[08:38:37.408] Timer tick, asking Buildbucket for the build status
[08:38:37.469] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:37.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:13:0) after 1m0s
[08:39:37.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:13:0)
[08:39:37.585] Timer tick, asking Buildbucket for the build status
[08:39:38.068] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:38.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:14:0) after 1m0s
[08:40:38.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:14:0)
[08:40:38.147] Timer tick, asking Buildbucket for the build status
[08:40:38.226] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:38.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:15:0) after 1m0s
[08:41:38.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:15:0)
[08:41:38.374] Timer tick, asking Buildbucket for the build status
[08:41:38.456] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:38.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:16:0) after 1m0s
[08:42:38.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:16:0)
[08:42:38.634] Timer tick, asking Buildbucket for the build status
[08:42:38.710] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:17:0) after 1m0s
[08:43:38.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:17:0)
[08:43:38.729] Timer tick, asking Buildbucket for the build status
[08:43:38.787] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:38.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:18:0) after 1m0s
[08:44:38.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:18:0)
[08:44:38.894] Timer tick, asking Buildbucket for the build status
[08:44:39.021] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:39.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:19:0) after 1m0s
[08:45:39.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:19:0)
[08:45:39.014] Timer tick, asking Buildbucket for the build status
[08:45:39.094] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:39.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:20:0) after 1m0s
[08:46:39.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:20:0)
[08:46:39.114] Timer tick, asking Buildbucket for the build status
[08:46:39.247] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:39.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:21:0) after 1m0s
[08:47:39.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:21:0)
[08:47:39.266] Timer tick, asking Buildbucket for the build status
[08:47:39.339] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:39.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:22:0) after 1m0s
[08:48:39.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:22:0)
[08:48:39.403] Timer tick, asking Buildbucket for the build status
[08:48:39.466] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:39.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:23:0) after 1m0s
[08:49:39.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:23:0)
[08:49:39.545] Timer tick, asking Buildbucket for the build status
[08:49:39.717] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:24:0) after 1m0s
[08:50:39.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:24:0)
[08:50:39.822] Timer tick, asking Buildbucket for the build status
[08:50:40.047] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:40.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:25:0) after 1m0s
[08:51:40.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:25:0)
[08:51:40.066] Timer tick, asking Buildbucket for the build status
[08:51:40.496] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:40.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:26:0) after 1m0s
[08:52:40.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:26:0)
[08:52:40.542] Timer tick, asking Buildbucket for the build status
[08:52:40.609] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:40.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:27:0) after 1m0s
[08:53:40.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:27:0)
[08:53:40.703] Timer tick, asking Buildbucket for the build status
[08:53:41.059] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:41.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:28:0) after 1m0s
[08:54:41.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:28:0)
[08:54:41.112] Timer tick, asking Buildbucket for the build status
[08:54:41.534] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:41.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:29:0) after 1m0s
[08:55:41.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:29:0)
[08:55:41.552] Timer tick, asking Buildbucket for the build status
[08:55:41.604] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:41.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:30:0) after 1m0s
[08:56:41.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:30:0)
[08:56:41.636] Timer tick, asking Buildbucket for the build status
[08:56:41.696] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:41.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:31:0) after 1m0s
[08:57:41.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:31:0)
[08:57:41.795] Timer tick, asking Buildbucket for the build status
[08:57:41.887] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:41.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:32:0) after 1m0s
[08:58:41.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:32:0)
[08:58:41.861] Timer tick, asking Buildbucket for the build status
[08:58:41.939] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:41.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:33:0) after 1m0s
[08:59:41.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:33:0)
[08:59:41.963] Timer tick, asking Buildbucket for the build status
[08:59:42.091] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:42.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:34:0) after 1m0s
[09:00:42.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:34:0)
[09:00:42.143] Timer tick, asking Buildbucket for the build status
[09:00:42.220] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:42.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:35:0) after 1m0s
[09:01:42.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:35:0)
[09:01:42.225] Timer tick, asking Buildbucket for the build status
[09:01:42.319] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:42.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:36:0) after 1m0s
[09:02:42.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:36:0)
[09:02:42.369] Timer tick, asking Buildbucket for the build status
[09:02:42.430] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:42.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:37:0) after 1m0s
[09:03:42.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:37:0)
[09:03:42.509] Timer tick, asking Buildbucket for the build status
[09:03:42.836] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:42.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:38:0) after 1m0s
[09:04:42.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:38:0)
[09:04:42.903] Timer tick, asking Buildbucket for the build status
[09:04:42.971] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:42.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:39:0) after 1m0s
[09:05:43.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:39:0)
[09:05:43.029] Timer tick, asking Buildbucket for the build status
[09:05:43.134] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:43.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:40:0) after 1m0s
[09:06:43.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:40:0)
[09:06:43.213] Timer tick, asking Buildbucket for the build status
[09:06:43.306] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:43.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:41:0) after 1m0s
[09:07:43.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:41:0)
[09:07:43.438] Timer tick, asking Buildbucket for the build status
[09:07:43.501] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:43.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:42:0) after 1m0s
[09:08:43.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:42:0)
[09:08:43.524] Timer tick, asking Buildbucket for the build status
[09:08:43.613] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:43.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:43:0) after 1m0s
[09:09:43.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:43:0)
[09:09:43.631] Timer tick, asking Buildbucket for the build status
[09:09:43.724] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:43.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:44:0) after 1m0s
[09:10:43.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:44:0)
[09:10:43.709] Timer tick, asking Buildbucket for the build status
[09:10:43.820] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:43.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:45:0) after 1m0s
[09:11:43.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:45:0)
[09:11:43.846] Timer tick, asking Buildbucket for the build status
[09:11:43.917] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:43.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:46:0) after 1m0s
[09:12:43.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:46:0)
[09:12:43.935] Timer tick, asking Buildbucket for the build status
[09:12:44.010] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:44.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:47:0) after 1m0s
[09:13:44.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:47:0)
[09:13:44.061] Timer tick, asking Buildbucket for the build status
[09:13:44.189] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:44.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:48:0) after 1m0s
[09:14:44.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:48:0)
[09:14:44.208] Timer tick, asking Buildbucket for the build status
[09:14:44.271] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:44.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:49:0) after 1m0s
[09:15:44.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:49:0)
[09:15:44.304] Timer tick, asking Buildbucket for the build status
[09:15:44.376] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:50:0) after 1m0s
[09:16:44.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:50:0)
[09:16:44.428] Timer tick, asking Buildbucket for the build status
[09:16:44.808] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:51:0) after 1m0s
[09:17:44.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:51:0)
[09:17:44.859] Timer tick, asking Buildbucket for the build status
[09:17:45.324] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:52:0) after 1m0s
[09:18:45.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:52:0)
[09:18:45.347] Timer tick, asking Buildbucket for the build status
[09:18:45.519] Build 8860952173417175904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:45.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026382235428942624:53:0) after 1m0s
[09:19:19.499] Received PubSub notification, asking Buildbucket for the build status
[09:19:19.583] Build 8860952173417175904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:19:19.583] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607937558806466",
"created_by": "project:chromium",
"created_ts": "1607934515515665",
"id": "8860952173417175904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f889d40b46bdff902a72eb44bdfb4a5f61f646d\"}}",
"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\": \"7f889d40b46bdff902a72eb44bdfb4a5f61f646d\", \"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-east1-d-8-37-rr94\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178629, \"got_angle_revision\": \"282fb4092b6c17fff7b91ec814c2be527788ecb1\", \"got_dawn_revision\": \"fb6c21547e6c5bc2053c15169769397e6584c9d2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"7f889d40b46bdff902a72eb44bdfb4a5f61f646d\", \"got_revision_cp\": \"refs/heads/master@{#836550}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"afdda12d2c531c8d2064d5f9062d2c0c23f63e33\", \"got_v8_revision_cp\": \"refs/heads/8.9.145@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"7f889d40b46bdff902a72eb44bdfb4a5f61f646d\", \"swarm_hashes_refs/heads/master(at){#836550}_without_patch\": {\"absl_hardening_tests\": \"27443f236c895fbd631749ba2e925460823b65a8\", \"accessibility_unittests\": \"5ac05b00f4f48522821b42e7d075085b6e46219a\", \"angle_unittests\": \"62ae1b1dc6d3cf9e8b531e64dc90b9d647b8525c\", \"app_shell_unittests\": \"65519eab860eb05933842449c2b8136d81ef302c\", \"aura_unittests\": \"582b11c98814f5a6eca14023ae40c53e8f3c493b\", \"base_unittests\": \"e7871ee52d61d4198ecf6820f2487c263b2f162c\", \"base_util_unittests\": \"5c67df80b8c70708908faa22e1edfdfe9a0bd92e\", \"blink_common_unittests\": \"e49ef4d14b1831f7d73dc39d50df0d545b3bf552\", \"blink_fuzzer_unittests\": \"103a325aafa97cdd81b502a5406c0297b6fcb0df\", \"blink_heap_unittests\": \"ab5ca2ab49abafb0e73c04a775fc61357352d63d\", \"blink_platform_unittests\": \"b47ae3755142641ff403301ff8189c5eea24ab7a\", \"blink_python_tests\": \"b26e73f05d1dc51b0ec658adf2fb990601fa58a9\", \"blink_unittests\": \"fc1f2ee972756173eda4aebe8ca2cca8677bc36a\", \"blink_web_tests\": \"e58d42a8cd9b18b5171eddc7608a8329e46fdc33\", \"boringssl_crypto_tests\": \"a9b3de46951a25b191a0ab984d0b8d5ba7de2639\", \"boringssl_ssl_tests\": \"009e0a253390cf3ba17cdcb130f99dc6c9473e89\", \"browser_tests\": \"f31f630135576c5e5e0ba31107fa8534434faf4b\", \"capture_unittests\": \"6ce968f0bb9d9deda5c12bb632bf268cd10807c5\", \"cast_unittests\": \"7680d5339291f1b747c88e0f068db995f736551d\", \"cc_unittests\": \"aeeafa436304a9da7d30c9f2370d615116dd3419\", \"chrome_app_unittests\": \"4120a0ec848126c7155af16033c4d9b15a558c64\", \"chromedriver_unittests\": \"f3022d4d547694cbec14e41b347b1476585677a3\", \"components_browsertests\": \"63fba80c97abbb12ba49922b421d3a0bc2c8ca4c\", \"components_unittests\": \"9cbf6e29eb2930df017b92fbe1a5e1abdf31af30\", \"compositor_unittests\": \"3848e77f60be002f48e1682dccb5a6e6062c96f7\", \"content_browsertests\": \"2c3342bcc123f47ccb2c7522ce785c2db785f484\", \"content_shell_crash_test\": \"cd6be788d3d5cba379eeee51279f81086350ff28\", \"content_unittests\": \"4b295150dc9e23162d08eba330e491dc80778fe6\", \"crashpad_tests\": \"89e6deeb111215fab49f2a0a277088d388552113\", \"cronet_tests\": \"46becee7576be85c654badce908c3774e3021019\", \"cronet_unittests\": \"8c02ed25a4d702a057b85488b38ac75369ace958\", \"crypto_unittests\": \"f17336894289338ecde80bc0403ef9e96853b4ca\", \"dbus_unittests\": \"c32d982f6618df8507e20981992fcd50b3edafdf\", \"device_unittests\": \"b9b5acdd325e38bd666fd2aebccae6159e6c0249\", \"display_unittests\": \"2259d2c47d6ac903b5b7d47f873933c6f85359e3\", \"events_unittests\": \"ac171b35d43a53c5b0c4d150f1fb16488be60266\", \"extension_docserver_python_unittests\": \"404be256be1db12aac786517b7902cbf3b17dfe7\", \"extensions_browsertests\": \"51815f2cabbe69bdb70285cc49d5fa447f8c5ed8\", \"extensions_unittests\": \"d7db8c6573f9b9ba96db5494d748c0245b792cea\", \"filesystem_service_unittests\": \"ac63149473236af4cd80e38c5af9313726545372\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"b54b9a4cc492b6b5c08d85858e1cbb975e20670d\", \"gfx_unittests\": \"3653e06100688120a41c52051719e3508bad9926\", \"gin_unittests\": \"e75e40d2502380863603a00c9522388ca4c09822\", \"google_apis_unittests\": \"cb94571d8f688d5254e1ca14f882489a15827e79\", \"gpu_unittests\": \"7d8a035555e58753c6e67942ace7cc882731d44d\", \"grit_python_unittests\": \"4240fd59c31e9646d2ab4fe1082f5d79a3314641\", \"gwp_asan_unittests\": \"0af3a74b7ce66317a701e99a2ed8e6b10d6d7492\", \"headless_browsertests\": \"37adc1563fbc4ccf705c69594ffd2de7f65bac21\", \"headless_unittests\": \"0208ef6b3e99e9b96c0c9d74f0ba8b0630e4df75\", \"interactive_ui_tests\": \"b24259648a4d68224b39429ea80c7f37ff5d99e1\", \"ipc_tests\": \"7d47d4bb4b73d2e3a0d2e81461671b1a18f79f33\", \"jingle_unittests\": \"8362dd4dacd31a3ba770488ae26eb1cfb8abcf8e\", \"latency_unittests\": \"1462268b84796d6c6e28924e4a52ab65537daac9\", \"libjingle_xmpp_unittests\": \"3bde0b29f143c52ca7cf7ff86c36a646d283c457\", \"liburlpattern_unittests\": \"509a24e50df7009b3f39f4687924e14637b5a4f2\", \"media_blink_unittests\": \"194bdd89ebd8e9a3b52017099edf60e3600a4042\", \"media_unittests\": \"df284508dbc88c99bbca29bea075348e10fbcb0f\", \"message_center_unittests\": \"a30f769e4264bd30728ae66c65cf8042f7f9a4d8\", \"metrics_python_tests\": \"ad20c4ff91a5393c1356f48885f017659f022e37\", \"midi_unittests\": \"b489d508e010d7502a35cfc0028ebf3e30b0f3a4\", \"mojo_core_unittests\": \"66aa01b9e14259f434bd38f3445a624538f060f0\", \"mojo_unittests\": \"315549e91c47672c42cd1dd20935a147c45baae0\", \"nacl_helper_nonsfi_unittests\": \"50e85151be410c4c06a617bdcb96967ba8b84d8f\", \"nacl_loader_unittests\": \"9e6327f85edef517e20e5e59605dfbbf095e8c52\", \"native_theme_unittests\": \"529d147ad5c548f439b31c6d1991f77308e80944\", \"net_unittests\": \"0fea0d15c3132210b49e3f71bc3d448513de039c\", \"openscreen_unittests\": \"7089229aee319c1eecf079dfa0bfd9fca9b41541\", \"pdf_unittests\": \"d4c82494a351319a966875ec033a298b8203fcf6\", \"perfetto_unittests\": \"5896a3660d71bab0e6976939715fda7c12086cf6\", \"ppapi_unittests\": \"86edc3e7606e3ad78df7ce74ab18bef73ce96826\", \"printing_unittests\": \"a7a6b3fec281328409733f9c30a43822f6f93836\", \"remoting_unittests\": \"f0d37f2776fde04b92427870c00bb24ff3cbccc1\", \"sandbox_linux_unittests\": \"cdbf26c904e604375121958bb9873401431eaf51\", \"service_manager_unittests\": \"78cc156d138b415c271c83893f61fd6411bad809\", \"services_unittests\": \"b930696ffde56033b159a6c510857786d853af0c\", \"shell_dialogs_unittests\": \"671893769825b9a2a1f62cb87e4f01f72214b9a6\", \"skia_unittests\": \"abfe99915434bf7caaaa95b26780fcf3f2444f82\", \"snapshot_unittests\": \"0c7e037b50b1432ab6cbdedd31c57d8b47228b31\", \"sql_unittests\": \"dd2c9607fa4414d0aaa1e9e51687b1ecc9a2fd5e\", \"storage_unittests\": \"40eeb6232562ab180fd8ae0be6f9e73e54e96405\", \"sync_integration_tests\": \"0b7128fe2b89e4529d113880c319790f43f775e0\", \"telemetry_gpu_unittests\": \"3bca9b458ea2f664cdf8c43985ba4796e4687d76\", \"telemetry_perf_unittests\": \"cae57c3bd108de8d859bc3ad08c397476899c5d5\", \"telemetry_unittests\": \"8155b32d01cc8f7e3b399cd175980af0fc486eb8\", \"traffic_annotation_auditor_unittests\": \"a795a8da233069cd5d98eeac2e2e08641a6d45a7\", \"ui_base_unittests\": \"6100c293fed3a29d2ee27282cee1156a1aab5cf8\", \"ui_touch_selection_unittests\": \"7029623667fedbc1503bb5126d740accbeedbe44\", \"unit_tests\": \"41ede870bd380665beeb1779f6cb44ff5a6372ca\", \"url_unittests\": \"6b96b05d2203b61783b14012d50b138d8e67c6e2\", \"views_perftests\": \"612bb50e2579c32fb3ae96fe7221fb8ac9ed82c6\", \"views_unittests\": \"55db43f5909f426d20e9a90dff8cfa4da8e8b374\", \"viz_unittests\": \"3393281537bfce93f1225115ef6b1f213f9bead8\", \"vr_common_unittests\": \"28ea876132f060a3aaeffa0da4bf58faab922081\", \"vr_pixeltests\": \"2c03b532f06d5e39a09d9a2c2c6c47cc099b8110\", \"webdriver_wpt_tests\": \"59b319c79343bff2ebe23e8c0783024e8529191f\", \"weblayer_browsertests\": \"52e4ccfdc90cfe52a26fd1d8ca18c111d62cfa8e\", \"weblayer_unittests\": \"55ef7a475d8afaad63a4648ebef6fdbe1baa0e19\", \"wm_unittests\": \"aebf8f03fe9c714eb5929d48d1c40cd0aa38e926\", \"wtf_unittests\": \"d27774a7651971c6fd86a73afb38c476648af4cf\", \"x11_unittests\": \"c432cf051fe1af00a76fee758c22197a03b97d47\", \"xr_browser_tests\": \"13a49e06432cc8c36ee5dbf710c8f74320acbbb0\", \"zlib_unittests\": \"151c0047c527b7c0907a934cb4af023db7016ffc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0111b226b6a2e1a66cbbf5d93fde4367495bc99d98428795ba3e931083c57f27_v2\", \"builder_0e4559ffd6169ab721e778dfe83867ca08424e9b4d480f5c0e6f91286240fc3f_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_541cf43b1bca5745fae9eb808cc6f212921580c436c428e330e275f831e0e73a_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_cb8f28a5d59bb80cbafed89b56af03ba2ea85f5e24941631d330b6bd1d886cb5_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-east1-d-8-37-rr94\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607934518376090",
"status": "COMPLETED",
"status_changed_ts": "1607937559078634",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178629",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7f889d40b46bdff902a72eb44bdfb4a5f61f646d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f889d40b46bdff902a72eb44bdfb4a5f61f646d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026382235428942624",
"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/8860952173417175904/+/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:50792f23e7239210",
"user_agent:luci-scheduler"
],
"updated_ts": "1607937559085330",
"url": "https://ci.chromium.org/b/8860952173417175904",
"utcnow_ts": "1607937559575280"
}
}
[09:19:19.583] Invocation finished in 50m45.37085644s with status SUCCEEDED