[13:12:54.733] New invocation is queued and will start shortly
[13:12:55.952] Starting the invocation (attempt 1)
[13:12:56.017] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:12:56.017] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:12:56.017] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026817331025375888",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"518e208bfc0ee1bb3ab783f1e8c41651aad067f5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9026817331025375888",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/518e208bfc0ee1bb3ab783f1e8c41651aad067f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/518e208bfc0ee1bb3ab783f1e8c41651aad067f5",
"gitiles_ref:refs/heads/master"
]
}
[13:12:56.717] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607519576140419",
"id": "8861387268887385296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"518e208bfc0ee1bb3ab783f1e8c41651aad067f5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607519576599222",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21673",
"builder:linux-chromeos-dbg",
"buildset:commit/git/518e208bfc0ee1bb3ab783f1e8c41651aad067f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/518e208bfc0ee1bb3ab783f1e8c41651aad067f5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026817331025375888",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8861387268887385296/+/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": "1607519576599368",
"url": "https://ci.chromium.org/b/8861387268887385296",
"utcnow_ts": "1607519576705981"
}
}
[13:12:56.717] Task URL: https://ci.chromium.org/b/8861387268887385296
[13:12:56.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:2:0) after 1m0s
[13:13:56.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:2:0)
[13:13:56.848] Timer tick, asking Buildbucket for the build status
[13:13:57.000] Build 8861387268887385296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:57.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:3:0) after 1m0s
[13:14:57.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:3:0)
[13:14:57.007] Timer tick, asking Buildbucket for the build status
[13:14:57.079] Build 8861387268887385296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:57.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:4:0) after 1m0s
[13:15:57.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:4:0)
[13:15:57.095] Timer tick, asking Buildbucket for the build status
[13:15:57.386] Build 8861387268887385296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:15:57.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:5:0) after 1m0s
[13:16:57.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:5:0)
[13:16:57.573] Timer tick, asking Buildbucket for the build status
[13:16:57.649] Build 8861387268887385296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:16:57.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:6:0) after 1m0s
[13:17:03.713] Received PubSub notification, asking Buildbucket for the build status
[13:17:03.781] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:57.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:6:0)
[13:17:57.762] Timer tick, asking Buildbucket for the build status
[13:17:57.915] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:57.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:8:0) after 1m0s
[13:18:58.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:8:0)
[13:18:58.258] Timer tick, asking Buildbucket for the build status
[13:18:58.602] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:58.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:9:0) after 1m0s
[13:19:58.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:9:0)
[13:19:58.710] Timer tick, asking Buildbucket for the build status
[13:19:58.810] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:10:0) after 1m0s
[13:20:58.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:10:0)
[13:20:58.831] Timer tick, asking Buildbucket for the build status
[13:20:58.898] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:58.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:11:0) after 1m0s
[13:21:58.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:11:0)
[13:21:58.944] Timer tick, asking Buildbucket for the build status
[13:21:59.006] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:12:0) after 1m0s
[13:22:59.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:12:0)
[13:22:59.075] Timer tick, asking Buildbucket for the build status
[13:22:59.205] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:59.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:13:0) after 1m0s
[13:23:59.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:13:0)
[13:23:59.240] Timer tick, asking Buildbucket for the build status
[13:23:59.624] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:59.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:14:0) after 1m0s
[13:24:59.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:14:0)
[13:24:59.648] Timer tick, asking Buildbucket for the build status
[13:24:59.751] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:59.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:15:0) after 1m0s
[13:25:59.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:15:0)
[13:25:59.739] Timer tick, asking Buildbucket for the build status
[13:25:59.809] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:59.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:16:0) after 1m0s
[13:26:59.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:16:0)
[13:26:59.866] Timer tick, asking Buildbucket for the build status
[13:27:00.309] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:00.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:17:0) after 1m0s
[13:28:00.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:17:0)
[13:28:00.428] Timer tick, asking Buildbucket for the build status
[13:28:00.536] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:00.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:18:0) after 1m0s
[13:29:01.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:18:0)
[13:29:01.649] Timer tick, asking Buildbucket for the build status
[13:29:01.752] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:01.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:19:0) after 1m0s
[13:30:02.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:19:0)
[13:30:02.166] Timer tick, asking Buildbucket for the build status
[13:30:02.274] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:02.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:20:0) after 1m0s
[13:31:02.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:20:0)
[13:31:02.390] Timer tick, asking Buildbucket for the build status
[13:31:02.713] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:02.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:21:0) after 1m0s
[13:32:02.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:21:0)
[13:32:02.803] Timer tick, asking Buildbucket for the build status
[13:32:02.976] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:02.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:22:0) after 1m0s
[13:33:03.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:22:0)
[13:33:03.253] Timer tick, asking Buildbucket for the build status
[13:33:03.499] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:03.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:23:0) after 1m0s
[13:34:03.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:23:0)
[13:34:03.589] Timer tick, asking Buildbucket for the build status
[13:34:03.934] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:03.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:24:0) after 1m0s
[13:35:03.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:24:0)
[13:35:03.937] Timer tick, asking Buildbucket for the build status
[13:35:04.419] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:04.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:25:0) after 1m0s
[13:36:04.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:25:0)
[13:36:04.517] Timer tick, asking Buildbucket for the build status
[13:36:04.589] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:04.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:26:0) after 1m0s
[13:37:04.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:26:0)
[13:37:04.663] Timer tick, asking Buildbucket for the build status
[13:37:05.173] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:05.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:27:0) after 1m0s
[13:38:05.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:27:0)
[13:38:05.217] Timer tick, asking Buildbucket for the build status
[13:38:05.360] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:05.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:28:0) after 1m0s
[13:39:05.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:28:0)
[13:39:05.470] Timer tick, asking Buildbucket for the build status
[13:39:05.552] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:05.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:29:0) after 1m0s
[13:40:05.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:29:0)
[13:40:05.703] Timer tick, asking Buildbucket for the build status
[13:40:05.778] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:05.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:30:0) after 1m0s
[13:41:05.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:30:0)
[13:41:05.918] Timer tick, asking Buildbucket for the build status
[13:41:06.127] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:06.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:31:0) after 1m0s
[13:42:06.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:31:0)
[13:42:06.158] Timer tick, asking Buildbucket for the build status
[13:42:06.229] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:06.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:32:0) after 1m0s
[13:43:06.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:32:0)
[13:43:06.288] Timer tick, asking Buildbucket for the build status
[13:43:06.608] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:06.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:33:0) after 1m0s
[13:44:06.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:33:0)
[13:44:06.697] Timer tick, asking Buildbucket for the build status
[13:44:07.110] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:07.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:34:0) after 1m0s
[13:45:07.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:34:0)
[13:45:07.177] Timer tick, asking Buildbucket for the build status
[13:45:07.250] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:07.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:35:0) after 1m0s
[13:46:07.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:35:0)
[13:46:07.279] Timer tick, asking Buildbucket for the build status
[13:46:07.525] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:07.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:36:0) after 1m0s
[13:47:07.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:36:0)
[13:47:07.663] Timer tick, asking Buildbucket for the build status
[13:47:07.763] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:07.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:37:0) after 1m0s
[13:48:07.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:37:0)
[13:48:07.876] Timer tick, asking Buildbucket for the build status
[13:48:08.114] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:08.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:38:0) after 1m0s
[13:49:08.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:38:0)
[13:49:08.193] Timer tick, asking Buildbucket for the build status
[13:49:08.293] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:08.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:39:0) after 1m0s
[13:50:08.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:39:0)
[13:50:08.342] Timer tick, asking Buildbucket for the build status
[13:50:08.435] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:08.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:40:0) after 1m0s
[13:51:08.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:40:0)
[13:51:08.544] Timer tick, asking Buildbucket for the build status
[13:51:08.731] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:08.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:41:0) after 1m0s
[13:52:09.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:41:0)
[13:52:09.069] Timer tick, asking Buildbucket for the build status
[13:52:09.144] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:09.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:42:0) after 1m0s
[13:53:09.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:42:0)
[13:53:09.261] Timer tick, asking Buildbucket for the build status
[13:53:09.373] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:09.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:43:0) after 1m0s
[13:54:09.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:43:0)
[13:54:09.505] Timer tick, asking Buildbucket for the build status
[13:54:10.044] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:10.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:44:0) after 1m0s
[13:55:10.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:44:0)
[13:55:10.381] Timer tick, asking Buildbucket for the build status
[13:55:10.434] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:10.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:45:0) after 1m0s
[13:56:10.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:45:0)
[13:56:10.725] Timer tick, asking Buildbucket for the build status
[13:56:10.781] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:10.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:46:0) after 1m0s
[13:57:10.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:46:0)
[13:57:10.803] Timer tick, asking Buildbucket for the build status
[13:57:10.920] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:10.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:47:0) after 1m0s
[13:58:10.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:47:0)
[13:58:10.968] Timer tick, asking Buildbucket for the build status
[13:58:11.086] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:11.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:48:0) after 1m0s
[13:59:11.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:48:0)
[13:59:11.142] Timer tick, asking Buildbucket for the build status
[13:59:11.210] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:11.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:49:0) after 1m0s
[14:00:11.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:49:0)
[14:00:11.253] Timer tick, asking Buildbucket for the build status
[14:00:11.322] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:11.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:50:0) after 1m0s
[14:01:11.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:50:0)
[14:01:11.408] Timer tick, asking Buildbucket for the build status
[14:01:11.477] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:11.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:51:0) after 1m0s
[14:02:11.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:51:0)
[14:02:11.602] Timer tick, asking Buildbucket for the build status
[14:02:11.822] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:11.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:52:0) after 1m0s
[14:03:11.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:52:0)
[14:03:11.895] Timer tick, asking Buildbucket for the build status
[14:03:11.997] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:11.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:53:0) after 1m0s
[14:04:12.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:53:0)
[14:04:12.047] Timer tick, asking Buildbucket for the build status
[14:04:12.114] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:12.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:54:0) after 1m0s
[14:05:12.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:54:0)
[14:05:12.184] Timer tick, asking Buildbucket for the build status
[14:05:13.877] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:13.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:55:0) after 1m0s
[14:06:14.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:55:0)
[14:06:14.592] Timer tick, asking Buildbucket for the build status
[14:06:14.715] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:14.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:56:0) after 1m0s
[14:07:14.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:56:0)
[14:07:14.862] Timer tick, asking Buildbucket for the build status
[14:07:15.126] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:15.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:57:0) after 1m0s
[14:08:15.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:57:0)
[14:08:15.217] Timer tick, asking Buildbucket for the build status
[14:08:15.322] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:15.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:58:0) after 1m0s
[14:09:15.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:58:0)
[14:09:15.548] Timer tick, asking Buildbucket for the build status
[14:09:15.623] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:15.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:59:0) after 1m0s
[14:10:15.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:59:0)
[14:10:15.656] Timer tick, asking Buildbucket for the build status
[14:10:15.998] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:15.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:60:0) after 1m0s
[14:11:16.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:60:0)
[14:11:16.052] Timer tick, asking Buildbucket for the build status
[14:11:16.182] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:16.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:61:0) after 1m0s
[14:12:16.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:61:0)
[14:12:16.208] Timer tick, asking Buildbucket for the build status
[14:12:16.653] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:16.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:62:0) after 1m0s
[14:13:16.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:62:0)
[14:13:16.699] Timer tick, asking Buildbucket for the build status
[14:13:16.835] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:16.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:63:0) after 1m0s
[14:14:16.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:63:0)
[14:14:16.829] Timer tick, asking Buildbucket for the build status
[14:14:16.983] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:16.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:64:0) after 1m0s
[14:15:17.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:64:0)
[14:15:17.015] Timer tick, asking Buildbucket for the build status
[14:15:17.143] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:17.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:65:0) after 1m0s
[14:16:17.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:65:0)
[14:16:17.200] Timer tick, asking Buildbucket for the build status
[14:16:17.314] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:17.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:66:0) after 1m0s
[14:17:17.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:66:0)
[14:17:17.369] Timer tick, asking Buildbucket for the build status
[14:17:17.487] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:17.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:67:0) after 1m0s
[14:18:17.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:67:0)
[14:18:17.532] Timer tick, asking Buildbucket for the build status
[14:18:17.625] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:17.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:68:0) after 1m0s
[14:19:17.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:68:0)
[14:19:17.696] Timer tick, asking Buildbucket for the build status
[14:19:17.839] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:17.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:69:0) after 1m0s
[14:20:17.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:69:0)
[14:20:17.875] Timer tick, asking Buildbucket for the build status
[14:20:18.033] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:18.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:70:0) after 1m0s
[14:21:18.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:70:0)
[14:21:18.200] Timer tick, asking Buildbucket for the build status
[14:21:18.641] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:18.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:71:0) after 1m0s
[14:22:18.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:71:0)
[14:22:18.723] Timer tick, asking Buildbucket for the build status
[14:22:18.788] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:18.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:72:0) after 1m0s
[14:23:18.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:72:0)
[14:23:18.932] Timer tick, asking Buildbucket for the build status
[14:23:19.043] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:19.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:73:0) after 1m0s
[14:24:20.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:73:0)
[14:24:20.867] Timer tick, asking Buildbucket for the build status
[14:24:20.981] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:20.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:74:0) after 1m0s
[14:25:21.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:74:0)
[14:25:21.335] Timer tick, asking Buildbucket for the build status
[14:25:21.460] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:21.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:75:0) after 1m0s
[14:26:21.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:75:0)
[14:26:21.909] Timer tick, asking Buildbucket for the build status
[14:26:22.014] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:22.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:76:0) after 1m0s
[14:27:22.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:76:0)
[14:27:22.093] Timer tick, asking Buildbucket for the build status
[14:27:22.180] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:22.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:77:0) after 1m0s
[14:28:22.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:77:0)
[14:28:22.376] Timer tick, asking Buildbucket for the build status
[14:28:22.497] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:22.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:78:0) after 1m0s
[14:29:22.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:78:0)
[14:29:22.565] Timer tick, asking Buildbucket for the build status
[14:29:22.677] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:22.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:79:0) after 1m0s
[14:30:22.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:79:0)
[14:30:22.825] Timer tick, asking Buildbucket for the build status
[14:30:23.601] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:23.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:80:0) after 1m0s
[14:31:23.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:80:0)
[14:31:23.832] Timer tick, asking Buildbucket for the build status
[14:31:25.098] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:25.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:81:0) after 1m0s
[14:32:25.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:81:0)
[14:32:25.610] Timer tick, asking Buildbucket for the build status
[14:32:25.990] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:25.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:82:0) after 1m0s
[14:33:26.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:82:0)
[14:33:26.123] Timer tick, asking Buildbucket for the build status
[14:33:26.341] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:26.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:83:0) after 1m0s
[14:34:26.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:83:0)
[14:34:26.432] Timer tick, asking Buildbucket for the build status
[14:34:26.504] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:26.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:84:0) after 1m0s
[14:35:26.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:84:0)
[14:35:26.522] Timer tick, asking Buildbucket for the build status
[14:35:26.608] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:26.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:85:0) after 1m0s
[14:36:26.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:85:0)
[14:36:26.850] Timer tick, asking Buildbucket for the build status
[14:36:27.026] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:27.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:86:0) after 1m0s
[14:37:27.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:86:0)
[14:37:27.073] Timer tick, asking Buildbucket for the build status
[14:37:27.697] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:87:0) after 1m0s
[14:38:28.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:87:0)
[14:38:28.689] Timer tick, asking Buildbucket for the build status
[14:38:28.881] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:28.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:88:0) after 1m0s
[14:39:29.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:88:0)
[14:39:29.027] Timer tick, asking Buildbucket for the build status
[14:39:29.106] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:29.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:89:0) after 1m0s
[14:40:29.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:89:0)
[14:40:29.217] Timer tick, asking Buildbucket for the build status
[14:40:29.313] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:29.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:90:0) after 1m0s
[14:41:29.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:90:0)
[14:41:29.501] Timer tick, asking Buildbucket for the build status
[14:41:29.613] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:29.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:91:0) after 1m0s
[14:42:29.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:91:0)
[14:42:29.873] Timer tick, asking Buildbucket for the build status
[14:42:31.164] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:31.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:92:0) after 1m0s
[14:43:31.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:92:0)
[14:43:31.184] Timer tick, asking Buildbucket for the build status
[14:43:31.366] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:31.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:93:0) after 1m0s
[14:44:31.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:93:0)
[14:44:31.507] Timer tick, asking Buildbucket for the build status
[14:44:31.717] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:31.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:94:0) after 1m0s
[14:45:31.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:94:0)
[14:45:31.813] Timer tick, asking Buildbucket for the build status
[14:45:31.952] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:31.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:95:0) after 1m0s
[14:46:32.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:95:0)
[14:46:32.014] Timer tick, asking Buildbucket for the build status
[14:46:32.212] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:32.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:96:0) after 1m0s
[14:47:32.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:96:0)
[14:47:32.335] Timer tick, asking Buildbucket for the build status
[14:47:34.067] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:97:0) after 1m0s
[14:48:34.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:97:0)
[14:48:34.077] Timer tick, asking Buildbucket for the build status
[14:48:34.316] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:34.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:98:0) after 1m0s
[14:49:34.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:98:0)
[14:49:34.359] Timer tick, asking Buildbucket for the build status
[14:49:34.513] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:34.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:99:0) after 1m0s
[14:50:34.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:99:0)
[14:50:34.621] Timer tick, asking Buildbucket for the build status
[14:50:34.797] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:34.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:100:0) after 1m0s
[14:51:34.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:100:0)
[14:51:34.824] Timer tick, asking Buildbucket for the build status
[14:51:35.048] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:35.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:101:0) after 1m0s
[14:52:35.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:101:0)
[14:52:35.072] Timer tick, asking Buildbucket for the build status
[14:52:35.173] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:35.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:102:0) after 1m0s
[14:53:35.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:102:0)
[14:53:35.229] Timer tick, asking Buildbucket for the build status
[14:53:35.434] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:35.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:103:0) after 1m0s
[14:54:35.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:103:0)
[14:54:35.482] Timer tick, asking Buildbucket for the build status
[14:54:35.537] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:35.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:104:0) after 1m0s
[14:55:35.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:104:0)
[14:55:35.636] Timer tick, asking Buildbucket for the build status
[14:55:35.745] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:35.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:105:0) after 1m0s
[14:56:35.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:105:0)
[14:56:35.774] Timer tick, asking Buildbucket for the build status
[14:56:36.314] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:36.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:106:0) after 1m0s
[14:57:36.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:106:0)
[14:57:36.419] Timer tick, asking Buildbucket for the build status
[14:57:36.833] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:36.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:107:0) after 1m0s
[14:58:36.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:107:0)
[14:58:36.916] Timer tick, asking Buildbucket for the build status
[14:58:37.144] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:37.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:108:0) after 1m0s
[14:59:37.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:108:0)
[14:59:37.204] Timer tick, asking Buildbucket for the build status
[14:59:37.333] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:37.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:109:0) after 1m0s
[15:00:37.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:109:0)
[15:00:37.431] Timer tick, asking Buildbucket for the build status
[15:00:37.563] Build 8861387268887385296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:37.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026817331025375888:110:0) after 1m0s
[15:00:44.421] Received PubSub notification, asking Buildbucket for the build status
[15:00:44.565] Build 8861387268887385296: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:00:44.565] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607526043576421",
"created_by": "project:chromium",
"created_ts": "1607519576140419",
"failure_reason": "BUILD_FAILURE",
"id": "8861387268887385296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"518e208bfc0ee1bb3ab783f1e8c41651aad067f5\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogDefaultFilter\\n\\n- TabStripTabListTest.All\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogSingleFilterNoAcceptAll\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"518e208bfc0ee1bb3ab783f1e8c41651aad067f5\", \"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-85-y9r2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21673, \"got_angle_revision\": \"f0f79e08366208f15f05c909bc7b81a1198e261f\", \"got_dawn_revision\": \"30805557e65102253a77aadb93ea02fd62dde142\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"518e208bfc0ee1bb3ab783f1e8c41651aad067f5\", \"got_revision_cp\": \"refs/heads/master@{#835160}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"84b9bb6621c7eae8da034d31aceab780d8b1abdc\", \"got_v8_revision\": \"2523885b9c6cad4afc21787b638301da243fca62\", \"got_v8_revision_cp\": \"refs/heads/8.9.125@{#1}\", \"got_webrtc_revision\": \"bb1a28de3cf17476142e9de8ee12fe6c567d06c1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32789}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"518e208bfc0ee1bb3ab783f1e8c41651aad067f5\", \"swarm_hashes_refs/heads/master(at){#835160}_without_patch\": {\"absl_hardening_tests\": \"03e6779794b667b73c491866f97b4113162f9583\", \"accessibility_unittests\": \"083b6f2c0a96688d48133a44ce7e38b74444d4a9\", \"angle_unittests\": \"caa749f96b2ccd0eadb9f85bfaf6f206ce4923b8\", \"app_list_unittests\": \"fb8144eb0000879c92d46a13ab285df869b1cb8f\", \"app_shell_unittests\": \"00debbe4dc975a5af3fcefc01ce73ebcb2788694\", \"ash_unittests\": \"3e0ae7aed6cd9bf7f33579067a75bfd5e49636b0\", \"aura_unittests\": \"5f86f9fc495b2447954ec083289c111fd32fe4b0\", \"base_unittests\": \"7d1b50f23e8eaf4f3e1ae59c217938f1a20df04c\", \"base_util_unittests\": \"168effafc36ca52f2e8588bbe52b9e5a1c822b22\", \"blink_common_unittests\": \"297b2382c9b23a1cf8c6cf9a3eaffeae8e57e3d2\", \"blink_fuzzer_unittests\": \"d5461af749944db706b2123ed642d875265e8ef9\", \"blink_heap_unittests\": \"90e6b522a4fc6815a1d34ed131bad5d24e2e8273\", \"blink_platform_unittests\": \"a21dae2a25917dd17062e16af73ab7275abb5b2c\", \"blink_unittests\": \"bd9bb9ad68bb21ac9c49ebd537b313d75607a410\", \"boringssl_crypto_tests\": \"bfa302db322bd510fb080303875a7ec967246175\", \"boringssl_ssl_tests\": \"638402b61f534b93febc6eb4e67576fc34c2d6eb\", \"browser_tests\": \"4404747e5ad0a2e5c380dfdbb8419534973f5c88\", \"capture_unittests\": \"88022062f8d119a51bd95a5a91bcf70c2cede2bc\", \"cast_unittests\": \"8cca4376e7f2dda735c2682a7b0cef9f6c6cdf11\", \"cc_unittests\": \"aeba294dd815db02c622a4cf719117af15bc60ea\", \"chrome_app_unittests\": \"db1b4611694e974851a365321c2b1c11406fd94a\", \"chromedriver_unittests\": \"5b00bbe5767dea48c5b979da851d1663277fde4c\", \"chromeos_components_unittests\": \"1442a7c5f49fcf64a7d99096d5bd745802b01454\", \"chromeos_unittests\": \"13de2b04b310a3682f784cf123659f86c78cec36\", \"components_browsertests\": \"0ac9a03118b2b60fa12d56595baa87dc5548a4bf\", \"components_unittests\": \"bed3edcd4cf4a004ef6282fae9f52394190234c1\", \"compositor_unittests\": \"bd5b590ada04ded99c104268eec17421eea3678a\", \"content_browsertests\": \"c3f04777732a7a8db8ae162a38e66ec5a4ceb115\", \"content_unittests\": \"bbb98de0839c0315153ac4f80a70a2419f768121\", \"crashpad_tests\": \"75b6888a6ccb864bb31f21ba22b9b3acdf96e7e2\", \"crypto_unittests\": \"05b5efcd0e475772e7b1c87d51a2757852934559\", \"dbus_unittests\": \"74754fef2ff7c7bf4d092d9bebb7738488406d4a\", \"device_unittests\": \"d1cf56bb03bb293898b77c03a7d636f8379029e0\", \"display_unittests\": \"80538f77979fbe37dd7625a7f74708341f87c536\", \"events_unittests\": \"4303e899c93ecee70dc76d248b01b0850fa46d58\", \"exo_unittests\": \"ac67b66a610b77993cc627bf5fcd197f84492507\", \"extensions_browsertests\": \"f84d5a277d92c1069c0c18c9580ec5e437cb1882\", \"extensions_unittests\": \"5aabdf278493fe153dc4dbd481c6d3c4af4c328e\", \"filesystem_service_unittests\": \"3efec3debc49a70258ffe1755a947fe995dc0ced\", \"gcm_unit_tests\": \"a8fa09a11c0947d7a9ad7869705d098ffa4ac3e4\", \"gfx_unittests\": \"8d01b48ef61ff6f83ac2610d7f4fa63e261291d8\", \"gin_unittests\": \"e7a7bb2ceaac5b67ae3b32162733aa658b79bb6c\", \"gl_unittests_ozone\": \"63aa104c670f7eb730d3e82ad751ce0123fe61b8\", \"google_apis_unittests\": \"0fe6e0360e9a8699959ea04e6b9db13828d95786\", \"gpu_unittests\": \"500cc1097e082fd0f8aad337fdc297f95f41e703\", \"gwp_asan_unittests\": \"8e86fb568a9ef00dbed1d085b21b36c883ce9f79\", \"interactive_ui_tests\": \"0cc3b0f33f3d59906d6f7047241523d6245373c9\", \"ipc_tests\": \"5b73aa7a901d4edf41a5d92cec043c05c4ce279a\", \"jingle_unittests\": \"d140e96d9f624c3861b0a3129d8bf2d440b0d2a9\", \"keyboard_unittests\": \"2c66719d4a09540fd72abd2c9b6a740b831e2a8d\", \"latency_unittests\": \"ee313b90e08c3714b1d8f03dba95f430e8290a4c\", \"libjingle_xmpp_unittests\": \"525a76d17ec81b3fca08dd5c91a359f44c3a2f7e\", \"liburlpattern_unittests\": \"27c121f45847b7118af410b6144ec8626159d128\", \"media_blink_unittests\": \"fe31812e9d8db8bade13f4252102bc5db228ac1e\", \"media_unittests\": \"2e28149b4c9f8bde6e6e93732c38806324a0c6f2\", \"message_center_unittests\": \"23ea143939f9c76d5a458a4698d340e8f59ea282\", \"midi_unittests\": \"81d686b4f6df91a4ec17f4a6e57412bed6bb20fc\", \"mojo_core_unittests\": \"6239ab80abefeb64fcb86d3a94cf862d6c7b8eea\", \"mojo_unittests\": \"d81918cfcd8aae7168e871d65ac6edd1d40c261f\", \"nacl_helper_nonsfi_unittests\": \"90e650b15f8b6aa411cef5b9369a30f33a0bd43e\", \"nacl_loader_unittests\": \"2679291e2a5e8b56c05297c5d0fd599f7e00dc1a\", \"native_theme_unittests\": \"dc21c7a6e89e7d4ab16de75d2681dac89c81a338\", \"net_unittests\": \"e6fe4e44eed763fa413a1a761477a40d8edfba3a\", \"ozone_gl_unittests\": \"2eddadf2fed1687269aba0ea282d10ee66dbbbc3\", \"ozone_unittests\": \"adc8c39bb0eb3ec3b083b3a262c7b5b66491db56\", \"ozone_x11_unittests\": \"e23615d8fa353ad06dfa534e9e1bbd3664d59a92\", \"pdf_unittests\": \"8255ddb22b5c1dad414bdf5761df4b52773282b0\", \"perfetto_unittests\": \"4f87faad945f8338514e309020378c8edae02240\", \"ppapi_unittests\": \"29089c2a9118be89c8f8299b438a963d9271c6e0\", \"printing_unittests\": \"c7887c628e55dabc7a2d0682859e9ac28cd0f7c8\", \"remoting_unittests\": \"046412ea1c1223b88976a48f44df5e18a6aed1bd\", \"sandbox_linux_unittests\": \"f1dff8bf8dffa022922d128ceb05f435e47f4b68\", \"service_manager_unittests\": \"a3fb47635992d10887bf0ec7671b3752489693e1\", \"services_unittests\": \"47eb3d23de66bff75609be82cca1ced3e8b71fe8\", \"shell_dialogs_unittests\": \"9b337b02ae2701f99a625ce28850bd3f478b2853\", \"shell_encryption_unittests\": \"8a185c94bfdf99e4814c7f78cedc9406240322e7\", \"skia_unittests\": \"13f9f06762c20f25e9563f6dbd0ff479c11bfed6\", \"snapshot_unittests\": \"d355192ccaafb82fed50350a89d8de13a467f9ca\", \"sql_unittests\": \"fc27cde6fa6d7ed22405c445b17d16f75819d98a\", \"storage_unittests\": \"6027d432019c6c209cb54bd749a695de3d3f2465\", \"sync_integration_tests\": \"cf2fbb93a130de6a3fbf098fac9ab331a3bb1ace\", \"traffic_annotation_auditor_unittests\": \"de39be0bdde36184712d13f5b28a83e076eca1b9\", \"ui_base_unittests\": \"8e11b0011164c65d26604f7bc4c168d91dd89fbe\", \"ui_chromeos_unittests\": \"4970fcfa868a2c4199a540ccd7fa1589c8f8d29a\", \"ui_touch_selection_unittests\": \"7996ccb5b817cc17d11e798189e276eba67e6f22\", \"unit_tests\": \"5ad7bfee15e79065ae2eb764d42549ea3fd14b00\", \"url_unittests\": \"a6d47f7f5c13b97a041b45449d3654f201c304e8\", \"usage_time_limit_unittests\": \"dcbee7aa074710399aa2258879f2161723c9fcb4\", \"views_unittests\": \"ad1d58d9d7c2d7db535b33559ea2d6f39c9d61f5\", \"viz_unittests\": \"ea418db2c8f8c9f8d190848ee01b76c0e9171ef0\", \"wm_unittests\": \"b0aa9747c15451a6adaca0e217753195dc1cc89e\", \"wtf_unittests\": \"74d87652eb1d912b7550a0e9c547a9ec026f6c33\", \"zlib_unittests\": \"75e5c672f82ca09ad6aa69fbcb916b10718493be\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_541cf43b1bca5745fae9eb808cc6f212921580c436c428e330e275f831e0e73a_v2\", \"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_abc31495eda36a292af84de2d2556c5a9957390958fb6f471694dbdb8b84ffff_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_c960022844155a7f8e715442a6b4552ebbee25f8ba7e1f4575586223f821653a_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_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-85-y9r2\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogDefaultFilter\\n\\n- TabStripTabListTest.All\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogSingleFilterNoAcceptAll\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607519822911224",
"status": "COMPLETED",
"status_changed_ts": "1607519823497162",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21673",
"builder:linux-chromeos-dbg",
"buildset:commit/git/518e208bfc0ee1bb3ab783f1e8c41651aad067f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/518e208bfc0ee1bb3ab783f1e8c41651aad067f5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026817331025375888",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8861387268887385296/+/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:506073abd3677910",
"user_agent:luci-scheduler"
],
"updated_ts": "1607526044128720",
"url": "https://ci.chromium.org/b/8861387268887385296",
"utcnow_ts": "1607526044552627"
}
}
[15:00:44.565] Invocation finished in 1h47m49.847035926s with status FAILED