[09:17:58.132] New invocation is queued and will start shortly
[09:17:59.261] Starting the invocation (attempt 1)
[09:17:59.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:17:59.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:17:59.338] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020309130801317552",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"35874913f1b700274d8e93fd735243030538cdaf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020309130801317552",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/35874913f1b700274d8e93fd735243030538cdaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35874913f1b700274d8e93fd735243030538cdaf",
"gitiles_ref:refs/heads/master"
]
}
[09:18:00.899] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1613726279529844",
"id": "8854879068675374816",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35874913f1b700274d8e93fd735243030538cdaf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613726280712433",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22692",
"builder:linux-chromeos-dbg",
"buildset:commit/git/35874913f1b700274d8e93fd735243030538cdaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35874913f1b700274d8e93fd735243030538cdaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020309130801317552",
"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/8854879068675374816/+/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": "1613726280712549",
"url": "https://ci.chromium.org/b/8854879068675374816",
"utcnow_ts": "1613726280891209"
}
}
[09:18:00.899] Task URL: https://ci.chromium.org/b/8854879068675374816
[09:18:00.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:2:0) after 1m0s
[09:18:16.179] Received PubSub notification, asking Buildbucket for the build status
[09:18:16.377] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:00.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:2:0)
[09:19:00.931] Timer tick, asking Buildbucket for the build status
[09:19:01.146] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:01.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:4:0) after 1m0s
[09:20:02.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:4:0)
[09:20:02.607] Timer tick, asking Buildbucket for the build status
[09:20:03.009] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:03.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:5:0) after 1m0s
[09:21:03.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:5:0)
[09:21:03.168] Timer tick, asking Buildbucket for the build status
[09:21:03.346] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:03.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:6:0) after 1m0s
[09:22:03.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:6:0)
[09:22:03.391] Timer tick, asking Buildbucket for the build status
[09:22:03.634] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:03.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:7:0) after 1m0s
[09:23:03.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:7:0)
[09:23:03.622] Timer tick, asking Buildbucket for the build status
[09:23:03.717] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:03.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:8:0) after 1m0s
[09:24:03.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:8:0)
[09:24:03.741] Timer tick, asking Buildbucket for the build status
[09:24:03.809] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:9:0) after 1m0s
[09:25:03.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:9:0)
[09:25:03.860] Timer tick, asking Buildbucket for the build status
[09:25:03.951] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:03.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:10:0) after 1m0s
[09:26:04.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:10:0)
[09:26:04.050] Timer tick, asking Buildbucket for the build status
[09:26:04.315] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:04.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:11:0) after 1m0s
[09:27:04.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:11:0)
[09:27:04.334] Timer tick, asking Buildbucket for the build status
[09:27:04.418] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:04.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:12:0) after 1m0s
[09:28:04.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:12:0)
[09:28:04.884] Timer tick, asking Buildbucket for the build status
[09:28:05.049] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:05.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:13:0) after 1m0s
[09:29:05.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:13:0)
[09:29:05.169] Timer tick, asking Buildbucket for the build status
[09:29:05.264] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:05.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:14:0) after 1m0s
[09:30:05.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:14:0)
[09:30:05.487] Timer tick, asking Buildbucket for the build status
[09:30:05.557] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:05.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:15:0) after 1m0s
[09:31:06.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:15:0)
[09:31:06.256] Timer tick, asking Buildbucket for the build status
[09:31:06.341] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:06.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:16:0) after 1m0s
[09:32:06.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:16:0)
[09:32:06.502] Timer tick, asking Buildbucket for the build status
[09:32:06.875] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:06.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:17:0) after 1m0s
[09:33:06.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:17:0)
[09:33:06.899] Timer tick, asking Buildbucket for the build status
[09:33:06.999] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:06.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:18:0) after 1m0s
[09:34:07.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:18:0)
[09:34:07.219] Timer tick, asking Buildbucket for the build status
[09:34:07.365] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:07.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:19:0) after 1m0s
[09:35:07.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:19:0)
[09:35:07.487] Timer tick, asking Buildbucket for the build status
[09:35:07.554] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:07.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:20:0) after 1m0s
[09:36:07.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:20:0)
[09:36:07.773] Timer tick, asking Buildbucket for the build status
[09:36:07.853] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:07.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:21:0) after 1m0s
[09:37:07.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:21:0)
[09:37:07.953] Timer tick, asking Buildbucket for the build status
[09:37:08.068] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:08.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:22:0) after 1m0s
[09:38:08.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:22:0)
[09:38:08.291] Timer tick, asking Buildbucket for the build status
[09:38:08.386] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:08.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:23:0) after 1m0s
[09:39:08.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:23:0)
[09:39:08.390] Timer tick, asking Buildbucket for the build status
[09:39:08.490] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:08.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:24:0) after 1m0s
[09:40:08.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:24:0)
[09:40:08.531] Timer tick, asking Buildbucket for the build status
[09:40:08.599] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:08.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:25:0) after 1m0s
[09:41:08.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:25:0)
[09:41:08.704] Timer tick, asking Buildbucket for the build status
[09:41:08.776] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:08.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:26:0) after 1m0s
[09:42:08.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:26:0)
[09:42:08.837] Timer tick, asking Buildbucket for the build status
[09:42:08.951] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:08.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:27:0) after 1m0s
[09:43:08.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:27:0)
[09:43:08.925] Timer tick, asking Buildbucket for the build status
[09:43:09.025] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:09.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:28:0) after 1m0s
[09:44:09.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:28:0)
[09:44:09.058] Timer tick, asking Buildbucket for the build status
[09:44:09.128] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:09.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:29:0) after 1m0s
[09:45:09.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:29:0)
[09:45:09.150] Timer tick, asking Buildbucket for the build status
[09:45:09.242] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:09.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:30:0) after 1m0s
[09:46:09.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:30:0)
[09:46:09.256] Timer tick, asking Buildbucket for the build status
[09:46:09.322] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:09.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:31:0) after 1m0s
[09:47:09.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:31:0)
[09:47:09.392] Timer tick, asking Buildbucket for the build status
[09:47:09.551] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:09.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:32:0) after 1m0s
[09:48:09.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:32:0)
[09:48:09.645] Timer tick, asking Buildbucket for the build status
[09:48:09.737] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:09.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:33:0) after 1m0s
[09:49:09.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:33:0)
[09:49:09.792] Timer tick, asking Buildbucket for the build status
[09:49:09.874] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:09.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:34:0) after 1m0s
[09:50:09.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:34:0)
[09:50:09.918] Timer tick, asking Buildbucket for the build status
[09:50:09.993] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:09.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:35:0) after 1m0s
[09:51:10.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:35:0)
[09:51:10.058] Timer tick, asking Buildbucket for the build status
[09:51:10.127] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:10.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:36:0) after 1m0s
[09:52:10.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:36:0)
[09:52:10.185] Timer tick, asking Buildbucket for the build status
[09:52:10.250] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:10.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:37:0) after 1m0s
[09:53:10.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:37:0)
[09:53:10.303] Timer tick, asking Buildbucket for the build status
[09:53:10.480] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:10.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:38:0) after 1m0s
[09:54:10.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:38:0)
[09:54:10.542] Timer tick, asking Buildbucket for the build status
[09:54:10.627] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:10.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:39:0) after 1m0s
[09:55:10.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:39:0)
[09:55:10.694] Timer tick, asking Buildbucket for the build status
[09:55:10.839] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:10.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:40:0) after 1m0s
[09:56:10.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:40:0)
[09:56:10.852] Timer tick, asking Buildbucket for the build status
[09:56:10.944] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:10.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:41:0) after 1m0s
[09:57:11.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:41:0)
[09:57:11.000] Timer tick, asking Buildbucket for the build status
[09:57:11.319] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:11.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:42:0) after 1m0s
[09:58:11.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:42:0)
[09:58:11.370] Timer tick, asking Buildbucket for the build status
[09:58:11.625] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:11.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:43:0) after 1m0s
[09:59:11.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:43:0)
[09:59:11.679] Timer tick, asking Buildbucket for the build status
[09:59:11.762] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:11.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:44:0) after 1m0s
[10:00:11.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:44:0)
[10:00:11.773] Timer tick, asking Buildbucket for the build status
[10:00:11.855] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:11.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:45:0) after 1m0s
[10:01:11.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:45:0)
[10:01:11.952] Timer tick, asking Buildbucket for the build status
[10:01:12.046] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:12.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:46:0) after 1m0s
[10:02:12.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:46:0)
[10:02:12.064] Timer tick, asking Buildbucket for the build status
[10:02:12.165] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:12.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:47:0) after 1m0s
[10:03:12.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:47:0)
[10:03:12.192] Timer tick, asking Buildbucket for the build status
[10:03:12.297] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:12.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:48:0) after 1m0s
[10:04:12.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:48:0)
[10:04:12.320] Timer tick, asking Buildbucket for the build status
[10:04:12.540] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:12.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:49:0) after 1m0s
[10:05:12.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:49:0)
[10:05:12.530] Timer tick, asking Buildbucket for the build status
[10:05:12.797] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:12.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:50:0) after 1m0s
[10:06:12.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:50:0)
[10:06:12.869] Timer tick, asking Buildbucket for the build status
[10:06:12.953] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:12.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:51:0) after 1m0s
[10:07:12.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:51:0)
[10:07:12.988] Timer tick, asking Buildbucket for the build status
[10:07:13.130] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:13.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:52:0) after 1m0s
[10:08:13.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:52:0)
[10:08:13.186] Timer tick, asking Buildbucket for the build status
[10:08:13.343] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:13.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:53:0) after 1m0s
[10:09:13.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:53:0)
[10:09:13.404] Timer tick, asking Buildbucket for the build status
[10:09:13.490] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:13.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:54:0) after 1m0s
[10:10:13.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:54:0)
[10:10:13.511] Timer tick, asking Buildbucket for the build status
[10:10:13.675] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:13.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:55:0) after 1m0s
[10:11:13.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:55:0)
[10:11:13.787] Timer tick, asking Buildbucket for the build status
[10:11:13.861] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:13.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:56:0) after 1m0s
[10:12:14.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:56:0)
[10:12:14.049] Timer tick, asking Buildbucket for the build status
[10:12:14.134] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:57:0) after 1m0s
[10:13:14.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:57:0)
[10:13:14.251] Timer tick, asking Buildbucket for the build status
[10:13:14.714] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:14.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:58:0) after 1m0s
[10:14:14.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:58:0)
[10:14:14.760] Timer tick, asking Buildbucket for the build status
[10:14:14.846] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:14.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:59:0) after 1m0s
[10:15:14.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:59:0)
[10:15:14.903] Timer tick, asking Buildbucket for the build status
[10:15:14.981] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:14.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:60:0) after 1m0s
[10:16:15.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:60:0)
[10:16:15.058] Timer tick, asking Buildbucket for the build status
[10:16:15.157] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:61:0) after 1m0s
[10:17:15.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:61:0)
[10:17:15.235] Timer tick, asking Buildbucket for the build status
[10:17:15.333] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:15.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:62:0) after 1m0s
[10:18:15.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:62:0)
[10:18:15.426] Timer tick, asking Buildbucket for the build status
[10:18:15.529] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:15.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:63:0) after 1m0s
[10:19:15.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:63:0)
[10:19:15.558] Timer tick, asking Buildbucket for the build status
[10:19:15.635] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:15.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:64:0) after 1m0s
[10:20:15.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:64:0)
[10:20:15.756] Timer tick, asking Buildbucket for the build status
[10:20:16.011] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:16.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:65:0) after 1m0s
[10:21:16.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:65:0)
[10:21:16.027] Timer tick, asking Buildbucket for the build status
[10:21:16.097] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:16.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:66:0) after 1m0s
[10:22:16.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:66:0)
[10:22:16.161] Timer tick, asking Buildbucket for the build status
[10:22:16.339] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:16.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:67:0) after 1m0s
[10:23:16.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:67:0)
[10:23:16.350] Timer tick, asking Buildbucket for the build status
[10:23:16.657] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:16.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:68:0) after 1m0s
[10:24:16.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:68:0)
[10:24:16.744] Timer tick, asking Buildbucket for the build status
[10:24:16.816] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:16.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:69:0) after 1m0s
[10:25:16.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:69:0)
[10:25:16.897] Timer tick, asking Buildbucket for the build status
[10:25:17.079] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:17.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:70:0) after 1m0s
[10:26:17.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:70:0)
[10:26:17.304] Timer tick, asking Buildbucket for the build status
[10:26:17.492] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:17.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:71:0) after 1m0s
[10:27:17.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:71:0)
[10:27:17.623] Timer tick, asking Buildbucket for the build status
[10:27:17.701] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:17.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:72:0) after 1m0s
[10:28:17.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:72:0)
[10:28:17.808] Timer tick, asking Buildbucket for the build status
[10:28:17.986] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:17.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:73:0) after 1m0s
[10:29:18.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:73:0)
[10:29:18.077] Timer tick, asking Buildbucket for the build status
[10:29:18.152] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:18.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:74:0) after 1m0s
[10:30:18.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:74:0)
[10:30:18.201] Timer tick, asking Buildbucket for the build status
[10:30:18.274] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:18.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:75:0) after 1m0s
[10:31:18.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:75:0)
[10:31:18.314] Timer tick, asking Buildbucket for the build status
[10:31:18.411] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:18.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:76:0) after 1m0s
[10:32:18.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:76:0)
[10:32:18.467] Timer tick, asking Buildbucket for the build status
[10:32:18.632] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:18.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:77:0) after 1m0s
[10:33:18.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:77:0)
[10:33:18.610] Timer tick, asking Buildbucket for the build status
[10:33:18.918] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:18.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:78:0) after 1m0s
[10:34:18.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:78:0)
[10:34:18.900] Timer tick, asking Buildbucket for the build status
[10:34:19.081] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:19.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:79:0) after 1m0s
[10:35:19.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:79:0)
[10:35:19.107] Timer tick, asking Buildbucket for the build status
[10:35:19.217] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:19.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:80:0) after 1m0s
[10:36:19.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:80:0)
[10:36:19.267] Timer tick, asking Buildbucket for the build status
[10:36:19.356] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:19.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:81:0) after 1m0s
[10:37:19.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:81:0)
[10:37:19.343] Timer tick, asking Buildbucket for the build status
[10:37:19.416] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:19.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:82:0) after 1m0s
[10:38:19.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:82:0)
[10:38:19.436] Timer tick, asking Buildbucket for the build status
[10:38:19.575] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:19.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:83:0) after 1m0s
[10:39:19.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:83:0)
[10:39:19.715] Timer tick, asking Buildbucket for the build status
[10:39:19.814] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:19.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:84:0) after 1m0s
[10:40:19.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:84:0)
[10:40:19.925] Timer tick, asking Buildbucket for the build status
[10:40:20.015] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:20.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:85:0) after 1m0s
[10:41:20.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:85:0)
[10:41:20.096] Timer tick, asking Buildbucket for the build status
[10:41:20.181] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:20.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:86:0) after 1m0s
[10:42:20.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:86:0)
[10:42:20.241] Timer tick, asking Buildbucket for the build status
[10:42:20.330] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:20.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:87:0) after 1m0s
[10:43:20.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:87:0)
[10:43:20.365] Timer tick, asking Buildbucket for the build status
[10:43:20.483] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:20.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:88:0) after 1m0s
[10:44:20.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:88:0)
[10:44:20.544] Timer tick, asking Buildbucket for the build status
[10:44:20.623] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:20.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:89:0) after 1m0s
[10:45:20.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:89:0)
[10:45:20.721] Timer tick, asking Buildbucket for the build status
[10:45:24.363] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:24.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:90:0) after 1m0s
[10:46:24.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:90:0)
[10:46:24.368] Timer tick, asking Buildbucket for the build status
[10:46:24.447] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:24.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:91:0) after 1m0s
[10:47:24.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:91:0)
[10:47:24.569] Timer tick, asking Buildbucket for the build status
[10:47:24.809] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:24.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:92:0) after 1m0s
[10:48:24.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:92:0)
[10:48:24.841] Timer tick, asking Buildbucket for the build status
[10:48:24.951] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:24.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:93:0) after 1m0s
[10:49:25.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:93:0)
[10:49:25.368] Timer tick, asking Buildbucket for the build status
[10:49:25.458] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:25.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:94:0) after 1m0s
[10:50:25.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:94:0)
[10:50:25.567] Timer tick, asking Buildbucket for the build status
[10:50:25.819] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:25.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:95:0) after 1m0s
[10:51:25.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:95:0)
[10:51:25.882] Timer tick, asking Buildbucket for the build status
[10:51:26.004] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:26.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:96:0) after 1m0s
[10:52:26.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:96:0)
[10:52:26.140] Timer tick, asking Buildbucket for the build status
[10:52:26.215] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:26.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:97:0) after 1m0s
[10:53:26.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:97:0)
[10:53:26.371] Timer tick, asking Buildbucket for the build status
[10:53:26.543] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:26.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:98:0) after 1m0s
[10:54:26.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:98:0)
[10:54:26.633] Timer tick, asking Buildbucket for the build status
[10:54:26.930] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:26.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:99:0) after 1m0s
[10:55:27.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:99:0)
[10:55:27.102] Timer tick, asking Buildbucket for the build status
[10:55:27.206] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:27.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:100:0) after 1m0s
[10:56:27.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:100:0)
[10:56:27.513] Timer tick, asking Buildbucket for the build status
[10:56:28.009] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:28.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:101:0) after 1m0s
[10:57:28.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:101:0)
[10:57:28.126] Timer tick, asking Buildbucket for the build status
[10:57:28.246] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:28.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:102:0) after 1m0s
[10:58:29.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:102:0)
[10:58:29.646] Timer tick, asking Buildbucket for the build status
[10:58:29.763] Build 8854879068675374816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:29.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020309130801317552:103:0) after 1m0s
[10:59:22.809] Received PubSub notification, asking Buildbucket for the build status
[10:59:22.900] Build 8854879068675374816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:59:22.900] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613732361989270",
"created_by": "project:chromium",
"created_ts": "1613726279529844",
"id": "8854879068675374816",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35874913f1b700274d8e93fd735243030538cdaf\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"35874913f1b700274d8e93fd735243030538cdaf\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-184-d4lj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22692, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"35874913f1b700274d8e93fd735243030538cdaf\", \"got_revision_cp\": \"refs/heads/master@{#855658}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35874913f1b700274d8e93fd735243030538cdaf\", \"swarm_hashes_refs/heads/master(at){#855658}_without_patch\": {\"absl_hardening_tests\": \"08d529fd8efef657c31d7b0b5b47a7490516f6fd\", \"accessibility_unittests\": \"2177e6e861b83bf345c252f2ba4e57bef40a8de4\", \"angle_unittests\": \"6b319ff85e29af979a79f9ea497ff0fd094fb653\", \"app_list_unittests\": \"4309194975323a6c4fc2b364ea0668cfb5c22335\", \"app_shell_unittests\": \"d2f6f4767d0f5159f4cd2a0f66f5ff70e4e052ff\", \"ash_unittests\": \"0845b6119356f3e43cdeba4dbf9fb5be7cfb2b80\", \"aura_unittests\": \"18ab727afea48b1edfec8003495ecdf82ac34079\", \"base_unittests\": \"873674bc781c9cd358531d92bf19cc9849f9af85\", \"base_util_unittests\": \"e10749f7f8c3ec00ac4666d738c6b4767940487d\", \"blink_common_unittests\": \"4e549574b3fd2bb81f78750a9fc1a26549b091ff\", \"blink_fuzzer_unittests\": \"4619e2a52389a7d2462fe4d951c1aef0588f9aeb\", \"blink_heap_unittests\": \"873e04850c65fd6c0966d53784844b882985ba3b\", \"blink_platform_unittests\": \"7552508b1c5719012f89a0dc4fdf2f82a95cacea\", \"blink_unittests\": \"f8e1a72450b9b6a9b2a52435bacb56b24cd63d69\", \"boringssl_crypto_tests\": \"2b08dd083e7d93921cd02b3f2dac198046e06483\", \"boringssl_ssl_tests\": \"3d0609a354d2721560f9b03acbcadbf828bf986a\", \"browser_tests\": \"c3bab67216a55ced813d969007d7835c1ea1c5e5\", \"capture_unittests\": \"d23481b47015c6d64e9bbcd74c9f2fed61e0e5d2\", \"cast_unittests\": \"565844e0b809d9c5461451cd168a0cf66a486543\", \"cc_unittests\": \"1914d6183d14c0d00f4ca9c501d7687feee8f391\", \"chrome_app_unittests\": \"033b541fe203c6066d8b80e120fbb6a7b3d97362\", \"chromedriver_unittests\": \"eb74ceab4b76e3f5f3841b615c1aae05bdfa352d\", \"chromeos_components_unittests\": \"d7b2af5678015aa16c90c3769873cf34a4f6d564\", \"chromeos_unittests\": \"163dc543ccc1b02d9ddc929fd4d4005d8be3c8bb\", \"components_browsertests\": \"fb5228d13be354875dd5f3a914898d6da55b9c93\", \"components_unittests\": \"2447dd076cd9a3da219397f30205106bbd1b4a6c\", \"compositor_unittests\": \"11cc46c324dec7d7c249e9a8d683548497f9b71d\", \"content_browsertests\": \"a5d87cdd3f4d1a5154b27c3771f928057f33db5a\", \"content_unittests\": \"6f4fe11992a440711b3be9aa2e3d3a0271e11305\", \"crashpad_tests\": \"27997f45133f02f064b3b6a23f29235ffa96ebbb\", \"crypto_unittests\": \"379e433c63d1c03a3203eca7c04be5def2a2a003\", \"dbus_unittests\": \"c542855bf1b345d7461592a1e22a6780ab7a0133\", \"device_unittests\": \"9b0cea2ef6d529eb3d9c52038412923a27d69367\", \"display_unittests\": \"6b581b9f31aa95948604290dcc33d01b38f48685\", \"events_unittests\": \"96a52dd3d968fc35307e29e489af554facb1217b\", \"exo_unittests\": \"6a73db2f440b187343943a3fa18d5237f07be303\", \"extensions_browsertests\": \"1a530491dfe6f13f17d08c6227d63c30403d0d0e\", \"extensions_unittests\": \"44a71a524e147ec0963555ee1cba6547230d98b4\", \"filesystem_service_unittests\": \"e87fbcab74702f9d2a29ea675001da746e297b8c\", \"gcm_unit_tests\": \"9885301bec084418539ff7272e9de5c397bb74eb\", \"gfx_unittests\": \"3715b05f9c10b8744f3809d14f0c48abaaa86d95\", \"gin_unittests\": \"fee90a19e5793c4346caf4e04b2b81afaf7f2323\", \"gl_unittests_ozone\": \"e136248b8cbeb1425497298fd72e38f70ec2b06e\", \"google_apis_unittests\": \"505bbc24c845afd9b68d68870e62ccc71aa8b1ce\", \"gpu_unittests\": \"bc1a30b60fb703ca341c2222cb6beda58e3855ab\", \"gwp_asan_unittests\": \"97d54cf59399b18ec23c240079df03051f6ca312\", \"interactive_ui_tests\": \"4cc84650caf51163f489aabd6353e9a3fea5af3d\", \"ipc_tests\": \"73acffccf83a7a75241c08d595fe78fa578761ed\", \"jingle_unittests\": \"17d2c5ac2cedbfec5f3195658ad011b622f553e1\", \"keyboard_unittests\": \"0844292c4a30dc74ede37aa0c6af2264b00016fb\", \"latency_unittests\": \"252f63af5a7edef2639d6fb9f91acfa5e2340e67\", \"libjingle_xmpp_unittests\": \"b954431aecda9f934c2d0d30e45f2efd95ae549c\", \"liburlpattern_unittests\": \"e634211c6dfb4a7524649139af8881578fae15d2\", \"media_blink_unittests\": \"f37d335a29ff62650e5a6c0aa5febec76065e60c\", \"media_unittests\": \"1e56fa905a26b38b28d75c3638706d9059efde96\", \"message_center_unittests\": \"c7748275f7f8f3d0443a61964c8476c244013832\", \"midi_unittests\": \"95cdb153522ad141c098f3985b76d5554eaf6632\", \"mojo_core_unittests\": \"b7f70cec2bdfbacc73c6f6a99c8b45f156d51a09\", \"mojo_unittests\": \"a45f5fec659afba0597a4f97b6bd31a965e17ae4\", \"nacl_helper_nonsfi_unittests\": \"2ef6d946829815e6ac61a5b88544a5d895f5f6c4\", \"nacl_loader_unittests\": \"2c871395a7c6426159627ce88e0df9f34a54c8fe\", \"native_theme_unittests\": \"f1e09c7e05674f6b45ce3cba51e1c212f776ed31\", \"net_unittests\": \"b7839ca0a7274dc361050b02499c0a4d64e4499f\", \"ozone_gl_unittests\": \"4f3fac4e61fd24fd7cbccd150841d4b03c262a05\", \"ozone_unittests\": \"1b0c5c6335338fe74bbb80009cddd81c08763079\", \"ozone_x11_unittests\": \"25e5f89201de66cf13bd9e5ce4e59d916b257009\", \"pdf_unittests\": \"97163b710654102464436292c5b6980230ca87e4\", \"perfetto_unittests\": \"18193b565bdd4f23c104f3e6a4db17718ef047b8\", \"ppapi_unittests\": \"268118e55fa8b6eddc785482db4f8b81d58821be\", \"printing_unittests\": \"906dddee3ecfbe5c8e39cd782553d9d35beff3af\", \"remoting_unittests\": \"4115181e1d8747642229c24ead76db021c825f67\", \"sandbox_linux_unittests\": \"acc1529146a2f3168889148bda6b1ada57728269\", \"service_manager_unittests\": \"8b7217a34a93333e0989a1076042d49e942d265a\", \"services_unittests\": \"43073da0abfc9961a97c26f1838c85231a4aa736\", \"shell_dialogs_unittests\": \"dbd7e32d3a5f5d1f18a81743b569a84612aecdac\", \"shell_encryption_unittests\": \"b7cc01f722e072dbfc8ed97c2f96ddbe811c856d\", \"skia_unittests\": \"4fc4918dc71bb9bffbb6ca44deac92cdc1c231ce\", \"snapshot_unittests\": \"fee0136f63dc9c0e13775508fc79f1bd679a95be\", \"sql_unittests\": \"d4b3c54351c74c083edbb09b9194e2aa5767b9ac\", \"storage_unittests\": \"82467f565ddf2955babbecc7054d8129aadcda2f\", \"sync_integration_tests\": \"949f4e5f79cf3eef9048993aa8ad9499894fe276\", \"traffic_annotation_auditor_unittests\": \"e0ab9f90def5e84a59f77acff52bf0ce4fb44e58\", \"ui_base_unittests\": \"dea53b1f9fccf249f2a275151d884d0687eac513\", \"ui_chromeos_unittests\": \"30ffba8c8f1a0ad6e4c3b95ac7da47ede639617f\", \"ui_touch_selection_unittests\": \"f9238f749da2a0b07f0d7e1a70df36fe431b5d62\", \"unit_tests\": \"796808ce4042debdf7feff2e7259321d4dbc149b\", \"url_unittests\": \"5c9a9c37476b44d502ad17570ec02dc09189c761\", \"usage_time_limit_unittests\": \"691a46246e4a02b0da093f7e292da393060ef6f4\", \"views_unittests\": \"7cecc80136ed60bf2fc555ec347b8f5721f2f4ba\", \"viz_unittests\": \"3ad07806fd67b8f5bfef23edcb9e2a591fa3afdf\", \"wm_unittests\": \"0e25ec04f01adb57904dd660f4916fee6614fcfe\", \"wtf_unittests\": \"e73a9914d484071d0bb29dfc3ec77d16129a62fb\", \"zlib_unittests\": \"1f3118f3c08623fba20d16dbd68cf9ffb28f9639\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_c07e1e1c2cdac716be0d96bd7f13cbf51acf1625d4d630d38cc920010d58defe_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-184-d4lj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613726295442952",
"status": "COMPLETED",
"status_changed_ts": "1613732362409442",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22692",
"builder:linux-chromeos-dbg",
"buildset:commit/git/35874913f1b700274d8e93fd735243030538cdaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35874913f1b700274d8e93fd735243030538cdaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020309130801317552",
"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/8854879068675374816/+/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:51d266755dcd7210",
"user_agent:luci-scheduler"
],
"updated_ts": "1613732362416958",
"url": "https://ci.chromium.org/b/8854879068675374816",
"utcnow_ts": "1613732362891002"
}
}
[10:59:22.900] Invocation finished in 1h41m24.783402837s with status SUCCEEDED