[20:15:38.227] New invocation is queued and will start shortly
[20:15:39.279] Starting the invocation (attempt 1)
[20:15:39.324] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:15:39.324] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:15:39.325] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023076259852460096",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"439d23934634ab8c6cf4c9d3ac6d92f4df80defe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9023076259852460096",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/439d23934634ab8c6cf4c9d3ac6d92f4df80defe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/439d23934634ab8c6cf4c9d3ac6d92f4df80defe",
"gitiles_ref:refs/heads/master"
]
}
[20:15:40.234] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611087339470226",
"id": "8857646197885773760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"439d23934634ab8c6cf4c9d3ac6d92f4df80defe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611087339961022",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44746",
"builder:linux-chromeos-rel",
"buildset:commit/git/439d23934634ab8c6cf4c9d3ac6d92f4df80defe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/439d23934634ab8c6cf4c9d3ac6d92f4df80defe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023076259852460096",
"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/8857646197885773760/+/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": "1611087339961161",
"url": "https://ci.chromium.org/b/8857646197885773760",
"utcnow_ts": "1611087340218148"
}
}
[20:15:40.234] Task URL: https://ci.chromium.org/b/8857646197885773760
[20:15:40.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:2:0) after 1m0s
[20:16:37.990] Received PubSub notification, asking Buildbucket for the build status
[20:16:38.137] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:40.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:2:0)
[20:16:40.293] Timer tick, asking Buildbucket for the build status
[20:16:40.386] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:40.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:4:0) after 1m0s
[20:17:40.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:4:0)
[20:17:40.435] Timer tick, asking Buildbucket for the build status
[20:17:40.575] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:40.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:5:0) after 1m0s
[20:18:40.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:5:0)
[20:18:40.618] Timer tick, asking Buildbucket for the build status
[20:18:40.905] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:40.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:6:0) after 1m0s
[20:19:40.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:6:0)
[20:19:40.961] Timer tick, asking Buildbucket for the build status
[20:19:41.047] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:41.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:7:0) after 1m0s
[20:20:41.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:7:0)
[20:20:41.076] Timer tick, asking Buildbucket for the build status
[20:20:41.405] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:41.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:8:0) after 1m0s
[20:21:41.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:8:0)
[20:21:41.568] Timer tick, asking Buildbucket for the build status
[20:21:41.685] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:41.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:9:0) after 1m0s
[20:22:41.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:9:0)
[20:22:41.706] Timer tick, asking Buildbucket for the build status
[20:22:41.886] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:41.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:10:0) after 1m0s
[20:23:41.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:10:0)
[20:23:41.909] Timer tick, asking Buildbucket for the build status
[20:23:41.959] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:41.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:11:0) after 1m0s
[20:24:42.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:11:0)
[20:24:42.013] Timer tick, asking Buildbucket for the build status
[20:24:42.126] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:42.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:12:0) after 1m0s
[20:25:42.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:12:0)
[20:25:42.116] Timer tick, asking Buildbucket for the build status
[20:25:42.329] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:42.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:13:0) after 1m0s
[20:26:42.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:13:0)
[20:26:42.432] Timer tick, asking Buildbucket for the build status
[20:26:42.502] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:42.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:14:0) after 1m0s
[20:27:42.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:14:0)
[20:27:42.549] Timer tick, asking Buildbucket for the build status
[20:27:42.806] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:42.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:15:0) after 1m0s
[20:28:42.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:15:0)
[20:28:42.854] Timer tick, asking Buildbucket for the build status
[20:28:42.922] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:42.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:16:0) after 1m0s
[20:29:43.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:16:0)
[20:29:43.008] Timer tick, asking Buildbucket for the build status
[20:29:43.073] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:43.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:17:0) after 1m0s
[20:30:43.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:17:0)
[20:30:43.304] Timer tick, asking Buildbucket for the build status
[20:30:43.702] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:43.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:18:0) after 1m0s
[20:31:43.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:18:0)
[20:31:43.739] Timer tick, asking Buildbucket for the build status
[20:31:43.803] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:43.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:19:0) after 1m0s
[20:32:43.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:19:0)
[20:32:43.930] Timer tick, asking Buildbucket for the build status
[20:32:44.222] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:44.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:20:0) after 1m0s
[20:33:44.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:20:0)
[20:33:44.216] Timer tick, asking Buildbucket for the build status
[20:33:44.349] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:44.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:21:0) after 1m0s
[20:34:44.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:21:0)
[20:34:44.431] Timer tick, asking Buildbucket for the build status
[20:34:44.585] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:22:0) after 1m0s
[20:35:44.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:22:0)
[20:35:44.648] Timer tick, asking Buildbucket for the build status
[20:35:44.774] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:44.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:23:0) after 1m0s
[20:36:44.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:23:0)
[20:36:44.839] Timer tick, asking Buildbucket for the build status
[20:36:44.909] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:44.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:24:0) after 1m0s
[20:37:44.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:24:0)
[20:37:44.918] Timer tick, asking Buildbucket for the build status
[20:37:45.154] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:45.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:25:0) after 1m0s
[20:38:45.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:25:0)
[20:38:45.219] Timer tick, asking Buildbucket for the build status
[20:38:45.318] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:45.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:26:0) after 1m0s
[20:39:45.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:26:0)
[20:39:45.388] Timer tick, asking Buildbucket for the build status
[20:39:45.828] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:45.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:27:0) after 1m0s
[20:40:45.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:27:0)
[20:40:45.988] Timer tick, asking Buildbucket for the build status
[20:40:46.115] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:46.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:28:0) after 1m0s
[20:41:46.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:28:0)
[20:41:46.238] Timer tick, asking Buildbucket for the build status
[20:41:46.510] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:29:0) after 1m0s
[20:42:46.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:29:0)
[20:42:46.538] Timer tick, asking Buildbucket for the build status
[20:42:46.642] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:30:0) after 1m0s
[20:43:46.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:30:0)
[20:43:46.912] Timer tick, asking Buildbucket for the build status
[20:43:46.978] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:46.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:31:0) after 1m0s
[20:44:47.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:31:0)
[20:44:47.107] Timer tick, asking Buildbucket for the build status
[20:44:47.180] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:47.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:32:0) after 1m0s
[20:45:47.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:32:0)
[20:45:47.292] Timer tick, asking Buildbucket for the build status
[20:45:47.402] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:47.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:33:0) after 1m0s
[20:46:47.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:33:0)
[20:46:47.503] Timer tick, asking Buildbucket for the build status
[20:46:47.657] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:34:0) after 1m0s
[20:47:47.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:34:0)
[20:47:47.795] Timer tick, asking Buildbucket for the build status
[20:47:47.961] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:35:0) after 1m0s
[20:48:47.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:35:0)
[20:48:47.981] Timer tick, asking Buildbucket for the build status
[20:48:48.153] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:48.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:36:0) after 1m0s
[20:49:48.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:36:0)
[20:49:48.183] Timer tick, asking Buildbucket for the build status
[20:49:48.262] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:48.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:37:0) after 1m0s
[20:50:48.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:37:0)
[20:50:48.293] Timer tick, asking Buildbucket for the build status
[20:50:48.463] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:48.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:38:0) after 1m0s
[20:51:48.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:38:0)
[20:51:48.546] Timer tick, asking Buildbucket for the build status
[20:51:48.676] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:48.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:39:0) after 1m0s
[20:52:48.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:39:0)
[20:52:48.680] Timer tick, asking Buildbucket for the build status
[20:52:49.482] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:49.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:40:0) after 1m0s
[20:53:49.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:40:0)
[20:53:49.504] Timer tick, asking Buildbucket for the build status
[20:53:49.827] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:49.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:41:0) after 1m0s
[20:54:49.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:41:0)
[20:54:49.855] Timer tick, asking Buildbucket for the build status
[20:54:50.272] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:50.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:42:0) after 1m0s
[20:55:50.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:42:0)
[20:55:50.293] Timer tick, asking Buildbucket for the build status
[20:55:50.435] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:50.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:43:0) after 1m0s
[20:56:50.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:43:0)
[20:56:50.460] Timer tick, asking Buildbucket for the build status
[20:56:50.605] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:50.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:44:0) after 1m0s
[20:57:50.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:44:0)
[20:57:50.638] Timer tick, asking Buildbucket for the build status
[20:57:50.798] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:50.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:45:0) after 1m0s
[20:58:50.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:45:0)
[20:58:50.839] Timer tick, asking Buildbucket for the build status
[20:58:51.035] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:51.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:46:0) after 1m0s
[20:59:51.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:46:0)
[20:59:51.098] Timer tick, asking Buildbucket for the build status
[20:59:51.513] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:51.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:47:0) after 1m0s
[21:00:51.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:47:0)
[21:00:51.612] Timer tick, asking Buildbucket for the build status
[21:00:52.455] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:52.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:48:0) after 1m0s
[21:01:52.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:48:0)
[21:01:52.537] Timer tick, asking Buildbucket for the build status
[21:01:52.657] Build 8857646197885773760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023076259852460096:49:0) after 1m0s
[21:02:03.915] Received PubSub notification, asking Buildbucket for the build status
[21:02:04.174] Build 8857646197885773760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:02:04.174] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611090122374943",
"created_by": "project:chromium",
"created_ts": "1611087339470226",
"id": "8857646197885773760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"439d23934634ab8c6cf4c9d3ac6d92f4df80defe\"}}",
"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\": \"439d23934634ab8c6cf4c9d3ac6d92f4df80defe\", \"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-65-yzph\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44746, \"got_angle_revision\": \"b69f54069cbf700a4646817805ca77c0d2a01292\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"439d23934634ab8c6cf4c9d3ac6d92f4df80defe\", \"got_revision_cp\": \"refs/heads/master@{#844862}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"870bd0b9a8bc7aa777926e94b031264fcddca0d1\", \"got_v8_revision_cp\": \"refs/heads/9.0.15@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"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\": \"439d23934634ab8c6cf4c9d3ac6d92f4df80defe\", \"swarm_hashes_refs/heads/master(at){#844862}_without_patch\": {\"absl_hardening_tests\": \"4767f927d898e6fd5b931ab9ba7c7b063651b93c\", \"accessibility_unittests\": \"ee5ef3f82b3f95143d8f032c3839bc61539d855a\", \"angle_unittests\": \"bd202ff555510f9e9fa3c8584e2d3704b5a4d4c3\", \"app_list_unittests\": \"643ddc9d020d2857f40e6ab6e67a61c7857756b6\", \"app_shell_unittests\": \"8cc45fea67839357f986e7b83deeb4120856df83\", \"ash_unittests\": \"635f24284462e9755a61d45d6bd860dcd0f2f3db\", \"aura_unittests\": \"161178f65dbe19c03307cef8e991be9acb92195c\", \"base_unittests\": \"28b0ffc37f9ca3038d5208aa9b00271ea4df660b\", \"base_util_unittests\": \"f997a83cfd9d6aa6af78e38edf59725b845a69d4\", \"blink_common_unittests\": \"65b720070ff0ca1f671e9aa075f0a0828bc9154f\", \"blink_fuzzer_unittests\": \"f7d65998a1e630b6ced14f0ba371f3b999449331\", \"blink_heap_unittests\": \"ac2f28da34aca5f3d4455596ec5cdde258f96c93\", \"blink_platform_unittests\": \"c3a5148ae43a56758a4bafd9192ebf266cf994f8\", \"blink_unittests\": \"f7ef08dbdc7ae26117898f79cc9e4bd43a7682d5\", \"boringssl_crypto_tests\": \"607aeda92f0a65ed54f5277d0014f4c93b429942\", \"boringssl_ssl_tests\": \"e49e5de5a0ccd0e64126f1b02db682ade2596fde\", \"browser_tests\": \"c8b505703c79fd083d0e9bb20309594d44ef8e7b\", \"capture_unittests\": \"c979d7a320f2a226d8dad88bae051ad630116df0\", \"cast_unittests\": \"31b6b195c257d5cf1300b5976f78948d437deff8\", \"cc_unittests\": \"c005f834dd9a424b5c3581295983a3570ce92a8c\", \"chrome_app_unittests\": \"76c5a43633b1f6c5dfba6b788c922e0acaa463cf\", \"chromedriver_unittests\": \"ed9af7159e4eed78b18c7a854aad0259d34659ee\", \"chromeos_components_unittests\": \"6facf17b979ab2fb8c2288f6f21c54b4701e12cb\", \"chromeos_unittests\": \"774fcc6110640191cc4b1f132853c71aad8811ef\", \"components_browsertests\": \"561028df752e325f18fa071df159f8e19742635a\", \"components_unittests\": \"94ae57f36ada6edec4d18bde4a2c2a14ae40a43b\", \"compositor_unittests\": \"fe17aaadc6c38c91ae3e354ac70569a350eedcaf\", \"content_browsertests\": \"d11e1272085321b179bcb344ea77af8634c8c44c\", \"content_unittests\": \"80a95ae6e1552d9095df31a27f2b436a9dcf1a07\", \"crashpad_tests\": \"c8b8f194332e0def8feafb74f1533fc7cc2fcc5d\", \"crypto_unittests\": \"43be19d903c8f56137a631d541c68dd9ddccceea\", \"dbus_unittests\": \"d9856378c21d3e8a6a76a2008496e5abc5de4027\", \"device_unittests\": \"ae3877e226bda9b97e1b3615127dfb69e77da0dc\", \"display_unittests\": \"f69eb7abb78873554a6294df797ed067c2904f8d\", \"events_unittests\": \"d44b5093874b99983401fed9df86bbab48e628c2\", \"exo_unittests\": \"af5c4d939baa11b85ea687e1deeec3954b2b702c\", \"extensions_browsertests\": \"5abed2bc730155f725b74955c9846dcf8e43360b\", \"extensions_unittests\": \"230b363f6d62d2d1327310363252798c8736d66a\", \"filesystem_service_unittests\": \"c97d17a4221db2f02829897d7b3390d398792a07\", \"gcm_unit_tests\": \"0e78067d1e2de4a5e3e87785c206c86e4642d336\", \"gfx_unittests\": \"8bf1acbfb31ec4aea85e2f9dbf8d09dcfdb4bfe6\", \"gin_unittests\": \"006ed31120e3d3c21395262b33c801ae39ee7d7f\", \"gl_unittests_ozone\": \"64f1f32130510a9cb7ffc383bc4c4520fa8ac8a3\", \"google_apis_unittests\": \"96e5ff6264a113d899c024335608a808bb110ca0\", \"gpu_unittests\": \"7386c3a7e8bfe0a453b7e6d2276204146d8a13fd\", \"gwp_asan_unittests\": \"ce06764402fcba2e4b55dec0279c3f70c0818ad7\", \"interactive_ui_tests\": \"75210dee5edc5d03ce182ac4c7ce384168b2f292\", \"ipc_tests\": \"ac01b2b3e044a4a237454a3e105081161481fa1f\", \"jingle_unittests\": \"e2543cbaef6484baa7d001b49942ad3f6d6e04db\", \"keyboard_unittests\": \"db0c9912e73b01f5010fc1e88567c2a441b6f915\", \"latency_unittests\": \"1d7afbf397aa7a4cf129eed08f309ce9f4ef512c\", \"libjingle_xmpp_unittests\": \"c11faac12f1c20ac7eba0721a6ac93b77611a610\", \"liburlpattern_unittests\": \"a6bfbf9d2e627cdaec9a4ec0f1e79418c813b938\", \"media_blink_unittests\": \"f27fb9b5f99bb4df86c5467a77aaac4a01ef80da\", \"media_unittests\": \"e9b0277f689d7d87beff36460621e6743320f69e\", \"message_center_unittests\": \"909c4b72411845d1a3171751f65c177aa01c855a\", \"midi_unittests\": \"45d3d0228125533f3a492f70b80a068ff2be3121\", \"mojo_core_unittests\": \"71d8272c942951dd3a4f1184612d586f79b8dcd0\", \"mojo_unittests\": \"f1be5c52a08c0c60758dc7d3adb8e46e33686879\", \"nacl_helper_nonsfi_unittests\": \"34bdd76a5dfa2e0c6deac254a2236e146c103472\", \"nacl_loader_unittests\": \"df940829fdd5a71591cee6b0827a194cbf6526b4\", \"native_theme_unittests\": \"c766a187c061befbce1de5801a395f3c32ff6969\", \"net_unittests\": \"63120cfc7855b09322c571a970c471a32f53d911\", \"ozone_gl_unittests\": \"795aa588fdc8d4894490e6345799e6e5844a83a9\", \"ozone_unittests\": \"a580fc8a5b3cbd632e2abfe64efc17d16fee47e8\", \"ozone_x11_unittests\": \"34dad6ecaf29fa24f435c4514424b19c9cb72c20\", \"pdf_unittests\": \"1d671cf170d2e215dc337b5e12193eb22ec15797\", \"perfetto_unittests\": \"d6b58341369a218ce386244fd703c85942cd4097\", \"ppapi_unittests\": \"9472f71b1458580e610e19b77c5a41c9fbd2d2d9\", \"printing_unittests\": \"667e84bd90b3893f5c5f3cfc0ec6ec44c2d3cfe7\", \"remoting_unittests\": \"f5180ace8ecf51fde09a34578d55b77106b7ddf9\", \"sandbox_linux_unittests\": \"f7d6383e207fb40d3cae571fd0d29c16c02c45cc\", \"service_manager_unittests\": \"e969a993c30cf0c394b7c72323ff6af33ce0ab2b\", \"services_unittests\": \"73794e687a7bf6d84f1f4faa47251b18ebe132a6\", \"shell_dialogs_unittests\": \"f83fc27257fddc13d4d05faad3d7baa48a7f0782\", \"shell_encryption_unittests\": \"17fc0f877c05ae9d47c5512d00a4e178642e21d9\", \"skia_unittests\": \"2a937918e4962e21888bb5ce9b63912e0134fb6b\", \"snapshot_unittests\": \"dacba132574487014cec86791750944e4ed39521\", \"sql_unittests\": \"a56e2a2978fba995525a6ee1e96bcece0f0e588c\", \"storage_unittests\": \"75c864aea9f62edc9910bf6d510ba7db53e5303d\", \"sync_integration_tests\": \"e26f27cc16ee6f7ee254238abd5a9ea5f4c1a91d\", \"traffic_annotation_auditor_unittests\": \"129682d3678d909ee3340699b41077dfc6c5337a\", \"ui_base_unittests\": \"926e84f8fd00c736a7763d0e83fb81fa7668fe68\", \"ui_chromeos_unittests\": \"c8cd74ee17dfcbba3027ed28f90c5f5f03ec7c3f\", \"ui_touch_selection_unittests\": \"5076b07273ae0f6fc4b8d0ada983e40efdb5aa45\", \"unit_tests\": \"113e6d587e09d13f19700e293177b8aada8999ab\", \"url_unittests\": \"e9fdbfc58b66e5853ff2af5b99e0edc452be2bf0\", \"usage_time_limit_unittests\": \"aa6124a8188db762afa83f28915927d38bf7ada9\", \"views_unittests\": \"6bd135ec0e070c717d005f88deccc45ff3489f7e\", \"viz_unittests\": \"262b92a944df93524a80dbe47664e2323ec1aa9c\", \"wayland_client_perftests\": \"fc500530538e3695875b5a8f71bab7169fd6a66c\", \"wm_unittests\": \"13d860415d87c0280a992cd6b2c1c2b225bf7d3e\", \"wtf_unittests\": \"089cc225c8c7737c53c46ad0f41544c3eb0be354\", \"zlib_unittests\": \"dff1d2dad7cdcce911d3f679ff07a49374997c16\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_6012964051d5021e7307eb12ad598b318c657120f21d3654d81218fef56916e6_v2\", \"builder_8f1f1a811acb8ac7cee91f001f34cb98db55e889611ed2a31914ce7c854c1541_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9864f67f40ba0a637f020c00db69aed5c54155e2e95bfe26df83308425415c7f_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_ce22d0fc5c297d03141230de59f52ebaf9005395a667e8b14df59e499796620f_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-65-yzph\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611087396165851",
"status": "COMPLETED",
"status_changed_ts": "1611090122945546",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44746",
"builder:linux-chromeos-rel",
"buildset:commit/git/439d23934634ab8c6cf4c9d3ac6d92f4df80defe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/439d23934634ab8c6cf4c9d3ac6d92f4df80defe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023076259852460096",
"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/8857646197885773760/+/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:51351b6b08066b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611090122992157",
"url": "https://ci.chromium.org/b/8857646197885773760",
"utcnow_ts": "1611090124154598"
}
}
[21:02:04.174] Invocation finished in 46m25.96333235s with status SUCCEEDED