[15:51:33.666] New invocation is queued and will start shortly
[15:51:34.945] Starting the invocation (attempt 1)
[15:51:35.001] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:51:35.001] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:51:35.001] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022277501396707216",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3321a70de69265cf0d4273b156e9ced0f5ffab3f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022277501396707216",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/3321a70de69265cf0d4273b156e9ced0f5ffab3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3321a70de69265cf0d4273b156e9ced0f5ffab3f",
"gitiles_ref:refs/heads/master"
]
}
[15:51:36.289] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611849095489489",
"id": "8856847438806667760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3321a70de69265cf0d4273b156e9ced0f5ffab3f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611849096135612",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22385",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3321a70de69265cf0d4273b156e9ced0f5ffab3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3321a70de69265cf0d4273b156e9ced0f5ffab3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022277501396707216",
"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/8856847438806667760/+/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": "1611849096135728",
"url": "https://ci.chromium.org/b/8856847438806667760",
"utcnow_ts": "1611849096271696"
}
}
[15:51:36.289] Task URL: https://ci.chromium.org/b/8856847438806667760
[15:51:36.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:2:0) after 1m0s
[15:52:36.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:2:0)
[15:52:36.951] Timer tick, asking Buildbucket for the build status
[15:52:37.426] Build 8856847438806667760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:37.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:3:0) after 1m0s
[15:53:37.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:3:0)
[15:53:37.552] Timer tick, asking Buildbucket for the build status
[15:53:37.787] Build 8856847438806667760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:37.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:4:0) after 1m0s
[15:54:27.961] Received PubSub notification, asking Buildbucket for the build status
[15:54:28.056] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:37.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:4:0)
[15:54:37.906] Timer tick, asking Buildbucket for the build status
[15:54:38.005] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:38.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:6:0) after 1m0s
[15:55:38.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:6:0)
[15:55:38.271] Timer tick, asking Buildbucket for the build status
[15:55:38.439] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:38.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:7:0) after 1m0s
[15:56:38.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:7:0)
[15:56:38.722] Timer tick, asking Buildbucket for the build status
[15:56:38.856] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:38.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:8:0) after 1m0s
[15:57:38.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:8:0)
[15:57:38.859] Timer tick, asking Buildbucket for the build status
[15:57:38.923] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:38.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:9:0) after 1m0s
[15:58:39.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:9:0)
[15:58:39.031] Timer tick, asking Buildbucket for the build status
[15:58:39.105] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:39.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:10:0) after 1m0s
[15:59:39.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:10:0)
[15:59:39.236] Timer tick, asking Buildbucket for the build status
[15:59:39.316] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:39.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:11:0) after 1m0s
[16:00:39.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:11:0)
[16:00:39.370] Timer tick, asking Buildbucket for the build status
[16:00:39.545] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:39.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:12:0) after 1m0s
[16:01:39.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:12:0)
[16:01:39.614] Timer tick, asking Buildbucket for the build status
[16:01:39.764] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:13:0) after 1m0s
[16:02:39.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:13:0)
[16:02:39.771] Timer tick, asking Buildbucket for the build status
[16:02:39.998] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:39.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:14:0) after 1m0s
[16:03:40.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:14:0)
[16:03:40.042] Timer tick, asking Buildbucket for the build status
[16:03:40.184] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:40.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:15:0) after 1m0s
[16:04:40.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:15:0)
[16:04:40.270] Timer tick, asking Buildbucket for the build status
[16:04:40.957] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:40.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:16:0) after 1m0s
[16:05:41.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:16:0)
[16:05:41.016] Timer tick, asking Buildbucket for the build status
[16:05:41.363] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:41.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:17:0) after 1m0s
[16:06:41.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:17:0)
[16:06:41.452] Timer tick, asking Buildbucket for the build status
[16:06:41.591] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:41.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:18:0) after 1m0s
[16:07:41.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:18:0)
[16:07:41.650] Timer tick, asking Buildbucket for the build status
[16:07:41.851] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:41.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:19:0) after 1m0s
[16:08:41.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:19:0)
[16:08:41.857] Timer tick, asking Buildbucket for the build status
[16:08:41.964] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:41.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:20:0) after 1m0s
[16:09:42.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:20:0)
[16:09:42.045] Timer tick, asking Buildbucket for the build status
[16:09:42.278] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:42.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:21:0) after 1m0s
[16:10:42.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:21:0)
[16:10:42.308] Timer tick, asking Buildbucket for the build status
[16:10:42.449] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:42.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:22:0) after 1m0s
[16:11:42.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:22:0)
[16:11:42.472] Timer tick, asking Buildbucket for the build status
[16:11:42.614] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:42.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:23:0) after 1m0s
[16:12:42.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:23:0)
[16:12:42.739] Timer tick, asking Buildbucket for the build status
[16:12:42.801] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:42.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:24:0) after 1m0s
[16:13:42.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:24:0)
[16:13:42.839] Timer tick, asking Buildbucket for the build status
[16:13:43.063] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:43.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:25:0) after 1m0s
[16:14:43.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:25:0)
[16:14:43.092] Timer tick, asking Buildbucket for the build status
[16:14:43.193] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:43.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:26:0) after 1m0s
[16:15:43.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:26:0)
[16:15:43.456] Timer tick, asking Buildbucket for the build status
[16:15:43.608] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:43.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:27:0) after 1m0s
[16:16:43.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:27:0)
[16:16:43.692] Timer tick, asking Buildbucket for the build status
[16:16:44.012] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:44.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:28:0) after 1m0s
[16:17:44.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:28:0)
[16:17:44.167] Timer tick, asking Buildbucket for the build status
[16:17:44.245] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:44.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:29:0) after 1m0s
[16:18:44.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:29:0)
[16:18:44.350] Timer tick, asking Buildbucket for the build status
[16:18:44.454] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:44.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:30:0) after 1m0s
[16:19:44.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:30:0)
[16:19:44.628] Timer tick, asking Buildbucket for the build status
[16:19:44.747] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:31:0) after 1m0s
[16:20:44.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:31:0)
[16:20:44.772] Timer tick, asking Buildbucket for the build status
[16:20:44.904] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:32:0) after 1m0s
[16:21:44.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:32:0)
[16:21:44.960] Timer tick, asking Buildbucket for the build status
[16:21:45.147] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:45.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:33:0) after 1m0s
[16:22:45.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:33:0)
[16:22:45.211] Timer tick, asking Buildbucket for the build status
[16:22:45.297] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:45.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:34:0) after 1m0s
[16:23:45.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:34:0)
[16:23:45.354] Timer tick, asking Buildbucket for the build status
[16:23:45.415] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:45.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:35:0) after 1m0s
[16:24:45.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:35:0)
[16:24:45.456] Timer tick, asking Buildbucket for the build status
[16:24:45.644] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:45.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:36:0) after 1m0s
[16:25:45.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:36:0)
[16:25:45.673] Timer tick, asking Buildbucket for the build status
[16:25:45.873] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:45.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:37:0) after 1m0s
[16:26:45.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:37:0)
[16:26:45.968] Timer tick, asking Buildbucket for the build status
[16:26:46.122] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:46.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:38:0) after 1m0s
[16:27:46.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:38:0)
[16:27:46.159] Timer tick, asking Buildbucket for the build status
[16:27:46.222] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:39:0) after 1m0s
[16:28:46.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:39:0)
[16:28:46.308] Timer tick, asking Buildbucket for the build status
[16:28:46.386] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:46.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:40:0) after 1m0s
[16:29:46.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:40:0)
[16:29:46.436] Timer tick, asking Buildbucket for the build status
[16:29:46.532] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:46.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:41:0) after 1m0s
[16:30:46.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:41:0)
[16:30:46.579] Timer tick, asking Buildbucket for the build status
[16:30:46.704] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:46.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:42:0) after 1m0s
[16:31:46.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:42:0)
[16:31:46.987] Timer tick, asking Buildbucket for the build status
[16:31:47.103] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:47.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:43:0) after 1m0s
[16:32:47.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:43:0)
[16:32:47.442] Timer tick, asking Buildbucket for the build status
[16:32:47.526] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:47.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:44:0) after 1m0s
[16:33:47.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:44:0)
[16:33:47.657] Timer tick, asking Buildbucket for the build status
[16:33:47.723] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:47.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:45:0) after 1m0s
[16:34:48.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:45:0)
[16:34:48.078] Timer tick, asking Buildbucket for the build status
[16:34:48.776] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:48.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:46:0) after 1m0s
[16:35:49.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:46:0)
[16:35:49.152] Timer tick, asking Buildbucket for the build status
[16:35:49.227] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:49.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:47:0) after 1m0s
[16:36:49.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:47:0)
[16:36:49.418] Timer tick, asking Buildbucket for the build status
[16:36:49.517] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:49.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:48:0) after 1m0s
[16:37:49.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:48:0)
[16:37:49.627] Timer tick, asking Buildbucket for the build status
[16:37:49.854] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:49.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:49:0) after 1m0s
[16:38:50.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:49:0)
[16:38:50.033] Timer tick, asking Buildbucket for the build status
[16:38:50.121] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:50.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:50:0) after 1m0s
[16:39:50.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:50:0)
[16:39:50.270] Timer tick, asking Buildbucket for the build status
[16:39:50.347] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:50.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:51:0) after 1m0s
[16:40:50.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:51:0)
[16:40:50.887] Timer tick, asking Buildbucket for the build status
[16:40:50.956] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:50.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:52:0) after 1m0s
[16:41:51.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:52:0)
[16:41:51.017] Timer tick, asking Buildbucket for the build status
[16:41:51.407] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:51.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:53:0) after 1m0s
[16:42:51.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:53:0)
[16:42:51.421] Timer tick, asking Buildbucket for the build status
[16:42:51.488] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:51.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:54:0) after 1m0s
[16:43:51.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:54:0)
[16:43:51.510] Timer tick, asking Buildbucket for the build status
[16:43:51.916] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:51.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:55:0) after 1m0s
[16:44:51.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:55:0)
[16:44:51.962] Timer tick, asking Buildbucket for the build status
[16:44:52.842] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:52.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:56:0) after 1m0s
[16:45:52.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:56:0)
[16:45:52.847] Timer tick, asking Buildbucket for the build status
[16:45:52.899] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:52.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:57:0) after 1m0s
[16:46:52.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:57:0)
[16:46:52.988] Timer tick, asking Buildbucket for the build status
[16:46:53.587] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:53.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:58:0) after 1m0s
[16:47:53.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:58:0)
[16:47:53.701] Timer tick, asking Buildbucket for the build status
[16:47:53.803] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:53.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:59:0) after 1m0s
[16:48:53.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:59:0)
[16:48:53.826] Timer tick, asking Buildbucket for the build status
[16:48:58.493] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:58.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:60:0) after 1m0s
[16:49:58.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:60:0)
[16:49:58.498] Timer tick, asking Buildbucket for the build status
[16:49:59.053] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:59.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:61:0) after 1m0s
[16:50:59.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:61:0)
[16:50:59.092] Timer tick, asking Buildbucket for the build status
[16:50:59.357] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:59.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:62:0) after 1m0s
[16:51:59.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:62:0)
[16:51:59.380] Timer tick, asking Buildbucket for the build status
[16:51:59.685] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:59.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:63:0) after 1m0s
[16:52:59.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:63:0)
[16:52:59.691] Timer tick, asking Buildbucket for the build status
[16:53:00.128] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:00.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:64:0) after 1m0s
[16:54:00.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:64:0)
[16:54:00.157] Timer tick, asking Buildbucket for the build status
[16:54:00.532] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:00.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:65:0) after 1m0s
[16:55:00.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:65:0)
[16:55:00.838] Timer tick, asking Buildbucket for the build status
[16:55:01.021] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:01.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:66:0) after 1m0s
[16:56:01.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:66:0)
[16:56:01.329] Timer tick, asking Buildbucket for the build status
[16:56:01.597] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:01.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:67:0) after 1m0s
[16:57:01.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:67:0)
[16:57:01.685] Timer tick, asking Buildbucket for the build status
[16:57:02.000] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:02.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:68:0) after 1m0s
[16:58:02.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:68:0)
[16:58:02.408] Timer tick, asking Buildbucket for the build status
[16:58:02.492] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:02.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:69:0) after 1m0s
[16:59:02.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:69:0)
[16:59:02.614] Timer tick, asking Buildbucket for the build status
[16:59:02.793] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:02.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:70:0) after 1m0s
[17:00:02.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:70:0)
[17:00:02.833] Timer tick, asking Buildbucket for the build status
[17:00:03.008] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:03.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:71:0) after 1m0s
[17:01:03.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:71:0)
[17:01:03.039] Timer tick, asking Buildbucket for the build status
[17:01:03.138] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:03.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:72:0) after 1m0s
[17:02:03.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:72:0)
[17:02:03.195] Timer tick, asking Buildbucket for the build status
[17:02:03.571] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:03.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:73:0) after 1m0s
[17:03:03.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:73:0)
[17:03:03.942] Timer tick, asking Buildbucket for the build status
[17:03:04.023] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:04.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:74:0) after 1m0s
[17:04:04.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:74:0)
[17:04:04.835] Timer tick, asking Buildbucket for the build status
[17:04:05.083] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:05.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:75:0) after 1m0s
[17:05:05.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:75:0)
[17:05:05.377] Timer tick, asking Buildbucket for the build status
[17:05:05.601] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:05.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:76:0) after 1m0s
[17:06:05.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:76:0)
[17:06:05.761] Timer tick, asking Buildbucket for the build status
[17:06:05.852] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:05.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:77:0) after 1m0s
[17:07:06.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:77:0)
[17:07:06.057] Timer tick, asking Buildbucket for the build status
[17:07:06.616] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:06.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:78:0) after 1m0s
[17:08:07.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:78:0)
[17:08:07.405] Timer tick, asking Buildbucket for the build status
[17:08:07.658] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:07.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:79:0) after 1m0s
[17:09:07.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:79:0)
[17:09:07.759] Timer tick, asking Buildbucket for the build status
[17:09:07.947] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:07.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:80:0) after 1m0s
[17:10:07.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:80:0)
[17:10:07.972] Timer tick, asking Buildbucket for the build status
[17:10:09.390] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:09.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:81:0) after 1m0s
[17:11:10.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:81:0)
[17:11:10.985] Timer tick, asking Buildbucket for the build status
[17:11:11.164] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:11.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:82:0) after 1m0s
[17:12:11.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:82:0)
[17:12:11.202] Timer tick, asking Buildbucket for the build status
[17:12:11.315] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:11.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:83:0) after 1m0s
[17:13:11.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:83:0)
[17:13:11.417] Timer tick, asking Buildbucket for the build status
[17:13:12.934] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:12.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:84:0) after 1m0s
[17:14:13.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:84:0)
[17:14:13.001] Timer tick, asking Buildbucket for the build status
[17:14:13.201] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:13.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:85:0) after 1m0s
[17:15:13.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:85:0)
[17:15:13.232] Timer tick, asking Buildbucket for the build status
[17:15:13.321] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:13.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:86:0) after 1m0s
[17:16:13.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:86:0)
[17:16:13.386] Timer tick, asking Buildbucket for the build status
[17:16:13.834] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:13.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:87:0) after 1m0s
[17:17:13.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:87:0)
[17:17:13.910] Timer tick, asking Buildbucket for the build status
[17:17:14.093] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:14.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:88:0) after 1m0s
[17:18:14.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:88:0)
[17:18:14.136] Timer tick, asking Buildbucket for the build status
[17:18:14.632] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:14.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:89:0) after 1m0s
[17:19:14.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:89:0)
[17:19:14.675] Timer tick, asking Buildbucket for the build status
[17:19:14.779] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:14.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:90:0) after 1m0s
[17:20:14.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:90:0)
[17:20:14.845] Timer tick, asking Buildbucket for the build status
[17:20:15.042] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:15.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:91:0) after 1m0s
[17:21:15.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:91:0)
[17:21:15.069] Timer tick, asking Buildbucket for the build status
[17:21:15.608] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:92:0) after 1m0s
[17:22:15.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:92:0)
[17:22:15.618] Timer tick, asking Buildbucket for the build status
[17:22:15.857] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:15.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:93:0) after 1m0s
[17:23:15.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:93:0)
[17:23:15.912] Timer tick, asking Buildbucket for the build status
[17:23:16.320] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:16.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:94:0) after 1m0s
[17:24:16.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:94:0)
[17:24:16.346] Timer tick, asking Buildbucket for the build status
[17:24:17.204] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:17.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:95:0) after 1m0s
[17:25:17.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:95:0)
[17:25:17.299] Timer tick, asking Buildbucket for the build status
[17:25:17.876] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:17.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:96:0) after 1m0s
[17:26:17.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:96:0)
[17:26:17.922] Timer tick, asking Buildbucket for the build status
[17:26:18.049] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:18.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:97:0) after 1m0s
[17:27:18.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:97:0)
[17:27:18.107] Timer tick, asking Buildbucket for the build status
[17:27:18.246] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:18.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:98:0) after 1m0s
[17:28:18.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:98:0)
[17:28:18.316] Timer tick, asking Buildbucket for the build status
[17:28:18.408] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:18.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:99:0) after 1m0s
[17:29:18.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:99:0)
[17:29:18.491] Timer tick, asking Buildbucket for the build status
[17:29:18.632] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:18.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:100:0) after 1m0s
[17:30:18.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:100:0)
[17:30:18.669] Timer tick, asking Buildbucket for the build status
[17:30:18.791] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:18.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:101:0) after 1m0s
[17:31:18.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:101:0)
[17:31:18.859] Timer tick, asking Buildbucket for the build status
[17:31:18.953] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:18.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:102:0) after 1m0s
[17:32:18.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:102:0)
[17:32:18.984] Timer tick, asking Buildbucket for the build status
[17:32:19.572] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:19.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:103:0) after 1m0s
[17:33:19.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:103:0)
[17:33:19.588] Timer tick, asking Buildbucket for the build status
[17:33:19.932] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:19.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:104:0) after 1m0s
[17:34:20.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:104:0)
[17:34:20.044] Timer tick, asking Buildbucket for the build status
[17:34:20.125] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:20.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:105:0) after 1m0s
[17:35:20.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:105:0)
[17:35:20.115] Timer tick, asking Buildbucket for the build status
[17:35:20.213] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:20.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:106:0) after 1m0s
[17:36:20.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:106:0)
[17:36:20.690] Timer tick, asking Buildbucket for the build status
[17:36:20.783] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:20.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:107:0) after 1m0s
[17:37:21.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:107:0)
[17:37:21.633] Timer tick, asking Buildbucket for the build status
[17:37:21.735] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:21.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:108:0) after 1m0s
[17:38:22.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:108:0)
[17:38:22.296] Timer tick, asking Buildbucket for the build status
[17:38:22.444] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:22.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:109:0) after 1m0s
[17:39:22.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:109:0)
[17:39:22.557] Timer tick, asking Buildbucket for the build status
[17:39:22.678] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:22.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:110:0) after 1m0s
[17:40:22.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:110:0)
[17:40:22.918] Timer tick, asking Buildbucket for the build status
[17:40:23.053] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:23.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:111:0) after 1m0s
[17:41:23.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:111:0)
[17:41:23.101] Timer tick, asking Buildbucket for the build status
[17:41:23.265] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:23.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:112:0) after 1m0s
[17:42:23.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:112:0)
[17:42:23.361] Timer tick, asking Buildbucket for the build status
[17:42:23.772] Build 8856847438806667760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:23.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022277501396707216:113:0) after 1m0s
[17:42:54.653] Received PubSub notification, asking Buildbucket for the build status
[17:42:56.801] Build 8856847438806667760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:42:56.801] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611855773196578",
"created_by": "project:chromium",
"created_ts": "1611849095489489",
"id": "8856847438806667760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3321a70de69265cf0d4273b156e9ced0f5ffab3f\"}}",
"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\": \"3321a70de69265cf0d4273b156e9ced0f5ffab3f\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-97-jg65\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22385, \"got_angle_revision\": \"4ce2e2135123407e09e37eb2f3400fd263febecc\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"3321a70de69265cf0d4273b156e9ced0f5ffab3f\", \"got_revision_cp\": \"refs/heads/master@{#848116}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"f569a18017889537012ab0775ec21101f1b2f7c6\", \"got_v8_revision_cp\": \"refs/heads/9.0.97@{#1}\", \"got_webrtc_revision\": \"b70c9531ee0c00d5d8aa104a3e5b76e6bc1412b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33084}\", \"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\": \"3321a70de69265cf0d4273b156e9ced0f5ffab3f\", \"swarm_hashes_refs/heads/master(at){#848116}_without_patch\": {\"absl_hardening_tests\": \"9e2a112f69dccb2a67bcdf19d87c3464fc074fc3\", \"accessibility_unittests\": \"0568fb0f8b6e8674d57efe6eb0245439142f0a5e\", \"angle_unittests\": \"27380c187ec2cfc0db2a887f11836bdd65d9f595\", \"app_list_unittests\": \"25df7d1f6111623b480cded0e8b1222c00f08cf0\", \"app_shell_unittests\": \"0f6fa84eaacad27fc394953a7c00fd32afcc4276\", \"ash_unittests\": \"43705136ffb9ee522a69c1d1f879080e1a210e17\", \"aura_unittests\": \"22d71f1078107c9daed988df5eca82f0909fc57a\", \"base_unittests\": \"4b6b405b153f682db893b6718ae3ea1804843917\", \"base_util_unittests\": \"563c6ac92d778e04d46acdf4389f4908371da0b1\", \"blink_common_unittests\": \"46334df53ab2ea112ef39567b7e81dd0685089cc\", \"blink_fuzzer_unittests\": \"6458dcc5dfd00b8ee77396db8a38c1c64cd0a96d\", \"blink_heap_unittests\": \"6c84e646068264e3229e23542dd45766cb804272\", \"blink_platform_unittests\": \"bdc26068386d851aadbf9ef98d7cccfa963381f7\", \"blink_unittests\": \"b149f9d841a5aa498572d83419bfb1a755139c9c\", \"boringssl_crypto_tests\": \"b77c975130a0bef618c7ce07824998929a75202d\", \"boringssl_ssl_tests\": \"4226cc5975f99f2a235a3abf08aecf966a04d031\", \"browser_tests\": \"e7b0331e27b4c432733121b3f9ca963af175a4dc\", \"capture_unittests\": \"7797383c94274d85f7d8781abb77e6a6e47665bf\", \"cast_unittests\": \"c862312613280dfccae699c82e1f36dd8551dfe1\", \"cc_unittests\": \"1cc3be2005aae60b4e6d21779f3d57d03f3da3a1\", \"chrome_app_unittests\": \"6a920bfaa3614f5e04170bdb4f0b41eb48a5df74\", \"chromedriver_unittests\": \"ae94da2b1d1595d5adfed922607029cd5d764d75\", \"chromeos_components_unittests\": \"bce27883cf5160946b03e4c012973eeba89983d0\", \"chromeos_unittests\": \"eb6f13c09de50d1543dc747a6eafa2f3b575fca4\", \"components_browsertests\": \"d1ea62bc6ae06a6a8b3df83c2c1647fe836b5e78\", \"components_unittests\": \"58a90b90877657a1c500993e3b842503e13504e3\", \"compositor_unittests\": \"4b767198dc9ff4f20b409821d24d4e250125fb85\", \"content_browsertests\": \"912d55918bc9c2b9bd9ff70702fab9dcbe2425aa\", \"content_unittests\": \"1710fff175acb2a8c3cf30ec9b63106ef64b3963\", \"crashpad_tests\": \"3e7b232f2a99ce9b6aa9b650ae342968c1c0328f\", \"crypto_unittests\": \"6778b3e16b7c51c7fb719c691ac6a01793e300b4\", \"dbus_unittests\": \"a0c40f5c365b36b08887746145dcfb09866d4535\", \"device_unittests\": \"247b84965a3509296f453e31180674c197b2954e\", \"display_unittests\": \"01527ff617e2e2727fd0e979d94b93863e2b0176\", \"events_unittests\": \"4dafa035d3458d34b83c2273af9efb081bab7cbc\", \"exo_unittests\": \"2ed61f922b0ad86890bd871df9b1680c7feb9a3f\", \"extensions_browsertests\": \"1ab8b6366578fd5713381a0aae8fcc464af5793f\", \"extensions_unittests\": \"a8e68941992d6c3b182e8b28fe8ee6e5937f3467\", \"filesystem_service_unittests\": \"2a3cd21329e9c98d4b09a267f4c1e19ebbf965ae\", \"gcm_unit_tests\": \"eac5c355d3d95a07ae051f6dedece6408cdb1a65\", \"gfx_unittests\": \"19faa2981f77cf37c7a48c4a52528c884f70df08\", \"gin_unittests\": \"0635368d683c571bc9e90c9c035a81c1cc60645b\", \"gl_unittests_ozone\": \"af13e940240b85ff1ad2c07d87cd09834d7e1966\", \"google_apis_unittests\": \"33731a7cc79e7b202b4df03c5f0182e80f4b9007\", \"gpu_unittests\": \"742eabf639d0fcc9fb9ecddd7282b13eb661b7f1\", \"gwp_asan_unittests\": \"3420aaec408c75359c0e60a7202c55a3b1f72009\", \"interactive_ui_tests\": \"08adc8699702ed7a74a7e9928b795459ae2728e1\", \"ipc_tests\": \"8a2f029bf353be77e9101c91f0c4fdc316e90482\", \"jingle_unittests\": \"e5bdf09545a46c6ed7812270fe7bdc5c71704f73\", \"keyboard_unittests\": \"4f85be2eaa7ebc8403bf3f91572474ba5c2b77d3\", \"latency_unittests\": \"9cee9a41bcc1e52b3b25f54e957838796c4b65c5\", \"libjingle_xmpp_unittests\": \"3c81c4c8c9af6d435bb0dedbdb9627c57b17066e\", \"liburlpattern_unittests\": \"682bd9ce67b23f2a52a497f4a851fc25e0e88a2e\", \"media_blink_unittests\": \"215d895cd0388e30d0057318bfd88a6ea821fb3c\", \"media_unittests\": \"5ab3746752889f3afc602db3d2cfe253dc71e1e7\", \"message_center_unittests\": \"0ad55045f8465d9eb9d11efd835c2ff23906299c\", \"midi_unittests\": \"6231b399bad39925229e66eb25e42bbeb8405206\", \"mojo_core_unittests\": \"451a88076d625b178d9f72781d95c9a60bc4f4ff\", \"mojo_unittests\": \"480ca7f697ff00416dbfe127a2410b03c6ecc13b\", \"nacl_helper_nonsfi_unittests\": \"e643a8db00d97ebaaba77d83bd2059287088233f\", \"nacl_loader_unittests\": \"8f9fe14f075cd2ae180de6191d79dd0595d1e3ba\", \"native_theme_unittests\": \"b7f762f85dd079dd9be76ae884186e2f9b2e9b5d\", \"net_unittests\": \"6e7c0ec497e083b2d6bd6abd762972beceafe42f\", \"ozone_gl_unittests\": \"f642e675d828d303a970123cb0e00300f58b3539\", \"ozone_unittests\": \"6c0d7796fc8ad9877ba9cd9dfc82759ae0aa1d23\", \"ozone_x11_unittests\": \"fd3f337ba30164eb04f30ac1f4cdb092544e1c2b\", \"pdf_unittests\": \"e264d82eab530483ad58772901bfcdec06fc3fd7\", \"perfetto_unittests\": \"eeb49feacbfc971f76e72aadc9e48cc07bd9f90e\", \"ppapi_unittests\": \"11aec06a68574d5f0f4c3598d1638767de47ec1b\", \"printing_unittests\": \"d9edd23580257173f4619c8fb3e30a66596e0d3a\", \"remoting_unittests\": \"17bc964b218641b25e8c0c4430a8b69698058ffc\", \"sandbox_linux_unittests\": \"20e5e705ab827bfcd9222d0e505456321de3036c\", \"service_manager_unittests\": \"bda6dcd16067ef4822a4eefabd54744263a276d3\", \"services_unittests\": \"0d410e23771805478bf718d20af08751b9faf5fb\", \"shell_dialogs_unittests\": \"0e706c8d5239ed19ec0854e60416cc8530e70664\", \"shell_encryption_unittests\": \"db70734566b59f14e05c4ecc29bb6981f3d0575c\", \"skia_unittests\": \"be6be1992f088f1290268152611188ffb8df7641\", \"snapshot_unittests\": \"d0989707dce52b90ef308ee05c0f2d83d7ee5fdc\", \"sql_unittests\": \"f32da55f1ade3a5f8da5b1157d8f3d0dcd3b7afc\", \"storage_unittests\": \"f0e3a8b5cbcd1b88383449e700783cb359e033a1\", \"sync_integration_tests\": \"58eab91fee132c2b36afd2dd18166a776da127b1\", \"traffic_annotation_auditor_unittests\": \"a2f3dac7e7a1a89cb5f86e0175bc632001919554\", \"ui_base_unittests\": \"336b6c0fe48c276a524c59711a512c42640cdbfc\", \"ui_chromeos_unittests\": \"b98fb85527b4e2460ee60bc29591d1d29b38d418\", \"ui_touch_selection_unittests\": \"c0ae9cfe957bebf1ed22ee7c7004aee7e3b4b857\", \"unit_tests\": \"dbd5c93b7bbf2594e572fe3105499a30069ad149\", \"url_unittests\": \"358438b84dabc32cad675e800eef3c84349ba859\", \"usage_time_limit_unittests\": \"5207c5a9a707efe80287bb7601aa3955b9194d58\", \"views_unittests\": \"8981eeccfdcf18420bab9bfebd4e1dfef1c35652\", \"viz_unittests\": \"5504492dfc1e81423eeeb4f2bfffb20d7ece4c23\", \"wm_unittests\": \"c1724b6d1125a0b13992e359b38fe57232ea122e\", \"wtf_unittests\": \"3351a618157f02305fd96b8b99930f1da9f7546a\", \"zlib_unittests\": \"a9a25e1d4f58421ab889c7d5158efc0bbf96e5be\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2924decd8bf92d66d12e0f7871729cd28b590c544e302b2201ef1e5b1ad96b76_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5031bc3d586fdedb2b02f62dae64b9ebfd5c405012b7a28b41092bb1d66cfccb_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_620847ba863b7b859d365f855d10aa27bab23d13b665ad3a30c50048a11ad6c4_v2\", \"builder_8c23a72064650b4b1d9380637a287eed4ae2e2a2092116afea022d28ee09b5dd_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-97-jg65\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611849267319484",
"status": "COMPLETED",
"status_changed_ts": "1611855773579213",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22385",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3321a70de69265cf0d4273b156e9ced0f5ffab3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3321a70de69265cf0d4273b156e9ced0f5ffab3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022277501396707216",
"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/8856847438806667760/+/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:516282e7c8806f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611855773652990",
"url": "https://ci.chromium.org/b/8856847438806667760",
"utcnow_ts": "1611855776782679"
}
}
[17:42:56.801] Invocation finished in 1h51m23.164886749s with status SUCCEEDED