[16:37:50.321] New invocation is queued and will start shortly
[16:37:51.478] Starting the invocation (attempt 1)
[16:37:51.516] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:37:51.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:37:51.516] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023542947376338416",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d7d9014603beaecc58b9bba53ef072f09fdd8753\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023542947376338416",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d7d9014603beaecc58b9bba53ef072f09fdd8753",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7d9014603beaecc58b9bba53ef072f09fdd8753",
"gitiles_ref:refs/heads/master"
]
}
[16:37:52.515] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610642271715795",
"id": "8858112885252552480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7d9014603beaecc58b9bba53ef072f09fdd8753\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610642272250333",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22200",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d7d9014603beaecc58b9bba53ef072f09fdd8753",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7d9014603beaecc58b9bba53ef072f09fdd8753",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023542947376338416",
"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/8858112885252552480/+/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": "1610642272250424",
"url": "https://ci.chromium.org/b/8858112885252552480",
"utcnow_ts": "1610642272497247"
}
}
[16:37:52.515] Task URL: https://ci.chromium.org/b/8858112885252552480
[16:37:52.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:2:0) after 1m0s
[16:38:52.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:2:0)
[16:38:52.546] Timer tick, asking Buildbucket for the build status
[16:38:52.913] Build 8858112885252552480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:38:52.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:3:0) after 1m0s
[16:39:52.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:3:0)
[16:39:52.900] Timer tick, asking Buildbucket for the build status
[16:39:52.992] Build 8858112885252552480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:39:52.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:4:0) after 1m0s
[16:40:53.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:4:0)
[16:40:53.061] Timer tick, asking Buildbucket for the build status
[16:40:53.591] Build 8858112885252552480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:40:53.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:5:0) after 1m0s
[16:41:53.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:5:0)
[16:41:53.638] Timer tick, asking Buildbucket for the build status
[16:41:53.715] Build 8858112885252552480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:53.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:6:0) after 1m0s
[16:42:07.906] Received PubSub notification, asking Buildbucket for the build status
[16:42:08.025] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:53.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:6:0)
[16:42:53.883] Timer tick, asking Buildbucket for the build status
[16:42:53.995] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:53.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:8:0) after 1m0s
[16:43:54.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:8:0)
[16:43:54.157] Timer tick, asking Buildbucket for the build status
[16:43:54.522] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:54.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:9:0) after 1m0s
[16:44:54.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:9:0)
[16:44:54.576] Timer tick, asking Buildbucket for the build status
[16:44:54.805] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:54.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:10:0) after 1m0s
[16:45:54.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:10:0)
[16:45:54.907] Timer tick, asking Buildbucket for the build status
[16:45:55.018] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:55.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:11:0) after 1m0s
[16:46:55.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:11:0)
[16:46:55.013] Timer tick, asking Buildbucket for the build status
[16:46:55.243] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:55.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:12:0) after 1m0s
[16:47:55.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:12:0)
[16:47:55.274] Timer tick, asking Buildbucket for the build status
[16:47:55.383] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:55.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:13:0) after 1m0s
[16:48:55.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:13:0)
[16:48:55.444] Timer tick, asking Buildbucket for the build status
[16:48:55.778] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:55.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:14:0) after 1m0s
[16:49:55.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:14:0)
[16:49:55.896] Timer tick, asking Buildbucket for the build status
[16:49:56.277] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:56.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:15:0) after 1m0s
[16:50:56.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:15:0)
[16:50:56.330] Timer tick, asking Buildbucket for the build status
[16:50:56.394] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:56.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:16:0) after 1m0s
[16:51:56.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:16:0)
[16:51:56.480] Timer tick, asking Buildbucket for the build status
[16:51:56.662] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:56.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:17:0) after 1m0s
[16:52:56.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:17:0)
[16:52:56.698] Timer tick, asking Buildbucket for the build status
[16:52:56.803] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:56.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:18:0) after 1m0s
[16:53:56.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:18:0)
[16:53:56.845] Timer tick, asking Buildbucket for the build status
[16:53:56.925] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:56.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:19:0) after 1m0s
[16:54:56.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:19:0)
[16:54:56.985] Timer tick, asking Buildbucket for the build status
[16:54:57.074] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:57.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:20:0) after 1m0s
[16:55:57.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:20:0)
[16:55:57.138] Timer tick, asking Buildbucket for the build status
[16:55:57.271] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:57.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:21:0) after 1m0s
[16:56:57.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:21:0)
[16:56:57.327] Timer tick, asking Buildbucket for the build status
[16:56:57.809] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:57.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:22:0) after 1m0s
[16:57:57.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:22:0)
[16:57:57.776] Timer tick, asking Buildbucket for the build status
[16:57:58.096] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:58.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:23:0) after 1m0s
[16:58:58.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:23:0)
[16:58:58.140] Timer tick, asking Buildbucket for the build status
[16:58:58.712] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:58.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:24:0) after 1m0s
[16:59:58.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:24:0)
[16:59:58.724] Timer tick, asking Buildbucket for the build status
[16:59:58.865] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:58.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:25:0) after 1m0s
[17:00:58.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:25:0)
[17:00:58.925] Timer tick, asking Buildbucket for the build status
[17:00:58.999] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:26:0) after 1m0s
[17:01:59.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:26:0)
[17:01:59.138] Timer tick, asking Buildbucket for the build status
[17:01:59.216] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:59.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:27:0) after 1m0s
[17:02:59.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:27:0)
[17:02:59.263] Timer tick, asking Buildbucket for the build status
[17:02:59.384] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:59.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:28:0) after 1m0s
[17:03:59.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:28:0)
[17:03:59.384] Timer tick, asking Buildbucket for the build status
[17:03:59.497] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:59.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:29:0) after 1m0s
[17:04:59.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:29:0)
[17:04:59.557] Timer tick, asking Buildbucket for the build status
[17:04:59.644] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:59.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:30:0) after 1m0s
[17:05:59.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:30:0)
[17:05:59.672] Timer tick, asking Buildbucket for the build status
[17:05:59.749] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:59.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:31:0) after 1m0s
[17:06:59.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:31:0)
[17:06:59.841] Timer tick, asking Buildbucket for the build status
[17:06:59.979] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:59.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:32:0) after 1m0s
[17:08:00.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:32:0)
[17:08:00.027] Timer tick, asking Buildbucket for the build status
[17:08:00.291] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:00.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:33:0) after 1m0s
[17:09:00.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:33:0)
[17:09:00.588] Timer tick, asking Buildbucket for the build status
[17:09:01.135] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:01.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:34:0) after 1m0s
[17:10:01.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:34:0)
[17:10:01.316] Timer tick, asking Buildbucket for the build status
[17:10:01.455] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:01.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:35:0) after 1m0s
[17:11:01.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:35:0)
[17:11:01.470] Timer tick, asking Buildbucket for the build status
[17:11:01.628] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:01.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:36:0) after 1m0s
[17:12:01.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:36:0)
[17:12:01.668] Timer tick, asking Buildbucket for the build status
[17:12:01.730] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:01.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:37:0) after 1m0s
[17:13:01.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:37:0)
[17:13:01.798] Timer tick, asking Buildbucket for the build status
[17:13:01.959] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:01.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:38:0) after 1m0s
[17:14:02.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:38:0)
[17:14:02.067] Timer tick, asking Buildbucket for the build status
[17:14:02.150] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:02.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:39:0) after 1m0s
[17:15:02.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:39:0)
[17:15:02.227] Timer tick, asking Buildbucket for the build status
[17:15:02.491] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:02.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:40:0) after 1m0s
[17:16:02.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:40:0)
[17:16:02.619] Timer tick, asking Buildbucket for the build status
[17:16:02.750] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:02.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:41:0) after 1m0s
[17:17:02.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:41:0)
[17:17:02.795] Timer tick, asking Buildbucket for the build status
[17:17:02.908] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:02.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:42:0) after 1m0s
[17:18:03.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:42:0)
[17:18:03.021] Timer tick, asking Buildbucket for the build status
[17:18:03.123] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:03.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:43:0) after 1m0s
[17:19:03.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:43:0)
[17:19:03.243] Timer tick, asking Buildbucket for the build status
[17:19:03.528] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:03.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:44:0) after 1m0s
[17:20:03.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:44:0)
[17:20:03.704] Timer tick, asking Buildbucket for the build status
[17:20:04.115] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:04.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:45:0) after 1m0s
[17:21:04.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:45:0)
[17:21:04.140] Timer tick, asking Buildbucket for the build status
[17:21:04.229] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:04.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:46:0) after 1m0s
[17:22:04.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:46:0)
[17:22:04.317] Timer tick, asking Buildbucket for the build status
[17:22:04.398] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:04.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:47:0) after 1m0s
[17:23:04.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:47:0)
[17:23:04.404] Timer tick, asking Buildbucket for the build status
[17:23:04.635] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:04.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:48:0) after 1m0s
[17:24:04.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:48:0)
[17:24:04.669] Timer tick, asking Buildbucket for the build status
[17:24:04.954] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:04.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:49:0) after 1m0s
[17:25:04.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:49:0)
[17:25:04.977] Timer tick, asking Buildbucket for the build status
[17:25:05.195] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:05.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:50:0) after 1m0s
[17:26:05.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:50:0)
[17:26:05.331] Timer tick, asking Buildbucket for the build status
[17:26:05.404] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:05.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:51:0) after 1m0s
[17:27:05.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:51:0)
[17:27:05.431] Timer tick, asking Buildbucket for the build status
[17:27:05.561] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:05.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:52:0) after 1m0s
[17:28:05.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:52:0)
[17:28:05.649] Timer tick, asking Buildbucket for the build status
[17:28:05.754] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:05.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:53:0) after 1m0s
[17:29:05.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:53:0)
[17:29:05.784] Timer tick, asking Buildbucket for the build status
[17:29:05.883] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:05.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:54:0) after 1m0s
[17:30:05.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:54:0)
[17:30:05.913] Timer tick, asking Buildbucket for the build status
[17:30:06.018] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:06.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:55:0) after 1m0s
[17:31:06.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:55:0)
[17:31:06.169] Timer tick, asking Buildbucket for the build status
[17:31:06.354] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:06.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:56:0) after 1m0s
[17:32:06.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:56:0)
[17:32:06.567] Timer tick, asking Buildbucket for the build status
[17:32:06.861] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:06.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:57:0) after 1m0s
[17:33:06.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:57:0)
[17:33:06.951] Timer tick, asking Buildbucket for the build status
[17:33:07.121] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:07.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:58:0) after 1m0s
[17:34:07.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:58:0)
[17:34:07.134] Timer tick, asking Buildbucket for the build status
[17:34:08.186] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:08.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:59:0) after 1m0s
[17:35:08.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:59:0)
[17:35:08.217] Timer tick, asking Buildbucket for the build status
[17:35:08.320] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:08.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:60:0) after 1m0s
[17:36:08.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:60:0)
[17:36:08.393] Timer tick, asking Buildbucket for the build status
[17:36:08.868] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:08.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:61:0) after 1m0s
[17:37:08.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:61:0)
[17:37:08.988] Timer tick, asking Buildbucket for the build status
[17:37:09.172] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:09.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:62:0) after 1m0s
[17:38:09.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:62:0)
[17:38:09.241] Timer tick, asking Buildbucket for the build status
[17:38:09.379] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:09.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:63:0) after 1m0s
[17:39:09.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:63:0)
[17:39:09.504] Timer tick, asking Buildbucket for the build status
[17:39:09.696] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:09.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:64:0) after 1m0s
[17:40:09.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:64:0)
[17:40:09.724] Timer tick, asking Buildbucket for the build status
[17:40:10.146] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:10.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:65:0) after 1m0s
[17:41:10.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:65:0)
[17:41:10.267] Timer tick, asking Buildbucket for the build status
[17:41:11.069] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:11.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:66:0) after 1m0s
[17:42:11.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:66:0)
[17:42:11.166] Timer tick, asking Buildbucket for the build status
[17:42:11.356] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:11.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:67:0) after 1m0s
[17:43:11.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:67:0)
[17:43:11.436] Timer tick, asking Buildbucket for the build status
[17:43:11.643] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:11.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:68:0) after 1m0s
[17:44:11.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:68:0)
[17:44:11.755] Timer tick, asking Buildbucket for the build status
[17:44:11.894] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:11.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:69:0) after 1m0s
[17:45:11.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:69:0)
[17:45:11.965] Timer tick, asking Buildbucket for the build status
[17:45:12.177] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:12.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:70:0) after 1m0s
[17:46:12.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:70:0)
[17:46:12.221] Timer tick, asking Buildbucket for the build status
[17:46:12.357] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:12.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:71:0) after 1m0s
[17:47:12.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:71:0)
[17:47:12.354] Timer tick, asking Buildbucket for the build status
[17:47:12.435] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:12.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:72:0) after 1m0s
[17:48:12.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:72:0)
[17:48:12.485] Timer tick, asking Buildbucket for the build status
[17:48:12.699] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:12.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:73:0) after 1m0s
[17:49:12.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:73:0)
[17:49:12.712] Timer tick, asking Buildbucket for the build status
[17:49:12.855] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:12.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:74:0) after 1m0s
[17:50:12.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:74:0)
[17:50:12.882] Timer tick, asking Buildbucket for the build status
[17:50:12.967] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:12.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:75:0) after 1m0s
[17:51:12.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:75:0)
[17:51:12.991] Timer tick, asking Buildbucket for the build status
[17:51:13.555] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:13.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:76:0) after 1m0s
[17:52:13.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:76:0)
[17:52:13.606] Timer tick, asking Buildbucket for the build status
[17:52:13.715] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:13.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:77:0) after 1m0s
[17:53:13.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:77:0)
[17:53:13.745] Timer tick, asking Buildbucket for the build status
[17:53:14.093] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:14.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:78:0) after 1m0s
[17:54:14.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:78:0)
[17:54:14.125] Timer tick, asking Buildbucket for the build status
[17:54:14.259] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:14.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:79:0) after 1m0s
[17:55:14.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:79:0)
[17:55:14.296] Timer tick, asking Buildbucket for the build status
[17:55:14.454] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:14.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:80:0) after 1m0s
[17:56:14.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:80:0)
[17:56:14.461] Timer tick, asking Buildbucket for the build status
[17:56:14.570] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:14.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:81:0) after 1m0s
[17:57:14.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:81:0)
[17:57:14.597] Timer tick, asking Buildbucket for the build status
[17:57:14.991] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:14.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:82:0) after 1m0s
[17:58:15.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:82:0)
[17:58:15.019] Timer tick, asking Buildbucket for the build status
[17:58:15.188] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:15.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:83:0) after 1m0s
[17:59:15.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:83:0)
[17:59:15.195] Timer tick, asking Buildbucket for the build status
[17:59:15.705] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:15.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:84:0) after 1m0s
[18:00:15.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:84:0)
[18:00:15.914] Timer tick, asking Buildbucket for the build status
[18:00:16.145] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:16.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:85:0) after 1m0s
[18:01:16.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:85:0)
[18:01:16.252] Timer tick, asking Buildbucket for the build status
[18:01:16.836] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:16.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:86:0) after 1m0s
[18:02:16.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:86:0)
[18:02:16.978] Timer tick, asking Buildbucket for the build status
[18:02:17.134] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:17.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:87:0) after 1m0s
[18:03:17.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:87:0)
[18:03:17.205] Timer tick, asking Buildbucket for the build status
[18:03:17.297] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:17.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:88:0) after 1m0s
[18:04:17.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:88:0)
[18:04:17.368] Timer tick, asking Buildbucket for the build status
[18:04:17.492] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:17.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:89:0) after 1m0s
[18:05:17.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:89:0)
[18:05:17.601] Timer tick, asking Buildbucket for the build status
[18:05:17.820] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:17.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:90:0) after 1m0s
[18:06:17.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:90:0)
[18:06:17.903] Timer tick, asking Buildbucket for the build status
[18:06:18.264] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:18.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:91:0) after 1m0s
[18:07:18.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:91:0)
[18:07:18.294] Timer tick, asking Buildbucket for the build status
[18:07:18.385] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:18.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:92:0) after 1m0s
[18:08:18.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:92:0)
[18:08:18.465] Timer tick, asking Buildbucket for the build status
[18:08:19.104] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:19.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:93:0) after 1m0s
[18:09:19.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:93:0)
[18:09:19.171] Timer tick, asking Buildbucket for the build status
[18:09:19.888] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:19.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:94:0) after 1m0s
[18:10:19.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:94:0)
[18:10:19.980] Timer tick, asking Buildbucket for the build status
[18:10:20.104] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:95:0) after 1m0s
[18:11:20.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:95:0)
[18:11:20.258] Timer tick, asking Buildbucket for the build status
[18:11:20.611] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:20.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:96:0) after 1m0s
[18:12:20.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:96:0)
[18:12:20.618] Timer tick, asking Buildbucket for the build status
[18:12:20.798] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:20.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:97:0) after 1m0s
[18:13:20.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:97:0)
[18:13:20.868] Timer tick, asking Buildbucket for the build status
[18:13:21.010] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:21.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:98:0) after 1m0s
[18:14:21.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:98:0)
[18:14:21.102] Timer tick, asking Buildbucket for the build status
[18:14:21.471] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:21.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:99:0) after 1m0s
[18:15:21.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:99:0)
[18:15:21.518] Timer tick, asking Buildbucket for the build status
[18:15:22.045] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:22.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:100:0) after 1m0s
[18:16:22.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:100:0)
[18:16:22.090] Timer tick, asking Buildbucket for the build status
[18:16:22.200] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:22.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:101:0) after 1m0s
[18:17:22.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:101:0)
[18:17:22.298] Timer tick, asking Buildbucket for the build status
[18:17:22.501] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:22.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:102:0) after 1m0s
[18:18:22.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:102:0)
[18:18:22.606] Timer tick, asking Buildbucket for the build status
[18:18:22.719] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:22.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:103:0) after 1m0s
[18:19:22.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:103:0)
[18:19:22.912] Timer tick, asking Buildbucket for the build status
[18:19:23.030] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:23.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:104:0) after 1m0s
[18:20:23.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:104:0)
[18:20:23.054] Timer tick, asking Buildbucket for the build status
[18:20:23.141] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:23.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:105:0) after 1m0s
[18:21:23.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:105:0)
[18:21:23.128] Timer tick, asking Buildbucket for the build status
[18:21:23.199] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:23.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:106:0) after 1m0s
[18:22:23.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:106:0)
[18:22:23.293] Timer tick, asking Buildbucket for the build status
[18:22:24.008] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:24.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:107:0) after 1m0s
[18:23:24.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:107:0)
[18:23:24.175] Timer tick, asking Buildbucket for the build status
[18:23:24.460] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:24.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:108:0) after 1m0s
[18:24:24.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:108:0)
[18:24:24.496] Timer tick, asking Buildbucket for the build status
[18:24:24.582] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:24.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:109:0) after 1m0s
[18:25:24.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:109:0)
[18:25:24.667] Timer tick, asking Buildbucket for the build status
[18:25:24.769] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:24.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:110:0) after 1m0s
[18:26:24.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:110:0)
[18:26:24.839] Timer tick, asking Buildbucket for the build status
[18:26:24.936] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:24.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:111:0) after 1m0s
[18:27:24.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:111:0)
[18:27:24.939] Timer tick, asking Buildbucket for the build status
[18:27:25.244] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:25.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:112:0) after 1m0s
[18:28:25.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:112:0)
[18:28:25.336] Timer tick, asking Buildbucket for the build status
[18:28:25.528] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:25.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:113:0) after 1m0s
[18:29:25.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:113:0)
[18:29:25.595] Timer tick, asking Buildbucket for the build status
[18:29:26.079] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:26.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:114:0) after 1m0s
[18:30:26.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:114:0)
[18:30:26.137] Timer tick, asking Buildbucket for the build status
[18:30:26.237] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:26.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:115:0) after 1m0s
[18:31:26.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:115:0)
[18:31:26.295] Timer tick, asking Buildbucket for the build status
[18:31:26.380] Build 8858112885252552480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:26.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023542947376338416:116:0) after 1m0s
[18:31:51.629] Received PubSub notification, asking Buildbucket for the build status
[18:31:51.714] Build 8858112885252552480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:31:51.714] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610649110027455",
"created_by": "project:chromium",
"created_ts": "1610642271715795",
"id": "8858112885252552480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7d9014603beaecc58b9bba53ef072f09fdd8753\"}}",
"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\": \"d7d9014603beaecc58b9bba53ef072f09fdd8753\", \"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-192-cztd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22200, \"got_angle_revision\": \"72c58a865b57e4a81334d82b1b7af302b5b579d9\", \"got_dawn_revision\": \"247f511f198f901ce3eb0344f355f53bf9ffe59d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"d7d9014603beaecc58b9bba53ef072f09fdd8753\", \"got_revision_cp\": \"refs/heads/master@{#843564}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"5255c465bbbab020b2fa98f818a705e764865869\", \"got_v8_revision\": \"c80a50a3c4de747d61e044cea6f94223016110d2\", \"got_v8_revision_cp\": \"refs/heads/8.9.273@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"d7d9014603beaecc58b9bba53ef072f09fdd8753\", \"swarm_hashes_refs/heads/master(at){#843564}_without_patch\": {\"absl_hardening_tests\": \"b2d27dd8e7fef9c4fa731495c32ba240548c6104\", \"accessibility_unittests\": \"1fabe024b803729658f07469af4622d17c9dfd3c\", \"angle_unittests\": \"25e5247690be9d24d2b217d0871248c0e69db55b\", \"app_list_unittests\": \"0535e7d11b06b3f415a1b9ef0069ba8dc6dad7d4\", \"app_shell_unittests\": \"516f0a4198cbbda00aee984549f71b64874f9ff2\", \"ash_unittests\": \"aec7b949ba889314dad6888afce990cac7bf9099\", \"aura_unittests\": \"299fc3a53ed05497b8a568cd9198ad511e4f65c8\", \"base_unittests\": \"978b1d9483cabef155cf19e1a2b5c297395a6b6b\", \"base_util_unittests\": \"50bd15acdcfdd918d09bef53616e31ef5f111ffa\", \"blink_common_unittests\": \"5338cb3f271a82b413e97a996b50b0a21c63ff3a\", \"blink_fuzzer_unittests\": \"874bf2938d92b643a2e7ba9fadd598b7143862eb\", \"blink_heap_unittests\": \"4f408817e4db1cb5fb96f535e2dca9e96b2eee3d\", \"blink_platform_unittests\": \"01916d3c494074611afe259d807cdeda1317c34d\", \"blink_unittests\": \"fba1dea9b8eb6d516306458178717bf524309213\", \"boringssl_crypto_tests\": \"a6c22c1f0a60df872fa6116123d38e899362fbb3\", \"boringssl_ssl_tests\": \"824742110a84720e6f7c59d485e7d13a6bd1a63a\", \"browser_tests\": \"5bd2665eddf68f54f4cd4302fa975b62b506a786\", \"capture_unittests\": \"79d0558d6ccde9270c3b7d2c7f24f4ab3b7db9e3\", \"cast_unittests\": \"f92066b580044c8e61386499595c4db4010f4356\", \"cc_unittests\": \"a32a71614902849eb29b4ad8054991a6372dbbb5\", \"chrome_app_unittests\": \"019cc73568da167dee0dd9c0e40dd05de623a560\", \"chromedriver_unittests\": \"339b16f670578b3251a432ac081aff7ebaa339c7\", \"chromeos_components_unittests\": \"f879d4984246c1bd5050cb4c2a3f6dcb8f464e96\", \"chromeos_unittests\": \"765d2d38b5f4792baca7250f2ee97b2e34f4ec3e\", \"components_browsertests\": \"55de86b8d6b19653a5c2e1287b16ea2dcb40965e\", \"components_unittests\": \"47174af4653fe0d3fc017dffe954412abb9a7830\", \"compositor_unittests\": \"707cf1f7fe7939eb649d7cdb2fc6796a5a8bde68\", \"content_browsertests\": \"40bb78f242eaeeeaa27a025015fb521a19a894ff\", \"content_unittests\": \"79c40a0bc0e7db8368066165f5a8f1a5cc54f453\", \"crashpad_tests\": \"d57f97ddcd32ac02e299223b9af385561a661672\", \"crypto_unittests\": \"9d3499febe321212759620be8a07c0828c62d99b\", \"dbus_unittests\": \"d2b8f6ce3671edb2056f5ccb0a87efe4806cc9de\", \"device_unittests\": \"6125fbd987d2ff6299d41e4e23eee31176cd96c9\", \"display_unittests\": \"a72e96cb89812960c1f961fc2f81d2e5a803cc96\", \"events_unittests\": \"63c83f7796129f1f9bcc82bd7941696c937dfd40\", \"exo_unittests\": \"d3cbdb53ffc09f1c4a8b11174a526b7563d60127\", \"extensions_browsertests\": \"44f7048d8e995969260f8be28c381ac9e6912be9\", \"extensions_unittests\": \"e622ddfd75ea88ad6e741ed2936deff137da7cb9\", \"filesystem_service_unittests\": \"faf1bab3fd4e4c8c45ec1a25c12ce39042242124\", \"gcm_unit_tests\": \"120406f2f7f388902ad32120a3578cdde14ca69d\", \"gfx_unittests\": \"a4b6ae2fe69211067c49460845d948f24cf61394\", \"gin_unittests\": \"029ee92dab4e3368988cf8790230fa5da5d04fe6\", \"gl_unittests_ozone\": \"ac173685c8b4084b2ba231626c7594d6593324af\", \"google_apis_unittests\": \"7e78c552381dcc139cfdc43587e43eeb7630989b\", \"gpu_unittests\": \"4af539ef25df7d8bc14ff8a0bf004f1a321843bd\", \"gwp_asan_unittests\": \"12a7162dede43845cd8d06685a73321ea6ec2477\", \"interactive_ui_tests\": \"44bd17568dd7e85f4302f34777da2197010c8a8e\", \"ipc_tests\": \"5129753adee4cb9096e2cfcecd574346c8bb7b51\", \"jingle_unittests\": \"dfab7f85bb1617cf52667cfd0167cf803773d97d\", \"keyboard_unittests\": \"ed1c24dd15a0ec3e77b0c6296cc49b41656f18cb\", \"latency_unittests\": \"54420bfed6e67b450d98596aa57417de735a1ed7\", \"libjingle_xmpp_unittests\": \"799d31320c196cf0a7522fe1738f818f70a843f5\", \"liburlpattern_unittests\": \"a8f0d368b37dd4985b7c8395b1c9f070880d14c6\", \"media_blink_unittests\": \"59992e637ed8258a0a38de2962a0f9f325608783\", \"media_unittests\": \"57e217f6c5fda65c080c572e8e262c001714b525\", \"message_center_unittests\": \"6fec2e92257eaf487b35a179d25b372310e23622\", \"midi_unittests\": \"fae9f6bb885e46ab6c1e85b6ab97639e7dfeca58\", \"mojo_core_unittests\": \"e16ed541b0896c1ff54eaf7be9f14df266cb6eed\", \"mojo_unittests\": \"2022ce9935d93da06676e2deac9ce23c343211a4\", \"nacl_helper_nonsfi_unittests\": \"67cb2721fe898566834679cecc56b23238acaf4e\", \"nacl_loader_unittests\": \"a57bd7a1041c369d83afa24151ff23720062e4c5\", \"native_theme_unittests\": \"e63be726dcecc7e3f67f13bca81927888593666c\", \"net_unittests\": \"658a63a5e6d99c51de01eb1c43bd6cff8953e2fe\", \"ozone_gl_unittests\": \"89e01765e44f0564c8dfd83a59c056276c28531f\", \"ozone_unittests\": \"06e57e0da4e5963902f0052d201df4ce48542237\", \"ozone_x11_unittests\": \"ab43fc722e6c23a0687579cc4fdcd6b9311548ce\", \"pdf_unittests\": \"58cdbfb44ca225f1ec00dbf9c6ced8f4f91ecf7e\", \"perfetto_unittests\": \"75ea489580e0e3b52d96d8e0a73379279ad249fd\", \"ppapi_unittests\": \"ee85877654390c81dc4c366128c9b22eb0dac9ef\", \"printing_unittests\": \"76ff90db9b111eb5034147d0fde7cec07a66b49f\", \"remoting_unittests\": \"4507606a26411adc191f5ab39d37af6eeae53ee4\", \"sandbox_linux_unittests\": \"f552032453c386cf2218a450d29742f6c49af83b\", \"service_manager_unittests\": \"50cff7e5e5257f74d4774df205981fe969389a6f\", \"services_unittests\": \"f9b42fc695c2927166b16f957e1c7fff67f9689e\", \"shell_dialogs_unittests\": \"1a05f4bd501ede763558979485e50c2d383ca374\", \"shell_encryption_unittests\": \"526b9307bd97159e0546a224a23fb64da3abedab\", \"skia_unittests\": \"2fc36544ef93578f8b367546a89f1532a16c05a4\", \"snapshot_unittests\": \"b69f522f87b5c0754dfc508ce574e31b6b67daba\", \"sql_unittests\": \"1b30bff650088b5b399fcb7a2fcb9545d6c0af0d\", \"storage_unittests\": \"c5c2524a2b3e0c35a284b1a1bd551e45ea5b8929\", \"sync_integration_tests\": \"89dcf21dab0095f46208eb91839a22311e1edad3\", \"traffic_annotation_auditor_unittests\": \"d96a004760a9c1dda87dc843bf39323b893a1b1c\", \"ui_base_unittests\": \"beb0aebdbd7aa53d51a7219565fb9fc6990844b7\", \"ui_chromeos_unittests\": \"9d009afcbfdf65b34905b4422415739718872600\", \"ui_touch_selection_unittests\": \"fe14c6923333774b83fb317e6f1c29720a09c410\", \"unit_tests\": \"b77bf5ede529c96fbcb4137d0fdc3a1f68994d28\", \"url_unittests\": \"ae9279f8522446e3fc33983b79c82d0ff7d8b5e4\", \"usage_time_limit_unittests\": \"411c42fb19913d26b6ad8cce80b9a78ee2e3317a\", \"views_unittests\": \"9deeddf26c375fb40a5c81f8b3fc3d25cd6cb714\", \"viz_unittests\": \"1b89baa5a8c37dd9be1b3a1fad50eabd288fa0ac\", \"wm_unittests\": \"d34e0d410e8900f9d1c4fc0d8ec1389ccf650d7e\", \"wtf_unittests\": \"b47cd61f2a8345507555961b9d05e8855af7c599\", \"zlib_unittests\": \"b5f64ea3186ab6ddea55218f9ac8c06aa830f4bf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_057d00cc9cf4bf141513fc3b802f5b4dacb7566e9fed03d4c1bbb1efa2ee2ffd_v2\", \"builder_2924decd8bf92d66d12e0f7871729cd28b590c544e302b2201ef1e5b1ad96b76_v2\", \"builder_53152dde8708cc1c92dc2a2f2f0a881296f06b0680dba39a3a26c20421417c3e_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_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-192-cztd\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610642527050007",
"status": "COMPLETED",
"status_changed_ts": "1610649110599305",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22200",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d7d9014603beaecc58b9bba53ef072f09fdd8753",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7d9014603beaecc58b9bba53ef072f09fdd8753",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023542947376338416",
"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/8858112885252552480/+/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:511a94395c0b6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1610649110613221",
"url": "https://ci.chromium.org/b/8858112885252552480",
"utcnow_ts": "1610649111704769"
}
}
[18:31:51.714] Invocation finished in 1h54m1.408030481s with status SUCCEEDED