[00:37:49.557] New invocation is queued and will start shortly
[00:37:50.795] Starting the invocation (attempt 1)
[00:37:50.867] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:37:50.867] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:37:50.867] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020341855364564592",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"97dbd59ea6622d61e599148663402d7759a2df23\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020341855364564592",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/97dbd59ea6622d61e599148663402d7759a2df23",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97dbd59ea6622d61e599148663402d7759a2df23",
"gitiles_ref:refs/heads/master"
]
}
[00:37:53.021] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613695071093819",
"id": "8854911793092328720",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97dbd59ea6622d61e599148663402d7759a2df23\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613695072551500",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45543",
"builder:linux-chromeos-rel",
"buildset:commit/git/97dbd59ea6622d61e599148663402d7759a2df23",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97dbd59ea6622d61e599148663402d7759a2df23",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020341855364564592",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854911793092328720/+/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": "1613695072551820",
"url": "https://ci.chromium.org/b/8854911793092328720",
"utcnow_ts": "1613695073007513"
}
}
[00:37:53.021] Task URL: https://ci.chromium.org/b/8854911793092328720
[00:37:53.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:2:0) after 1m0s
[00:37:56.773] Received PubSub notification, asking Buildbucket for the build status
[00:37:59.318] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:53.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:2:0)
[00:38:53.066] Timer tick, asking Buildbucket for the build status
[00:38:53.136] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:53.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:4:0) after 1m0s
[00:39:53.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:4:0)
[00:39:53.156] Timer tick, asking Buildbucket for the build status
[00:39:53.312] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:53.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:5:0) after 1m0s
[00:40:53.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:5:0)
[00:40:53.327] Timer tick, asking Buildbucket for the build status
[00:40:53.601] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:53.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:6:0) after 1m0s
[00:41:53.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:6:0)
[00:41:53.622] Timer tick, asking Buildbucket for the build status
[00:41:53.693] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:53.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:7:0) after 1m0s
[00:42:53.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:7:0)
[00:42:53.751] Timer tick, asking Buildbucket for the build status
[00:42:54.024] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:54.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:8:0) after 1m0s
[00:43:54.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:8:0)
[00:43:54.077] Timer tick, asking Buildbucket for the build status
[00:43:54.142] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:54.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:9:0) after 1m0s
[00:44:54.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:9:0)
[00:44:54.190] Timer tick, asking Buildbucket for the build status
[00:44:54.267] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:54.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:10:0) after 1m0s
[00:45:54.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:10:0)
[00:45:54.370] Timer tick, asking Buildbucket for the build status
[00:45:54.487] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:54.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:11:0) after 1m0s
[00:46:54.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:11:0)
[00:46:54.516] Timer tick, asking Buildbucket for the build status
[00:46:54.591] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:54.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:12:0) after 1m0s
[00:47:54.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:12:0)
[00:47:54.657] Timer tick, asking Buildbucket for the build status
[00:47:54.751] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:54.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:13:0) after 1m0s
[00:48:54.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:13:0)
[00:48:54.801] Timer tick, asking Buildbucket for the build status
[00:48:54.874] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:54.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:14:0) after 1m0s
[00:49:55.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:14:0)
[00:49:55.012] Timer tick, asking Buildbucket for the build status
[00:49:55.099] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:55.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:15:0) after 1m0s
[00:50:55.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:15:0)
[00:50:55.165] Timer tick, asking Buildbucket for the build status
[00:50:55.228] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:55.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:16:0) after 1m0s
[00:51:55.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:16:0)
[00:51:55.289] Timer tick, asking Buildbucket for the build status
[00:51:55.606] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:55.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:17:0) after 1m0s
[00:52:55.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:17:0)
[00:52:55.646] Timer tick, asking Buildbucket for the build status
[00:52:55.787] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:55.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:18:0) after 1m0s
[00:53:56.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:18:0)
[00:53:56.643] Timer tick, asking Buildbucket for the build status
[00:53:56.711] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:56.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:19:0) after 1m0s
[00:54:56.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:19:0)
[00:54:56.979] Timer tick, asking Buildbucket for the build status
[00:54:57.060] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:57.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:20:0) after 1m0s
[00:55:57.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:20:0)
[00:55:57.232] Timer tick, asking Buildbucket for the build status
[00:55:57.347] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:57.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:21:0) after 1m0s
[00:56:57.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:21:0)
[00:56:57.527] Timer tick, asking Buildbucket for the build status
[00:56:57.602] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:57.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:22:0) after 1m0s
[00:57:57.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:22:0)
[00:57:57.786] Timer tick, asking Buildbucket for the build status
[00:57:57.881] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:57.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:23:0) after 1m0s
[00:58:57.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:23:0)
[00:58:57.998] Timer tick, asking Buildbucket for the build status
[00:58:58.079] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:58.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:24:0) after 1m0s
[00:59:58.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:24:0)
[00:59:58.151] Timer tick, asking Buildbucket for the build status
[00:59:58.248] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:58.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:25:0) after 1m0s
[01:00:58.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:25:0)
[01:00:58.250] Timer tick, asking Buildbucket for the build status
[01:00:58.340] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:58.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:26:0) after 1m0s
[01:01:58.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:26:0)
[01:01:58.417] Timer tick, asking Buildbucket for the build status
[01:01:58.481] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:58.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:27:0) after 1m0s
[01:02:58.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:27:0)
[01:02:58.619] Timer tick, asking Buildbucket for the build status
[01:02:58.791] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:58.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:28:0) after 1m0s
[01:03:58.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:28:0)
[01:03:58.866] Timer tick, asking Buildbucket for the build status
[01:03:58.954] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:58.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:29:0) after 1m0s
[01:04:59.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:29:0)
[01:04:59.057] Timer tick, asking Buildbucket for the build status
[01:04:59.374] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:59.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:30:0) after 1m0s
[01:05:59.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:30:0)
[01:05:59.406] Timer tick, asking Buildbucket for the build status
[01:05:59.496] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:59.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:31:0) after 1m0s
[01:06:59.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:31:0)
[01:06:59.469] Timer tick, asking Buildbucket for the build status
[01:06:59.599] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:59.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:32:0) after 1m0s
[01:07:59.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:32:0)
[01:07:59.616] Timer tick, asking Buildbucket for the build status
[01:08:02.077] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:02.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:33:0) after 1m0s
[01:09:02.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:33:0)
[01:09:02.177] Timer tick, asking Buildbucket for the build status
[01:09:02.402] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:02.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:34:0) after 1m0s
[01:10:02.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:34:0)
[01:10:02.514] Timer tick, asking Buildbucket for the build status
[01:10:02.817] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:02.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:35:0) after 1m0s
[01:11:02.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:35:0)
[01:11:02.924] Timer tick, asking Buildbucket for the build status
[01:11:03.021] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:03.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:36:0) after 1m0s
[01:12:03.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:36:0)
[01:12:03.065] Timer tick, asking Buildbucket for the build status
[01:12:03.143] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:03.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:37:0) after 1m0s
[01:13:03.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:37:0)
[01:13:03.168] Timer tick, asking Buildbucket for the build status
[01:13:03.544] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:03.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:38:0) after 1m0s
[01:14:03.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:38:0)
[01:14:03.605] Timer tick, asking Buildbucket for the build status
[01:14:03.898] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:03.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:39:0) after 1m0s
[01:15:03.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:39:0)
[01:15:03.988] Timer tick, asking Buildbucket for the build status
[01:15:04.105] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:04.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:40:0) after 1m0s
[01:16:04.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:40:0)
[01:16:04.253] Timer tick, asking Buildbucket for the build status
[01:16:04.336] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:04.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:41:0) after 1m0s
[01:17:04.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:41:0)
[01:17:04.338] Timer tick, asking Buildbucket for the build status
[01:17:04.439] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:04.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:42:0) after 1m0s
[01:18:04.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:42:0)
[01:18:04.463] Timer tick, asking Buildbucket for the build status
[01:18:04.603] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:04.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:43:0) after 1m0s
[01:19:04.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:43:0)
[01:19:04.673] Timer tick, asking Buildbucket for the build status
[01:19:04.761] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:04.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:44:0) after 1m0s
[01:20:04.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:44:0)
[01:20:04.815] Timer tick, asking Buildbucket for the build status
[01:20:04.903] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:04.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:45:0) after 1m0s
[01:21:05.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:45:0)
[01:21:05.159] Timer tick, asking Buildbucket for the build status
[01:21:05.506] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:05.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:46:0) after 1m0s
[01:22:05.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:46:0)
[01:22:05.609] Timer tick, asking Buildbucket for the build status
[01:22:05.687] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:05.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:47:0) after 1m0s
[01:23:05.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:47:0)
[01:23:05.753] Timer tick, asking Buildbucket for the build status
[01:23:05.861] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:05.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:48:0) after 1m0s
[01:24:05.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:48:0)
[01:24:05.971] Timer tick, asking Buildbucket for the build status
[01:24:06.512] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:06.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:49:0) after 1m0s
[01:25:06.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:49:0)
[01:25:06.570] Timer tick, asking Buildbucket for the build status
[01:25:06.670] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:06.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:50:0) after 1m0s
[01:26:06.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:50:0)
[01:26:06.666] Timer tick, asking Buildbucket for the build status
[01:26:06.750] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:06.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:51:0) after 1m0s
[01:27:06.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:51:0)
[01:27:06.933] Timer tick, asking Buildbucket for the build status
[01:27:07.519] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:07.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:52:0) after 1m0s
[01:28:07.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:52:0)
[01:28:07.612] Timer tick, asking Buildbucket for the build status
[01:28:07.818] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:07.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:53:0) after 1m0s
[01:29:08.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:53:0)
[01:29:08.248] Timer tick, asking Buildbucket for the build status
[01:29:08.350] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:08.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:54:0) after 1m0s
[01:30:08.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:54:0)
[01:30:08.527] Timer tick, asking Buildbucket for the build status
[01:30:08.619] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:08.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:55:0) after 1m0s
[01:31:08.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:55:0)
[01:31:08.711] Timer tick, asking Buildbucket for the build status
[01:31:08.824] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:08.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:56:0) after 1m0s
[01:32:08.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:56:0)
[01:32:08.989] Timer tick, asking Buildbucket for the build status
[01:32:09.069] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:09.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:57:0) after 1m0s
[01:33:09.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:57:0)
[01:33:09.153] Timer tick, asking Buildbucket for the build status
[01:33:09.843] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:09.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:58:0) after 1m0s
[01:34:09.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:58:0)
[01:34:09.859] Timer tick, asking Buildbucket for the build status
[01:34:10.112] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:10.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:59:0) after 1m0s
[01:35:10.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:59:0)
[01:35:10.166] Timer tick, asking Buildbucket for the build status
[01:35:10.275] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:10.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:60:0) after 1m0s
[01:36:10.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:60:0)
[01:36:10.325] Timer tick, asking Buildbucket for the build status
[01:36:10.660] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:10.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:61:0) after 1m0s
[01:37:10.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:61:0)
[01:37:10.805] Timer tick, asking Buildbucket for the build status
[01:37:10.888] Build 8854911793092328720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:10.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020341855364564592:62:0) after 1m0s
[01:37:56.451] Received PubSub notification, asking Buildbucket for the build status
[01:37:56.552] Build 8854911793092328720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:37:56.552] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613698675088417",
"created_by": "project:chromium",
"created_ts": "1613695071093819",
"id": "8854911793092328720",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97dbd59ea6622d61e599148663402d7759a2df23\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"97dbd59ea6622d61e599148663402d7759a2df23\", \"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-58-wfny\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45543, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"97dbd59ea6622d61e599148663402d7759a2df23\", \"got_revision_cp\": \"refs/heads/master@{#855549}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97dbd59ea6622d61e599148663402d7759a2df23\", \"swarm_hashes_refs/heads/master(at){#855549}_without_patch\": {\"absl_hardening_tests\": \"b2fb8b042f707bb51474d1741f5e6b5ee0687a3f\", \"accessibility_unittests\": \"e25e21bd3bda3a98c41f83a497ac193d54df01c7\", \"angle_unittests\": \"e74eba617b2bdf07a5a1815e0dde52f4f49af159\", \"app_list_unittests\": \"626211ddf1f05db7c391ec52f5d8328e87f00b31\", \"app_shell_unittests\": \"5ebf5affe11bc3838009e84efd355eed1bf8bc84\", \"ash_unittests\": \"f21c8769b33559d12aca4de8c67f2ba956cfdc24\", \"aura_unittests\": \"90930443fc055aeb5fc3229d53d46a9dd36659b4\", \"base_unittests\": \"3c0d9d22a67c36fb6c0bfdbe6778eb049f4346ba\", \"base_util_unittests\": \"53a421a772d7fec551908257c7b1a958d495d818\", \"blink_common_unittests\": \"b4d238184f04b7ef90b9d7385207fd511f1ff6c9\", \"blink_fuzzer_unittests\": \"88e1359d28ab9e105706daac384fcea5363d2e2e\", \"blink_heap_unittests\": \"be34e41aa9ee3ba6fa2ff3c50a7d68ba42c467e4\", \"blink_platform_unittests\": \"48005b374f7b5171c0c5706ad45e4ab11ce6d2be\", \"blink_unittests\": \"df506dc916e1bc286c10c92ca3be4200e74a0d24\", \"boringssl_crypto_tests\": \"1721140601ff00f2d6d7a574339be26be13ac41a\", \"boringssl_ssl_tests\": \"22afef7bfb5a25f9f53f761dfdae699abe96113e\", \"browser_tests\": \"dd4e290f0237511ad7719213729a8f5dfa3887f0\", \"capture_unittests\": \"2f755c59e0b04da26bee13975de924856221a7d0\", \"cast_unittests\": \"23466c4261f72ac6cb4d9df2134180b68289a0c2\", \"cc_unittests\": \"f35a253bca3bd9f0acade22bfa768605c98fc744\", \"chrome_app_unittests\": \"426735a90c54dc7c40ab35da4d9e70c93b2859fd\", \"chromedriver_unittests\": \"57d58f024d4e8a4933bd809e33e75a42e0a384b5\", \"chromeos_components_unittests\": \"176a805eec2b35b375a8502549522d7577f71cec\", \"chromeos_unittests\": \"b22e10e5230a4986d3b1833f1aae004949c5969f\", \"components_browsertests\": \"1315832a38fb9d8d6966615f0fb076ea39b1bfe4\", \"components_unittests\": \"17369bcd32e62aad7c818470e5aa98d956026453\", \"compositor_unittests\": \"f7dd87327c50c101f7ab583a9682d73f7711e548\", \"content_browsertests\": \"280cf4e0f82caca07a96a9e37160444142b2ec33\", \"content_unittests\": \"36e502eb07344278adce5bdf5494546480e90201\", \"crashpad_tests\": \"8a0a86fbce4311ef8e8d8c0b9618e9cbffb79153\", \"crypto_unittests\": \"d7553c85039b54060b4b1e4c466c213c4d140f4f\", \"dbus_unittests\": \"41c15d4cc27ed08f2e4a0b5166dd4e5d33849e92\", \"device_unittests\": \"fd9a21db18a82c18bb50326fd7800c1c2f46c1ef\", \"display_unittests\": \"a34eb6ab6d22c04b812ea805a0b8bb725ddb79a4\", \"events_unittests\": \"dd53b33ee43be77c708f45851183c55ebbbc19bf\", \"exo_unittests\": \"3a6395cef78ff245daf0eaf819cdda2ccd3231ac\", \"extensions_browsertests\": \"69eb41347dde62f02dde6311099f7644f1cd34e0\", \"extensions_unittests\": \"a2254efa5608a68d81a43dfd9fbb20b4b4b55d8c\", \"filesystem_service_unittests\": \"d8b8e22b947d2b8582058460c101c927ba225ecb\", \"gcm_unit_tests\": \"218ea39656aec7d0afab9b42d7b58f93435eb592\", \"gfx_unittests\": \"25ef8127144b5c34cd76f36aeab61172df1433aa\", \"gin_unittests\": \"2dab2f1964df0aa91e8b0bc0ce5ad31ba9dcdbed\", \"gl_unittests_ozone\": \"a34a8303e6515735822edfc7d128c983ac2e7e19\", \"google_apis_unittests\": \"369a8fa166d0965ccba7e7c04e56f27db22c18dd\", \"gpu_unittests\": \"03bafa32515e110f91dab65195fca2ec03f3ccef\", \"gwp_asan_unittests\": \"53b5c9af7019abfdabb448677b42ab1639f71b9d\", \"interactive_ui_tests\": \"2b7fbe437a6b6089efc57fb0e3459c28251ef90b\", \"ipc_tests\": \"b223f1ec230bc9b09c2ca81203fe4349f39bf359\", \"jingle_unittests\": \"9c941317f60ec3e165ec31da425b25936fe08f26\", \"keyboard_unittests\": \"9906f48fd3cb5f8d85b39f4dea52a3983b799028\", \"latency_unittests\": \"afddb314bd0dbe3c29f4982c4e3664388f1ec513\", \"libjingle_xmpp_unittests\": \"5589d0fd45ad97a21be32fc357b3798907539770\", \"liburlpattern_unittests\": \"19c733d8e29e4f0140cc1cfcf3bb8916b2e89c06\", \"media_blink_unittests\": \"c4e37bddc6734099a4249639b70867783f721e3a\", \"media_unittests\": \"6b75b706909bfcdca1e9f1ba01494e183974770f\", \"message_center_unittests\": \"5b39b698129b86e73e2a6d386207ecfb65667b00\", \"midi_unittests\": \"ee91ee38a98b042b1f8c29d297b58a49ef385ddf\", \"mojo_core_unittests\": \"e03c5e9bad98e453d02835420fccb8c03a391ebb\", \"mojo_unittests\": \"056b71f015bbe395cf5d350aa8f68b66d2f8209e\", \"nacl_helper_nonsfi_unittests\": \"a66c5b2248ae0887839448c3c9dc328e759b9565\", \"nacl_loader_unittests\": \"6d28f4419351ec9fef954ff77896cbc0d87e8897\", \"native_theme_unittests\": \"0c41108495309cf0ed525e6baf9ad0af8a1006b1\", \"net_unittests\": \"bc84da144b138308c95befa41a7ac8876c3df79f\", \"ozone_gl_unittests\": \"98588c6e2aa3cc290dd101dbe2d93c85afb38723\", \"ozone_unittests\": \"2c37c1d76331855950890052457ad8557240709a\", \"ozone_x11_unittests\": \"caa7bdf4aa983f911d5af0afc058edfa8cda41f1\", \"pdf_unittests\": \"b15a7a579799b5570820088d7c7e7ea201f34ed2\", \"perfetto_unittests\": \"9e2e940ea5c820bb29e6201dec60f395bf72b6f5\", \"ppapi_unittests\": \"cbd771d369e736c1f7439ec2b2e8ae00d81e6a5f\", \"printing_unittests\": \"b0e79b782253e4fd5eeedd10b166a2df7568392a\", \"remoting_unittests\": \"2243ca27068f4467d76baa5bf6300212ccdd6aa7\", \"sandbox_linux_unittests\": \"d976c9c164a8e3fcbe859d08d9a2f8c364456b08\", \"service_manager_unittests\": \"bb2e03e5c6d38a5ac8c13ac58009e8d8983d5e63\", \"services_unittests\": \"766d9fecff6d2b9f0e48b05eb165efa406c7726c\", \"shell_dialogs_unittests\": \"91371f007c4180a9569a6b648faac0633a0a1cd2\", \"shell_encryption_unittests\": \"6e71d20b3cedc811e6921d57c885fdae3876f325\", \"skia_unittests\": \"32e6a9b52227282f10f1a6a440841c46cf28e189\", \"snapshot_unittests\": \"70174a1d2ae7374c6c5eadd74edeca94c4b1d880\", \"sql_unittests\": \"0d1c20768b825bf0d0eb76bf38f62c7207ec5e35\", \"storage_unittests\": \"c36e6b3c55b24727b0b5505092332fb3c78bfa9b\", \"sync_integration_tests\": \"cd183e99811fcc44663d8f9cda6ef71d8ce1e772\", \"traffic_annotation_auditor_unittests\": \"d5414b7bbf66ae6096081612f768efc3ea62d319\", \"ui_base_unittests\": \"1f29619711cdf6224eab50adeae711ff34e2dc53\", \"ui_chromeos_unittests\": \"ed880ed7000a7b725a4ddcfb4fc129fb5ba7440c\", \"ui_touch_selection_unittests\": \"be52b41cc4c58673c4eef9c80b6b57a867668356\", \"unit_tests\": \"edbcae019ffe0f8c1b43ec62f32eaaef2e0c325b\", \"url_unittests\": \"be4bf2e9fcdb114e406d2372cc739f0c799b68ff\", \"usage_time_limit_unittests\": \"c8025e7443255103549782e28200ae97f0ec0f48\", \"views_unittests\": \"ceb8962cbc38b1fe7d8dbe121fe11cd6543c11ef\", \"viz_unittests\": \"b11a59f85bea6879d43115c15cee67bb0fd3cd85\", \"wayland_client_perftests\": \"f17277c4e1e501146021e3724fb9578195fdec8d\", \"wm_unittests\": \"5f0331992e9707cf4cfbf0b1a11da9dc92644d3b\", \"wtf_unittests\": \"6c0c4608c0a80c262d083e9c574c5cbbcc492e79\", \"zlib_unittests\": \"6bd97db4bed1dcf34b97da35587572999f1f155e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_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-58-wfny\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613695076100419",
"status": "COMPLETED",
"status_changed_ts": "1613698675668177",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45543",
"builder:linux-chromeos-rel",
"buildset:commit/git/97dbd59ea6622d61e599148663402d7759a2df23",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97dbd59ea6622d61e599148663402d7759a2df23",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020341855364564592",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854911793092328720/+/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:51d08a436d650110",
"user_agent:luci-scheduler"
],
"updated_ts": "1613698675675460",
"url": "https://ci.chromium.org/b/8854911793092328720",
"utcnow_ts": "1613698676540363"
}
}
[01:37:56.552] Invocation finished in 1h0m7.009961575s with status SUCCEEDED