[00:11:11.923] New invocation is queued and will start shortly
[00:11:13.188] Starting the invocation (attempt 1)
[00:11:13.268] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:11:13.268] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:11:13.268] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018531591277937424",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0f53bb3848d00835f00380dc71c34cf56281b886\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018531591277937424",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/0f53bb3848d00835f00380dc71c34cf56281b886",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f53bb3848d00835f00380dc71c34cf56281b886",
"gitiles_ref:refs/heads/master"
]
}
[00:11:14.560] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615421473392797",
"id": "8853101529074924304",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f53bb3848d00835f00380dc71c34cf56281b886\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615421474241105",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22943",
"builder:linux-chromeos-dbg",
"buildset:commit/git/0f53bb3848d00835f00380dc71c34cf56281b886",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f53bb3848d00835f00380dc71c34cf56281b886",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018531591277937424",
"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/8853101529074924304/+/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": "1615421474241225",
"url": "https://ci.chromium.org/b/8853101529074924304",
"utcnow_ts": "1615421474540630"
}
}
[00:11:14.560] Task URL: https://ci.chromium.org/b/8853101529074924304
[00:11:14.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:2:0) after 1m0s
[00:11:20.730] Received PubSub notification, asking Buildbucket for the build status
[00:11:20.822] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:14.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:2:0)
[00:12:14.654] Timer tick, asking Buildbucket for the build status
[00:12:14.759] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:14.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:4:0) after 1m0s
[00:13:14.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:4:0)
[00:13:14.765] Timer tick, asking Buildbucket for the build status
[00:13:14.887] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:14.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:5:0) after 1m0s
[00:14:14.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:5:0)
[00:14:14.968] Timer tick, asking Buildbucket for the build status
[00:14:15.039] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:15.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:6:0) after 1m0s
[00:15:15.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:6:0)
[00:15:15.130] Timer tick, asking Buildbucket for the build status
[00:15:15.221] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:15.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:7:0) after 1m0s
[00:16:15.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:7:0)
[00:16:15.292] Timer tick, asking Buildbucket for the build status
[00:16:15.371] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:15.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:8:0) after 1m0s
[00:17:15.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:8:0)
[00:17:15.562] Timer tick, asking Buildbucket for the build status
[00:17:15.704] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:15.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:9:0) after 1m0s
[00:18:15.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:9:0)
[00:18:15.738] Timer tick, asking Buildbucket for the build status
[00:18:16.063] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:16.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:10:0) after 1m0s
[00:19:16.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:10:0)
[00:19:16.086] Timer tick, asking Buildbucket for the build status
[00:19:16.196] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:16.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:11:0) after 1m0s
[00:20:16.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:11:0)
[00:20:16.188] Timer tick, asking Buildbucket for the build status
[00:20:16.272] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:16.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:12:0) after 1m0s
[00:21:16.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:12:0)
[00:21:16.679] Timer tick, asking Buildbucket for the build status
[00:21:16.813] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:16.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:13:0) after 1m0s
[00:22:16.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:13:0)
[00:22:16.908] Timer tick, asking Buildbucket for the build status
[00:22:16.977] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:16.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:14:0) after 1m0s
[00:23:17.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:14:0)
[00:23:17.085] Timer tick, asking Buildbucket for the build status
[00:23:17.204] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:17.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:15:0) after 1m0s
[00:24:17.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:15:0)
[00:24:17.416] Timer tick, asking Buildbucket for the build status
[00:24:17.486] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:17.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:16:0) after 1m0s
[00:25:17.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:16:0)
[00:25:17.636] Timer tick, asking Buildbucket for the build status
[00:25:17.707] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:17.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:17:0) after 1m0s
[00:26:18.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:17:0)
[00:26:18.027] Timer tick, asking Buildbucket for the build status
[00:26:18.220] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:18.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:18:0) after 1m0s
[00:27:18.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:18:0)
[00:27:18.374] Timer tick, asking Buildbucket for the build status
[00:27:18.439] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:18.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:19:0) after 1m0s
[00:28:18.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:19:0)
[00:28:18.514] Timer tick, asking Buildbucket for the build status
[00:28:18.808] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:18.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:20:0) after 1m0s
[00:29:18.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:20:0)
[00:29:18.916] Timer tick, asking Buildbucket for the build status
[00:29:19.382] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:19.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:21:0) after 1m0s
[00:30:19.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:21:0)
[00:30:19.399] Timer tick, asking Buildbucket for the build status
[00:30:19.531] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:19.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:22:0) after 1m0s
[00:31:19.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:22:0)
[00:31:19.611] Timer tick, asking Buildbucket for the build status
[00:31:19.702] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:19.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:23:0) after 1m0s
[00:32:19.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:23:0)
[00:32:19.724] Timer tick, asking Buildbucket for the build status
[00:32:19.818] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:19.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:24:0) after 1m0s
[00:33:19.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:24:0)
[00:33:19.823] Timer tick, asking Buildbucket for the build status
[00:33:19.898] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:25:0) after 1m0s
[00:34:19.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:25:0)
[00:34:19.970] Timer tick, asking Buildbucket for the build status
[00:34:20.064] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:20.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:26:0) after 1m0s
[00:35:20.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:26:0)
[00:35:20.045] Timer tick, asking Buildbucket for the build status
[00:35:20.210] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:20.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:27:0) after 1m0s
[00:36:20.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:27:0)
[00:36:20.213] Timer tick, asking Buildbucket for the build status
[00:36:20.297] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:20.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:28:0) after 1m0s
[00:37:20.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:28:0)
[00:37:20.320] Timer tick, asking Buildbucket for the build status
[00:37:20.415] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:20.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:29:0) after 1m0s
[00:38:20.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:29:0)
[00:38:20.467] Timer tick, asking Buildbucket for the build status
[00:38:20.535] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:20.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:30:0) after 1m0s
[00:39:20.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:30:0)
[00:39:20.629] Timer tick, asking Buildbucket for the build status
[00:39:20.751] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:20.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:31:0) after 1m0s
[00:40:20.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:31:0)
[00:40:20.773] Timer tick, asking Buildbucket for the build status
[00:40:20.873] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:20.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:32:0) after 1m0s
[00:41:20.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:32:0)
[00:41:20.854] Timer tick, asking Buildbucket for the build status
[00:41:20.942] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:20.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:33:0) after 1m0s
[00:42:21.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:33:0)
[00:42:21.030] Timer tick, asking Buildbucket for the build status
[00:42:21.104] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:21.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:34:0) after 1m0s
[00:43:21.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:34:0)
[00:43:21.195] Timer tick, asking Buildbucket for the build status
[00:43:21.266] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:21.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:35:0) after 1m0s
[00:44:21.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:35:0)
[00:44:21.351] Timer tick, asking Buildbucket for the build status
[00:44:21.434] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:21.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:36:0) after 1m0s
[00:45:21.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:36:0)
[00:45:21.541] Timer tick, asking Buildbucket for the build status
[00:45:21.630] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:21.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:37:0) after 1m0s
[00:46:21.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:37:0)
[00:46:21.627] Timer tick, asking Buildbucket for the build status
[00:46:21.714] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:21.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:38:0) after 1m0s
[00:47:21.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:38:0)
[00:47:21.838] Timer tick, asking Buildbucket for the build status
[00:47:22.150] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:22.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:39:0) after 1m0s
[00:48:22.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:39:0)
[00:48:22.299] Timer tick, asking Buildbucket for the build status
[00:48:22.371] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:22.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:40:0) after 1m0s
[00:49:22.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:40:0)
[00:49:22.511] Timer tick, asking Buildbucket for the build status
[00:49:22.583] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:22.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:41:0) after 1m0s
[00:50:22.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:41:0)
[00:50:22.726] Timer tick, asking Buildbucket for the build status
[00:50:22.835] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:22.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:42:0) after 1m0s
[00:51:22.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:42:0)
[00:51:22.863] Timer tick, asking Buildbucket for the build status
[00:51:23.247] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:23.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:43:0) after 1m0s
[00:52:23.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:43:0)
[00:52:23.335] Timer tick, asking Buildbucket for the build status
[00:52:23.433] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:23.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:44:0) after 1m0s
[00:53:23.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:44:0)
[00:53:23.447] Timer tick, asking Buildbucket for the build status
[00:53:23.941] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:45:0) after 1m0s
[00:54:23.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:45:0)
[00:54:23.921] Timer tick, asking Buildbucket for the build status
[00:54:24.019] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:24.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:46:0) after 1m0s
[00:55:24.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:46:0)
[00:55:24.065] Timer tick, asking Buildbucket for the build status
[00:55:24.148] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:24.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:47:0) after 1m0s
[00:56:24.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:47:0)
[00:56:24.269] Timer tick, asking Buildbucket for the build status
[00:56:24.354] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:24.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:48:0) after 1m0s
[00:57:24.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:48:0)
[00:57:24.466] Timer tick, asking Buildbucket for the build status
[00:57:24.552] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:24.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:49:0) after 1m0s
[00:58:24.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:49:0)
[00:58:24.567] Timer tick, asking Buildbucket for the build status
[00:58:24.697] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:24.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:50:0) after 1m0s
[00:59:24.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:50:0)
[00:59:24.717] Timer tick, asking Buildbucket for the build status
[00:59:24.804] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:24.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:51:0) after 1m0s
[01:00:24.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:51:0)
[01:00:24.884] Timer tick, asking Buildbucket for the build status
[01:00:24.982] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:24.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:52:0) after 1m0s
[01:01:25.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:52:0)
[01:01:25.015] Timer tick, asking Buildbucket for the build status
[01:01:25.117] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:53:0) after 1m0s
[01:02:25.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:53:0)
[01:02:25.163] Timer tick, asking Buildbucket for the build status
[01:02:25.264] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:25.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:54:0) after 1m0s
[01:03:25.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:54:0)
[01:03:25.283] Timer tick, asking Buildbucket for the build status
[01:03:25.375] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:25.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:55:0) after 1m0s
[01:04:25.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:55:0)
[01:04:25.380] Timer tick, asking Buildbucket for the build status
[01:04:25.481] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:25.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:56:0) after 1m0s
[01:05:25.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:56:0)
[01:05:25.530] Timer tick, asking Buildbucket for the build status
[01:05:25.609] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:25.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:57:0) after 1m0s
[01:06:25.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:57:0)
[01:06:25.626] Timer tick, asking Buildbucket for the build status
[01:06:25.883] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:25.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:58:0) after 1m0s
[01:07:25.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:58:0)
[01:07:25.903] Timer tick, asking Buildbucket for the build status
[01:07:25.981] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:25.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:59:0) after 1m0s
[01:08:26.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:59:0)
[01:08:26.010] Timer tick, asking Buildbucket for the build status
[01:08:26.111] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:26.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:60:0) after 1m0s
[01:09:26.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:60:0)
[01:09:26.165] Timer tick, asking Buildbucket for the build status
[01:09:26.251] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:26.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:61:0) after 1m0s
[01:10:26.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:61:0)
[01:10:26.307] Timer tick, asking Buildbucket for the build status
[01:10:26.435] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:26.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:62:0) after 1m0s
[01:11:26.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:62:0)
[01:11:26.485] Timer tick, asking Buildbucket for the build status
[01:11:27.332] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:27.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:63:0) after 1m0s
[01:12:27.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:63:0)
[01:12:27.319] Timer tick, asking Buildbucket for the build status
[01:12:27.556] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:27.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:64:0) after 1m0s
[01:13:27.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:64:0)
[01:13:27.626] Timer tick, asking Buildbucket for the build status
[01:13:28.231] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:28.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:65:0) after 1m0s
[01:14:28.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:65:0)
[01:14:28.254] Timer tick, asking Buildbucket for the build status
[01:14:28.338] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:28.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:66:0) after 1m0s
[01:15:28.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:66:0)
[01:15:28.445] Timer tick, asking Buildbucket for the build status
[01:15:28.658] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:28.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:67:0) after 1m0s
[01:16:28.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:67:0)
[01:16:28.717] Timer tick, asking Buildbucket for the build status
[01:16:29.012] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:29.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:68:0) after 1m0s
[01:17:29.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:68:0)
[01:17:29.027] Timer tick, asking Buildbucket for the build status
[01:17:29.111] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:29.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:69:0) after 1m0s
[01:18:29.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:69:0)
[01:18:29.133] Timer tick, asking Buildbucket for the build status
[01:18:29.274] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:29.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:70:0) after 1m0s
[01:19:29.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:70:0)
[01:19:29.292] Timer tick, asking Buildbucket for the build status
[01:19:29.370] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:29.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:71:0) after 1m0s
[01:20:29.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:71:0)
[01:20:29.435] Timer tick, asking Buildbucket for the build status
[01:20:29.663] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:29.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:72:0) after 1m0s
[01:21:29.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:72:0)
[01:21:29.702] Timer tick, asking Buildbucket for the build status
[01:21:29.792] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:29.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:73:0) after 1m0s
[01:22:29.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:73:0)
[01:22:29.881] Timer tick, asking Buildbucket for the build status
[01:22:30.001] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:30.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:74:0) after 1m0s
[01:23:30.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:74:0)
[01:23:30.116] Timer tick, asking Buildbucket for the build status
[01:23:30.218] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:30.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:75:0) after 1m0s
[01:24:30.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:75:0)
[01:24:30.201] Timer tick, asking Buildbucket for the build status
[01:24:30.270] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:30.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:76:0) after 1m0s
[01:25:30.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:76:0)
[01:25:30.341] Timer tick, asking Buildbucket for the build status
[01:25:30.434] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:30.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:77:0) after 1m0s
[01:26:30.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:77:0)
[01:26:30.452] Timer tick, asking Buildbucket for the build status
[01:26:30.728] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:30.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:78:0) after 1m0s
[01:27:30.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:78:0)
[01:27:30.717] Timer tick, asking Buildbucket for the build status
[01:27:30.853] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:30.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:79:0) after 1m0s
[01:28:30.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:79:0)
[01:28:30.887] Timer tick, asking Buildbucket for the build status
[01:28:30.982] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:30.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:80:0) after 1m0s
[01:29:31.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:80:0)
[01:29:31.026] Timer tick, asking Buildbucket for the build status
[01:29:31.122] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:31.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:81:0) after 1m0s
[01:30:31.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:81:0)
[01:30:31.124] Timer tick, asking Buildbucket for the build status
[01:30:31.359] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:31.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:82:0) after 1m0s
[01:31:31.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:82:0)
[01:31:31.435] Timer tick, asking Buildbucket for the build status
[01:31:31.561] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:31.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:83:0) after 1m0s
[01:32:31.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:83:0)
[01:32:31.694] Timer tick, asking Buildbucket for the build status
[01:32:31.769] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:31.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:84:0) after 1m0s
[01:33:31.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:84:0)
[01:33:31.793] Timer tick, asking Buildbucket for the build status
[01:33:31.874] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:31.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:85:0) after 1m0s
[01:34:31.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:85:0)
[01:34:31.920] Timer tick, asking Buildbucket for the build status
[01:34:31.998] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:31.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:86:0) after 1m0s
[01:35:32.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:86:0)
[01:35:32.049] Timer tick, asking Buildbucket for the build status
[01:35:32.138] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:32.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:87:0) after 1m0s
[01:36:32.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:87:0)
[01:36:32.223] Timer tick, asking Buildbucket for the build status
[01:36:32.331] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:32.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:88:0) after 1m0s
[01:37:32.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:88:0)
[01:37:32.404] Timer tick, asking Buildbucket for the build status
[01:37:32.541] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:32.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:89:0) after 1m0s
[01:38:32.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:89:0)
[01:38:32.585] Timer tick, asking Buildbucket for the build status
[01:38:32.772] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:32.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:90:0) after 1m0s
[01:39:32.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:90:0)
[01:39:32.888] Timer tick, asking Buildbucket for the build status
[01:39:32.977] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:32.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:91:0) after 1m0s
[01:40:33.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:91:0)
[01:40:33.033] Timer tick, asking Buildbucket for the build status
[01:40:33.118] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:33.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:92:0) after 1m0s
[01:41:33.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:92:0)
[01:41:33.212] Timer tick, asking Buildbucket for the build status
[01:41:33.449] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:33.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:93:0) after 1m0s
[01:42:33.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:93:0)
[01:42:33.471] Timer tick, asking Buildbucket for the build status
[01:42:33.595] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:33.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:94:0) after 1m0s
[01:43:33.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:94:0)
[01:43:33.594] Timer tick, asking Buildbucket for the build status
[01:43:33.675] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:33.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:95:0) after 1m0s
[01:44:33.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:95:0)
[01:44:33.745] Timer tick, asking Buildbucket for the build status
[01:44:34.139] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:96:0) after 1m0s
[01:45:34.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:96:0)
[01:45:34.216] Timer tick, asking Buildbucket for the build status
[01:45:34.313] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:34.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:97:0) after 1m0s
[01:46:34.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:97:0)
[01:46:34.413] Timer tick, asking Buildbucket for the build status
[01:46:34.602] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:34.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:98:0) after 1m0s
[01:47:34.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:98:0)
[01:47:34.622] Timer tick, asking Buildbucket for the build status
[01:47:34.690] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:99:0) after 1m0s
[01:48:34.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:99:0)
[01:48:34.733] Timer tick, asking Buildbucket for the build status
[01:48:34.819] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:34.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:100:0) after 1m0s
[01:49:34.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:100:0)
[01:49:34.824] Timer tick, asking Buildbucket for the build status
[01:49:34.912] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:34.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:101:0) after 1m0s
[01:50:34.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:101:0)
[01:50:34.925] Timer tick, asking Buildbucket for the build status
[01:50:36.718] Build 8853101529074924304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:36.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018531591277937424:102:0) after 1m0s
[01:51:30.073] Received PubSub notification, asking Buildbucket for the build status
[01:51:30.171] Build 8853101529074924304: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:51:30.171] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615427488708607",
"created_by": "project:chromium",
"created_ts": "1615421473392797",
"id": "8853101529074924304",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f53bb3848d00835f00380dc71c34cf56281b886\"}}",
"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\": \"0f53bb3848d00835f00380dc71c34cf56281b886\", \"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-44-4rk7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22943, \"got_angle_revision\": \"331640e5c19e63209de0307ae37dc1ec69a1f4e0\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"0f53bb3848d00835f00380dc71c34cf56281b886\", \"got_revision_cp\": \"refs/heads/master@{#861769}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"f6b9f78f5d13401dd4ba1dfdacb65056c89715b5\", \"got_v8_revision_cp\": \"refs/heads/9.1.93@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"0f53bb3848d00835f00380dc71c34cf56281b886\", \"swarm_hashes_refs/heads/master(at){#861769}_without_patch\": {\"absl_hardening_tests\": \"c0aa46e183d0daba6b3bc26e726e8b6e963b4b33\", \"accessibility_unittests\": \"d7ce410143e4a08e25a98c77fefdfc7e0aa9942e\", \"angle_unittests\": \"0d62c7718a42909ed9a76c2ea52d470a19cfc830\", \"app_list_unittests\": \"927568157bf08473ab53317f68113851fdeaeb9f\", \"app_shell_unittests\": \"7cdb6f28440911a2e13fcae98ca0db31e04ec028\", \"ash_unittests\": \"2f15a67af3a050d3fd12344d0a243c165bf96b26\", \"aura_unittests\": \"17c877d84052a7b94a1967cd37dfdc9782ea4074\", \"base_unittests\": \"0cec6792b78298573e1bdaf3106420642f4814da\", \"base_util_unittests\": \"65d438cccf3d29576523c55bdd063dbc94b48be8\", \"blink_common_unittests\": \"21f26d5fa3486c1c4ec9141bf9f528cf34680911\", \"blink_fuzzer_unittests\": \"6490f8427af62f982e09b931c94707ce1e002472\", \"blink_heap_unittests\": \"10ae725ed421b35593a73b56bc2b210b737eefa8\", \"blink_platform_unittests\": \"cc8f3263592561ab44ba43e3146d7505f184c3fa\", \"blink_unittests\": \"39b300c1bb0cfafdf6353cbf526f7defc243ce1f\", \"boringssl_crypto_tests\": \"c63305279a998452a6eddb0dc1542bc3f24fc783\", \"boringssl_ssl_tests\": \"b731837a094d91a47924a30c34519f76e553e4c4\", \"browser_tests\": \"89e910ec99995bc4cea84111964ab21b57509e8d\", \"capture_unittests\": \"0334a58a9d01db9a6e7e381c4e7a2ce9d47d25e9\", \"cast_unittests\": \"ba537f7392c2f106b0529b88c091c7e005321d7a\", \"cc_unittests\": \"e1931e547155d8d02a4f8f7200e8a9c86d3a8494\", \"chrome_app_unittests\": \"474f47de5b26dbefa8653799d19bc8a725be7f38\", \"chromedriver_unittests\": \"7e05340aa3bd516fbeba365c9dca84b21584c7d6\", \"chromeos_components_unittests\": \"0f709402ba47dc049f575623ef480414eef5224e\", \"chromeos_unittests\": \"adc8b4f4afeb2c5cf40b07adcbcc409becda25d2\", \"color_unittests\": \"167c0b3d14268248713338025c2bbb6407403447\", \"components_browsertests\": \"e699e78511c440a3db546f858da4e3e56da79f34\", \"components_unittests\": \"ab47e3a3ba9ee3184f6d203c0f7018a7b7df5b6f\", \"compositor_unittests\": \"43836fb84c9cb99c4da16ad3e62df96d5dec2c98\", \"content_browsertests\": \"a9f1fc57bd16fb2ff002f7b8d10bd8f24e47940a\", \"content_unittests\": \"4e77f43498b60568aeba4928fcead867ef629aa9\", \"crashpad_tests\": \"1d6a2bf9f5cc52bbb6d1f611168e64d3937f467b\", \"crypto_unittests\": \"d6b9ba6d3b2c027cf4ccf219721f58a54fef981c\", \"dbus_unittests\": \"7737c948f609d817c07cb223a5069c24161659ac\", \"device_unittests\": \"186085a44e9fe66600aef2c52522a8c19a35684f\", \"display_unittests\": \"4c528812918608d349ca129dcfb091431cb2e86d\", \"events_unittests\": \"54110891ac631101b2d60dcd13d2d95553cdc9cd\", \"exo_unittests\": \"817f69ab697f2272c11450a7508c28b600cff60b\", \"extensions_browsertests\": \"f01da0ae6c2d44bc634b7007d10dbb08a210fb15\", \"extensions_unittests\": \"70235232882745bba7ea7cf9e6dd8b2004d1a5f2\", \"filesystem_service_unittests\": \"7b329cf2915891fc639fd908f061dea43cfa83a6\", \"gcm_unit_tests\": \"a74fbe99ab5f613dab5b341662d34bbe84c9d6c9\", \"gfx_unittests\": \"4acd8c730f4d900c901659bc7807cae073c2b7ea\", \"gin_unittests\": \"3ab8a522616891f935f823f87f37a61770bab32e\", \"gl_unittests_ozone\": \"6e12a18bbfaea63531a20411b61d3b8b9395b66a\", \"google_apis_unittests\": \"6af25c48237f9eea6ed09d5d587f6fc4463b51b8\", \"gpu_unittests\": \"ee954710132e592e03703eb9991191ee9db32226\", \"gwp_asan_unittests\": \"4f400c274d24c4a6628b5ec96069914390283e21\", \"interactive_ui_tests\": \"ebeb49c2822b88e19cfbddfdeab3765ca436f419\", \"ipc_tests\": \"8b2a265e6fef163f0bbba9d8ca0bf7e49e8b11b3\", \"jingle_unittests\": \"82afc5ca3afba80a769589b39497cdfb0c6242db\", \"keyboard_unittests\": \"6b063216270351d3d9aed2b8ac1db39fad0b2212\", \"latency_unittests\": \"aa341db278653c11dbb0eb26f6af13a5f7794315\", \"libjingle_xmpp_unittests\": \"a528eec7663e0d3d2933f1dcd78d0629179e3edf\", \"liburlpattern_unittests\": \"0402263bf46e04c59084d314e77bce26dc348038\", \"media_blink_unittests\": \"fb3435d798f731ce08a5842a2729a3e431f320a5\", \"media_unittests\": \"526aa2d8a6942d94db554adb4ecc2de3e636f908\", \"message_center_unittests\": \"914a60aa5b6a1c02a4d795f5e82a27f0262c5881\", \"midi_unittests\": \"fa0fb191150ca3d6ce3fa31695518a3d78bda957\", \"mojo_core_unittests\": \"fbc6755735e99d41a7c9ff3ef77386d4d6d541ca\", \"mojo_unittests\": \"cf5e3c30f9e2905c514c0e95a8670749e70fd467\", \"nacl_helper_nonsfi_unittests\": \"fc42bee93233de161581570705195a75caf58e61\", \"nacl_loader_unittests\": \"147d9d9e80c43aee59b31734a69fbed117373d2f\", \"native_theme_unittests\": \"038ef53dc5bf603df078b53f38b02be7c1c86fbb\", \"net_unittests\": \"0fcf3c5b45735af3d08fcfa68de088cacb61f218\", \"ozone_gl_unittests\": \"39cfdf0bb2522e210c596530fcb2a1ee14cb801d\", \"ozone_unittests\": \"75e52ffdfcd7f84c30e383620fdcd0351f162a8e\", \"ozone_x11_unittests\": \"5a40d29c2f07cc937f0cf9bec00818235d16fbc7\", \"pdf_unittests\": \"ed6e29249c5ead779b118281f5338be69bb89a34\", \"perfetto_unittests\": \"c51a90aacf99adf9f11e486e4316dc89c81e35a3\", \"ppapi_unittests\": \"521fe8b956119e0c8d8ce23f4bd33886beee69ab\", \"printing_unittests\": \"b97b52394e8b8757d61b8d2e05f568afa8aeeb09\", \"remoting_unittests\": \"75d7b3166008f625a3b37f359f6b9eb2b613147b\", \"sandbox_linux_unittests\": \"1a507039c64eeae68b158f2a2f001f128e47ff80\", \"service_manager_unittests\": \"35bb38b4d453fd5cb5c8b5e2bb76e1c63c76512f\", \"services_unittests\": \"629de4396475adae6fbc0e82af8c6f2d342128e8\", \"shell_dialogs_unittests\": \"609337852a3723c4e1604b34bfcf9bfcf2a9f2e4\", \"shell_encryption_unittests\": \"731f25babebbdc0da3027120a779bd51df29a6cd\", \"skia_unittests\": \"0fe31248485f320865aa4db41dc2c6c4eb8de95c\", \"snapshot_unittests\": \"e923ba86c67c9e05b4303d0e1043038182f5a20a\", \"sql_unittests\": \"c4f476886fe2424889a44cd2c5e8de8ccfdc24d6\", \"storage_unittests\": \"60146129cbbfc01cae3fad468e397e967f56c6d5\", \"sync_integration_tests\": \"163eca39773188bdd53056898780c77877323641\", \"traffic_annotation_auditor_unittests\": \"ca62085355c1a7ad02ae8b208e49845889769f94\", \"ui_base_unittests\": \"56a29d536e625cd8e32e66c7dd1040d903682d0b\", \"ui_chromeos_unittests\": \"2dc138434190cd67aae95ed4ad20968c0ab3c8a3\", \"ui_touch_selection_unittests\": \"8bf2b41b467162c43df7e0eb4d9e62d32d441c40\", \"unit_tests\": \"a94128d17c510382b8dd7ae0205c994fed202e0d\", \"url_unittests\": \"7f7c4287d4bfcd0a4e23709b8da239e9f4643893\", \"usage_time_limit_unittests\": \"a007210aaa99865ab95e91b4620ca968e3472987\", \"views_unittests\": \"fa40878395827fed5aa57a8725d41ce75fcc307f\", \"viz_unittests\": \"e10702a494c0215e4915a9ece97606a20abcb949\", \"wayland_client_tests\": \"904e50b729228f582ce18e04c17b0cac15011fb4\", \"wm_unittests\": \"57161344605b4ca8a447d2edef0dda7d24335d4f\", \"wtf_unittests\": \"cad70d8f4dceac22667304a509bcb1937f7211eb\", \"zlib_unittests\": \"9fa508e1b3dfd4e8bd9d5fad38dd402f39d4f62d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_6c78a7f8d33b40824ce59948f4a03b9b1d7e446f2adcc16b16c0c54004d8c305_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_9ab1612fdb00db29a8d60b17a842600a8e29ecb37944be685dafbc3ddd01329a_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_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-44-4rk7\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615421477901730",
"status": "COMPLETED",
"status_changed_ts": "1615427489441512",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22943",
"builder:linux-chromeos-dbg",
"buildset:commit/git/0f53bb3848d00835f00380dc71c34cf56281b886",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f53bb3848d00835f00380dc71c34cf56281b886",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018531591277937424",
"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/8853101529074924304/+/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:5237710f4c33f210",
"user_agent:luci-scheduler"
],
"updated_ts": "1615427489445959",
"url": "https://ci.chromium.org/b/8853101529074924304",
"utcnow_ts": "1615427490157795"
}
}
[01:51:30.171] Invocation finished in 1h40m18.264274314s with status SUCCEEDED