[10:41:54.469] New invocation is queued and will start shortly
[10:41:55.603] Starting the invocation (attempt 1)
[10:41:55.641] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:41:55.642] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:41:55.642] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019669671054808528",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9cac656d0737ef2ccf682bb43f6bfdb93e27898d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019669671054808528",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/9cac656d0737ef2ccf682bb43f6bfdb93e27898d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9cac656d0737ef2ccf682bb43f6bfdb93e27898d",
"gitiles_ref:refs/heads/master"
]
}
[10:41:56.706] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614336115820850",
"id": "8854239608975735792",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9cac656d0737ef2ccf682bb43f6bfdb93e27898d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614336116477991",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45756",
"builder:linux-chromeos-rel",
"buildset:commit/git/9cac656d0737ef2ccf682bb43f6bfdb93e27898d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9cac656d0737ef2ccf682bb43f6bfdb93e27898d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019669671054808528",
"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/8854239608975735792/+/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": "1614336116478127",
"url": "https://ci.chromium.org/b/8854239608975735792",
"utcnow_ts": "1614336116692755"
}
}
[10:41:56.706] Task URL: https://ci.chromium.org/b/8854239608975735792
[10:41:56.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:2:0) after 1m0s
[10:42:25.958] Received PubSub notification, asking Buildbucket for the build status
[10:42:26.040] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:56.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:2:0)
[10:42:56.730] Timer tick, asking Buildbucket for the build status
[10:42:56.811] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:56.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:4:0) after 1m0s
[10:43:56.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:4:0)
[10:43:56.828] Timer tick, asking Buildbucket for the build status
[10:43:56.894] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:56.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:5:0) after 1m0s
[10:44:56.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:5:0)
[10:44:56.936] Timer tick, asking Buildbucket for the build status
[10:44:56.997] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:56.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:6:0) after 1m0s
[10:45:57.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:6:0)
[10:45:57.390] Timer tick, asking Buildbucket for the build status
[10:45:57.544] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:57.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:7:0) after 1m0s
[10:46:57.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:7:0)
[10:46:57.627] Timer tick, asking Buildbucket for the build status
[10:46:57.708] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:57.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:8:0) after 1m0s
[10:47:58.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:8:0)
[10:47:58.079] Timer tick, asking Buildbucket for the build status
[10:47:58.163] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:58.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:9:0) after 1m0s
[10:48:58.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:9:0)
[10:48:58.372] Timer tick, asking Buildbucket for the build status
[10:48:58.449] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:58.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:10:0) after 1m0s
[10:50:02.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:10:0)
[10:50:02.528] Timer tick, asking Buildbucket for the build status
[10:50:03.015] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:03.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:11:0) after 1m0s
[10:51:03.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:11:0)
[10:51:03.047] Timer tick, asking Buildbucket for the build status
[10:51:03.222] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:03.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:12:0) after 1m0s
[10:52:03.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:12:0)
[10:52:03.384] Timer tick, asking Buildbucket for the build status
[10:52:03.468] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:03.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:13:0) after 1m0s
[10:53:03.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:13:0)
[10:53:03.604] Timer tick, asking Buildbucket for the build status
[10:53:03.679] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:03.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:14:0) after 1m0s
[10:54:03.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:14:0)
[10:54:03.881] Timer tick, asking Buildbucket for the build status
[10:54:03.970] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:03.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:15:0) after 1m0s
[10:55:04.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:15:0)
[10:55:04.119] Timer tick, asking Buildbucket for the build status
[10:55:04.303] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:16:0) after 1m0s
[10:56:04.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:16:0)
[10:56:04.505] Timer tick, asking Buildbucket for the build status
[10:56:04.576] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:04.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:17:0) after 1m0s
[10:57:04.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:17:0)
[10:57:04.575] Timer tick, asking Buildbucket for the build status
[10:57:04.911] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:04.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:18:0) after 1m0s
[10:58:04.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:18:0)
[10:58:04.933] Timer tick, asking Buildbucket for the build status
[10:58:05.001] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:05.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:19:0) after 1m0s
[10:59:05.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:19:0)
[10:59:05.026] Timer tick, asking Buildbucket for the build status
[10:59:05.101] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:05.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:20:0) after 1m0s
[11:00:05.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:20:0)
[11:00:05.207] Timer tick, asking Buildbucket for the build status
[11:00:05.296] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:05.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:21:0) after 1m0s
[11:01:06.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:21:0)
[11:01:06.607] Timer tick, asking Buildbucket for the build status
[11:01:06.704] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:06.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:22:0) after 1m0s
[11:02:06.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:22:0)
[11:02:06.681] Timer tick, asking Buildbucket for the build status
[11:02:06.869] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:06.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:23:0) after 1m0s
[11:03:06.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:23:0)
[11:03:06.922] Timer tick, asking Buildbucket for the build status
[11:03:07.284] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:07.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:24:0) after 1m0s
[11:04:07.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:24:0)
[11:04:07.371] Timer tick, asking Buildbucket for the build status
[11:04:07.446] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:07.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:25:0) after 1m0s
[11:05:07.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:25:0)
[11:05:07.531] Timer tick, asking Buildbucket for the build status
[11:05:07.897] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:07.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:26:0) after 1m0s
[11:06:07.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:26:0)
[11:06:07.906] Timer tick, asking Buildbucket for the build status
[11:06:07.998] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:07.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:27:0) after 1m0s
[11:07:07.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:27:0)
[11:07:07.971] Timer tick, asking Buildbucket for the build status
[11:07:08.066] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:08.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:28:0) after 1m0s
[11:08:08.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:28:0)
[11:08:08.123] Timer tick, asking Buildbucket for the build status
[11:08:08.226] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:08.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:29:0) after 1m0s
[11:09:08.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:29:0)
[11:09:08.308] Timer tick, asking Buildbucket for the build status
[11:09:08.415] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:08.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:30:0) after 1m0s
[11:10:08.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:30:0)
[11:10:08.471] Timer tick, asking Buildbucket for the build status
[11:10:08.563] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:08.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:31:0) after 1m0s
[11:11:08.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:31:0)
[11:11:08.615] Timer tick, asking Buildbucket for the build status
[11:11:09.009] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:09.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:32:0) after 1m0s
[11:12:09.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:32:0)
[11:12:09.060] Timer tick, asking Buildbucket for the build status
[11:12:09.173] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:09.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:33:0) after 1m0s
[11:13:09.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:33:0)
[11:13:09.291] Timer tick, asking Buildbucket for the build status
[11:13:09.375] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:09.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:34:0) after 1m0s
[11:14:09.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:34:0)
[11:14:09.422] Timer tick, asking Buildbucket for the build status
[11:14:09.493] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:09.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:35:0) after 1m0s
[11:15:09.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:35:0)
[11:15:09.517] Timer tick, asking Buildbucket for the build status
[11:15:09.798] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:09.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:36:0) after 1m0s
[11:16:09.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:36:0)
[11:16:09.816] Timer tick, asking Buildbucket for the build status
[11:16:09.920] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:09.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:37:0) after 1m0s
[11:17:09.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:37:0)
[11:17:09.940] Timer tick, asking Buildbucket for the build status
[11:17:10.059] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:10.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:38:0) after 1m0s
[11:18:10.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:38:0)
[11:18:10.116] Timer tick, asking Buildbucket for the build status
[11:18:10.428] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:10.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:39:0) after 1m0s
[11:19:10.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:39:0)
[11:19:10.448] Timer tick, asking Buildbucket for the build status
[11:19:10.540] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:10.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:40:0) after 1m0s
[11:20:10.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:40:0)
[11:20:10.560] Timer tick, asking Buildbucket for the build status
[11:20:10.632] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:10.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:41:0) after 1m0s
[11:21:10.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:41:0)
[11:21:10.701] Timer tick, asking Buildbucket for the build status
[11:21:10.795] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:10.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:42:0) after 1m0s
[11:22:10.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:42:0)
[11:22:10.901] Timer tick, asking Buildbucket for the build status
[11:22:11.020] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:11.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:43:0) after 1m0s
[11:23:11.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:43:0)
[11:23:11.049] Timer tick, asking Buildbucket for the build status
[11:23:11.167] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:11.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:44:0) after 1m0s
[11:24:11.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:44:0)
[11:24:11.304] Timer tick, asking Buildbucket for the build status
[11:24:11.434] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:11.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:45:0) after 1m0s
[11:25:11.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:45:0)
[11:25:11.466] Timer tick, asking Buildbucket for the build status
[11:25:11.561] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:11.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:46:0) after 1m0s
[11:26:11.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:46:0)
[11:26:11.657] Timer tick, asking Buildbucket for the build status
[11:26:11.931] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:11.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:47:0) after 1m0s
[11:27:11.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:47:0)
[11:27:11.968] Timer tick, asking Buildbucket for the build status
[11:27:12.425] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:12.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:48:0) after 1m0s
[11:28:12.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:48:0)
[11:28:12.433] Timer tick, asking Buildbucket for the build status
[11:28:12.800] Build 8854239608975735792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:12.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:49:0) after 1m0s
[11:29:12.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019669671054808528:49:0)
[11:29:12.820] Timer tick, asking Buildbucket for the build status
[11:29:12.913] Build 8854239608975735792: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:29:12.913] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614338951635203",
"created_by": "project:chromium",
"created_ts": "1614336115820850",
"failure_reason": "BUILD_FAILURE",
"id": "8854239608975735792",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9cac656d0737ef2ccf682bb43f6bfdb93e27898d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**interactive_ui_tests** failed because of:\\n\\n- MimeHandlerViewTest.EscapeExitsFullscreen\"}, \"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\": \"9cac656d0737ef2ccf682bb43f6bfdb93e27898d\", \"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-12-dutr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45756, \"got_angle_revision\": \"d24398b3e36175d08e74261a1a0a2c8a27a00dd6\", \"got_dawn_revision\": \"87649ff09dee357f0412834527e4174b4989358f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"9cac656d0737ef2ccf682bb43f6bfdb93e27898d\", \"got_revision_cp\": \"refs/heads/master@{#858070}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"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\": \"9cac656d0737ef2ccf682bb43f6bfdb93e27898d\", \"swarm_hashes_refs/heads/master(at){#858070}_without_patch\": {\"absl_hardening_tests\": \"5fc0ad562c99899cf31c9f76eb5747976d65aa3b\", \"accessibility_unittests\": \"7e6dcc3fd573dd8c494faf09e977176e86f59756\", \"angle_unittests\": \"8e0ee415f54eda00a79c679e1e3ab418b6a83b71\", \"app_list_unittests\": \"7b0ee36bd3baddb2565361ac91b139c36ad63508\", \"app_shell_unittests\": \"a6c4e9d854d17660132eb3a3351b581e4a1272da\", \"ash_unittests\": \"f5db86bc156cb61ead5efd9f382452b91f0d3939\", \"aura_unittests\": \"fa7c87b91aa67e5ce7b252c02bc18a34a5ae742f\", \"base_unittests\": \"89dd221e27510c31ab116d6ef28dfc278965ae05\", \"base_util_unittests\": \"0d6421149bef8b60ab7ef933a3bb5ab899e42f27\", \"blink_common_unittests\": \"d3b7b4506f1b387a2a4568940da11a4b297d8ca0\", \"blink_fuzzer_unittests\": \"75546eb75ad8c4cd579fa626dbcc807a99a3a6cb\", \"blink_heap_unittests\": \"9ecb23512e543a321028fc07ea709b63d6aa4d87\", \"blink_platform_unittests\": \"6c746cb8d9d3deee13230197d6f32b1861fa6851\", \"blink_unittests\": \"e67d7420090d439f8282fcd5e136e009dd7718ae\", \"boringssl_crypto_tests\": \"afa394d2a893d11bd4981df06160eac4c4cb5ad5\", \"boringssl_ssl_tests\": \"ee698c33a9ce4944886a562721d9fd8b353b79ff\", \"browser_tests\": \"1590a8eb1d78ac724174efde9985d51bcf4ed762\", \"capture_unittests\": \"24cf4ee7c3667d448d1dde4a1caa6691ade524cc\", \"cast_unittests\": \"e67b6cd6c3a61a00a734f3b7ea5e873e6cbd6824\", \"cc_unittests\": \"b513c8a57ad8b947ba1417575a1150ced980cf84\", \"chrome_app_unittests\": \"9fd2b01284f951f2b6334888c1493ceb937f2578\", \"chromedriver_unittests\": \"99ae363b5e6ba8262fb0f9f74730ac4bb3789972\", \"chromeos_components_unittests\": \"d8ef9c49f4f6da35932d56aecb4153f596230e48\", \"chromeos_unittests\": \"3bf873926c422c5e532b6d2f1f6557b80e0616cf\", \"color_unittests\": \"525c54b6974c1564efc87ff5354cd7c50487cfff\", \"components_browsertests\": \"9d58ec565c8db5d330fc6388e1e0b0e85edf728c\", \"components_unittests\": \"b3149989db9a62bc17cdab8759d8a8bd64233fa2\", \"compositor_unittests\": \"9fc0193ae9fb36a44644a8ad7451bdcb4042838b\", \"content_browsertests\": \"d88933fe1f987bf4972223d95a971b600a5cf9d1\", \"content_unittests\": \"ee9a2e66919b0973b9f8fa9f8b77363b06fc28fa\", \"crashpad_tests\": \"07dda6507a318a918fb9bbd6d5b492777498e23a\", \"crypto_unittests\": \"aa8832f5f3a0692855ce196dafb1a67d8b9b6abb\", \"dbus_unittests\": \"399bfde8113b564b01ba458c6e80f13a27f5a798\", \"device_unittests\": \"5e11d6faecdc0f1640e0a978d63dc6ed324991a4\", \"display_unittests\": \"41a352429825136a874e77d6d2215e79b01b088d\", \"events_unittests\": \"c559e0ef762a7b94c38d100824a0c2b1a8d0c611\", \"exo_unittests\": \"afb8d372bfcf41d9b790ac14653a3eec4382367a\", \"extensions_browsertests\": \"5350f6af6bc4708bca2228f50e6127a7c20b433c\", \"extensions_unittests\": \"03079233b88660cc23575a8a3acdcbd0422dabf3\", \"filesystem_service_unittests\": \"e44afec1ac39fa3c1461ce9cb215dd05fd7dd25c\", \"gcm_unit_tests\": \"ae8d4bf43f3c47fd2c68a0c030ff6a32280f136f\", \"gfx_unittests\": \"05c9f36b05de4f892dc89cec51f40f42bbe666d3\", \"gin_unittests\": \"84c49dc8e2ccca4c8b74d4bf562d070f936e39c3\", \"gl_unittests_ozone\": \"fa6f9c0499cd0883cea31029d1a029e9bb4d025c\", \"google_apis_unittests\": \"31aca48a1430bd1421d7917182d2ec930d433111\", \"gpu_unittests\": \"c582fff1ee388540d0690b5ae356a1a9cfe2b798\", \"gwp_asan_unittests\": \"e2b748cbb3cd84a52168218856a6c96bf46b0054\", \"interactive_ui_tests\": \"f8302979090d2c18bf732ab18ebe5c6f5c21a078\", \"ipc_tests\": \"3bd348bd2a9384510314b4f436604529e930cf8a\", \"jingle_unittests\": \"b8557decc6530ae222634b04aa9af72666fef660\", \"keyboard_unittests\": \"e65dd0af192bc604e702d443155d4320376e7486\", \"latency_unittests\": \"27ec29790b6494dd4a0869c92cc8a64404c727eb\", \"libjingle_xmpp_unittests\": \"66b426d82ec9d55ed3192c2199c0a63d7a6327e5\", \"liburlpattern_unittests\": \"868a4d3a68da851b404ee722d177430bc86ef40c\", \"media_blink_unittests\": \"c93e2838c79c7a89cdc77df54f2d876ff3464feb\", \"media_unittests\": \"9bcbe3f33b5f35bff4a9a9e3e905ba94d6080dd3\", \"message_center_unittests\": \"b2d928d17b357433b2330c866a67b9da038009d8\", \"midi_unittests\": \"3febc61788466dc9c481cb9bf7e1e0aacfa7fb95\", \"mojo_core_unittests\": \"9597335a2c5b67f3c831140e3cf4a2e02f2ad135\", \"mojo_unittests\": \"81143f0251768fe40bc8ebb3f57c544929c5c106\", \"nacl_helper_nonsfi_unittests\": \"78898c1cee4fa0e9f97e358307adbe84164280d4\", \"nacl_loader_unittests\": \"4f663c728595bd198cba46ca9e3daba13bba2bd5\", \"native_theme_unittests\": \"7214d9c9d445e1717baf564023f15cffe0aadedf\", \"net_unittests\": \"69d6dd910e93610fdfd55a8ffd37b2ad1a14fe3c\", \"ozone_gl_unittests\": \"5f7e2ac904a0a4d6ef2a76bf7128e188884781ca\", \"ozone_unittests\": \"f2d71f911aff7659aa6c52bde27de89be2f7dd9e\", \"ozone_x11_unittests\": \"8c8883d00d34ee55c3b5d1609a5febc24bbc4777\", \"pdf_unittests\": \"f99d45e4ad517d318f1de341cf22a7e60d6b54f0\", \"perfetto_unittests\": \"66cd2f89b9d3a522952e3d8494b202c0934393f4\", \"ppapi_unittests\": \"7075671d2d23605e3e6bc6925fe1385ac3f572d3\", \"printing_unittests\": \"91639796a3426310ed2bc5acbac95888b3152c22\", \"remoting_unittests\": \"8c6dda50996454e221def023a560fe3babde610b\", \"sandbox_linux_unittests\": \"af9e41d86da0b84c6bf1c7974a5f1d2dd6f3c3ff\", \"service_manager_unittests\": \"59647d0b44b7a2ccc9d64d057d3ed6eafbb22c14\", \"services_unittests\": \"df9cd33ce7cc973aca94d5d91b40ee70eac8617d\", \"shell_dialogs_unittests\": \"ab235c2d639bfe5e959581e41b313e1e7d9855eb\", \"shell_encryption_unittests\": \"afb61535330ac669da3e07932bbb5b78c6e7ae2e\", \"skia_unittests\": \"23caf522266c36507e3a3cfb930fcb380a29ab29\", \"snapshot_unittests\": \"8b1ed5407a814f9e331081a56c4f0ebd08ca9f78\", \"sql_unittests\": \"dcbcb9c131e501ecf13487c1fa6aefd55bd134e4\", \"storage_unittests\": \"4f3d0f6df34cac71b0d125b410ca8488f1ad99b7\", \"sync_integration_tests\": \"fe425e445ffc4c6d35940a86e9c04af1b10ddc10\", \"traffic_annotation_auditor_unittests\": \"047d2cf23cd55ac28c63292efb41ce537a11b642\", \"ui_base_unittests\": \"63da6b8c761e7d759acd00aef322d6a0d7b94509\", \"ui_chromeos_unittests\": \"ddaa4e54b614779b644aaaa05f321e65113c62fd\", \"ui_touch_selection_unittests\": \"46e6f917f3c8c290aa18a8f7180e877355a5db49\", \"unit_tests\": \"bd500c28967d1b1f0776ce8dce8b5de19b2c6cf9\", \"url_unittests\": \"3d0315a176d64bb1aa24eb6561b8debde5b3e3c8\", \"usage_time_limit_unittests\": \"005fb93373366295a1814df5f231a7a8d527acf4\", \"views_unittests\": \"a8579591124b3efd990dfc36c6be08086e964a3d\", \"viz_unittests\": \"94321370517df03116483905a07aeaf804a0374f\", \"wayland_client_perftests\": \"1d4758a2f721c489c9d99ddb9f008a308295040b\", \"wayland_client_tests\": \"eb2239780da3b06b1b24ccce37edbaab3917084c\", \"wm_unittests\": \"27c29a78bd3379a46c434c105dc18a345cee9c93\", \"wtf_unittests\": \"4b61f364af606901d045811a53fd9dd622bcbc78\", \"zlib_unittests\": \"0d105847e165d3204ee716a9e02b0f84e5904f77\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_v2\", \"builder_fdd7de770372258dd0e62a94923a13570b890ab5ae7c622093730be0503c1d22_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-12-dutr\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**interactive_ui_tests** failed because of:\\n\\n- MimeHandlerViewTest.EscapeExitsFullscreen\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614336144810453",
"status": "COMPLETED",
"status_changed_ts": "1614336145542227",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45756",
"builder:linux-chromeos-rel",
"buildset:commit/git/9cac656d0737ef2ccf682bb43f6bfdb93e27898d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9cac656d0737ef2ccf682bb43f6bfdb93e27898d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019669671054808528",
"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/8854239608975735792/+/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:51f6bfd057e23010",
"user_agent:luci-scheduler"
],
"updated_ts": "1614338951635682",
"url": "https://ci.chromium.org/b/8854239608975735792",
"utcnow_ts": "1614338952903514"
}
}
[11:29:12.913] Invocation finished in 47m18.459608228s with status FAILED