[04:07:52.918] New invocation is queued and will start shortly
[04:07:54.130] Starting the invocation (attempt 1)
[04:07:54.166] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:07:54.166] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:07:54.166] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020238042816327232",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"53590e5d3bef76e402a1a48a83fd91766bb097ae\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020238042816327232",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/53590e5d3bef76e402a1a48a83fd91766bb097ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53590e5d3bef76e402a1a48a83fd91766bb097ae",
"gitiles_ref:refs/heads/master"
]
}
[04:07:55.038] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613794074266431",
"id": "8854807980741215760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53590e5d3bef76e402a1a48a83fd91766bb097ae\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613794074800180",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22704",
"builder:linux-chromeos-dbg",
"buildset:commit/git/53590e5d3bef76e402a1a48a83fd91766bb097ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53590e5d3bef76e402a1a48a83fd91766bb097ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020238042816327232",
"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/8854807980741215760/+/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": "1613794074800291",
"url": "https://ci.chromium.org/b/8854807980741215760",
"utcnow_ts": "1613794075031198"
}
}
[04:07:55.038] Task URL: https://ci.chromium.org/b/8854807980741215760
[04:07:55.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:2:0) after 1m0s
[04:08:57.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:2:0)
[04:08:57.874] Timer tick, asking Buildbucket for the build status
[04:08:58.147] Build 8854807980741215760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:58.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:3:0) after 1m0s
[04:09:58.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:3:0)
[04:09:58.361] Timer tick, asking Buildbucket for the build status
[04:09:58.444] Build 8854807980741215760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:58.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:4:0) after 1m0s
[04:10:58.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:4:0)
[04:10:58.618] Timer tick, asking Buildbucket for the build status
[04:10:58.694] Build 8854807980741215760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:58.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:5:0) after 1m0s
[04:11:58.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:5:0)
[04:11:58.792] Timer tick, asking Buildbucket for the build status
[04:11:58.863] Build 8854807980741215760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:58.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:6:0) after 1m0s
[04:12:58.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:6:0)
[04:12:58.925] Timer tick, asking Buildbucket for the build status
[04:12:59.048] Build 8854807980741215760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:59.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:7:0) after 1m0s
[04:13:57.971] Received PubSub notification, asking Buildbucket for the build status
[04:13:58.055] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:59.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:7:0)
[04:13:59.290] Timer tick, asking Buildbucket for the build status
[04:13:59.360] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:59.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:9:0) after 1m0s
[04:14:59.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:9:0)
[04:14:59.570] Timer tick, asking Buildbucket for the build status
[04:14:59.798] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:59.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:10:0) after 1m0s
[04:15:59.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:10:0)
[04:15:59.952] Timer tick, asking Buildbucket for the build status
[04:16:00.275] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:00.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:11:0) after 1m0s
[04:17:00.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:11:0)
[04:17:00.401] Timer tick, asking Buildbucket for the build status
[04:17:00.468] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:00.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:12:0) after 1m0s
[04:18:01.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:12:0)
[04:18:01.656] Timer tick, asking Buildbucket for the build status
[04:18:01.755] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:01.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:13:0) after 1m0s
[04:19:02.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:13:0)
[04:19:02.294] Timer tick, asking Buildbucket for the build status
[04:19:02.407] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:02.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:14:0) after 1m0s
[04:20:02.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:14:0)
[04:20:02.659] Timer tick, asking Buildbucket for the build status
[04:20:02.764] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:02.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:15:0) after 1m0s
[04:21:02.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:15:0)
[04:21:02.857] Timer tick, asking Buildbucket for the build status
[04:21:03.035] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:03.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:16:0) after 1m0s
[04:22:03.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:16:0)
[04:22:03.270] Timer tick, asking Buildbucket for the build status
[04:22:03.349] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:03.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:17:0) after 1m0s
[04:23:03.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:17:0)
[04:23:03.339] Timer tick, asking Buildbucket for the build status
[04:23:03.858] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:03.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:18:0) after 1m0s
[04:24:03.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:18:0)
[04:24:03.928] Timer tick, asking Buildbucket for the build status
[04:24:04.029] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:04.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:19:0) after 1m0s
[04:25:04.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:19:0)
[04:25:04.029] Timer tick, asking Buildbucket for the build status
[04:25:04.098] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:04.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:20:0) after 1m0s
[04:26:04.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:20:0)
[04:26:04.222] Timer tick, asking Buildbucket for the build status
[04:26:04.581] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:04.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:21:0) after 1m0s
[04:27:04.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:21:0)
[04:27:04.647] Timer tick, asking Buildbucket for the build status
[04:27:04.743] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:04.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:22:0) after 1m0s
[04:28:04.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:22:0)
[04:28:04.760] Timer tick, asking Buildbucket for the build status
[04:28:04.945] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:04.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:23:0) after 1m0s
[04:29:05.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:23:0)
[04:29:05.168] Timer tick, asking Buildbucket for the build status
[04:29:05.269] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:05.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:24:0) after 1m0s
[04:30:05.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:24:0)
[04:30:05.367] Timer tick, asking Buildbucket for the build status
[04:30:05.448] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:05.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:25:0) after 1m0s
[04:31:06.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:25:0)
[04:31:06.067] Timer tick, asking Buildbucket for the build status
[04:31:06.153] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:06.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:26:0) after 1m0s
[04:32:06.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:26:0)
[04:32:06.171] Timer tick, asking Buildbucket for the build status
[04:32:06.248] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:06.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:27:0) after 1m0s
[04:33:06.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:27:0)
[04:33:06.305] Timer tick, asking Buildbucket for the build status
[04:33:06.509] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:06.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:28:0) after 1m0s
[04:34:06.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:28:0)
[04:34:06.567] Timer tick, asking Buildbucket for the build status
[04:34:06.861] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:06.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:29:0) after 1m0s
[04:35:06.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:29:0)
[04:35:06.922] Timer tick, asking Buildbucket for the build status
[04:35:07.010] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:07.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:30:0) after 1m0s
[04:36:07.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:30:0)
[04:36:07.029] Timer tick, asking Buildbucket for the build status
[04:36:07.145] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:07.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:31:0) after 1m0s
[04:37:07.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:31:0)
[04:37:07.173] Timer tick, asking Buildbucket for the build status
[04:37:07.326] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:07.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:32:0) after 1m0s
[04:38:07.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:32:0)
[04:38:07.340] Timer tick, asking Buildbucket for the build status
[04:38:07.407] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:07.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:33:0) after 1m0s
[04:39:07.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:33:0)
[04:39:07.521] Timer tick, asking Buildbucket for the build status
[04:39:07.627] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:07.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:34:0) after 1m0s
[04:40:07.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:34:0)
[04:40:07.678] Timer tick, asking Buildbucket for the build status
[04:40:08.105] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:08.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:35:0) after 1m0s
[04:41:08.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:35:0)
[04:41:08.113] Timer tick, asking Buildbucket for the build status
[04:41:08.193] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:08.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:36:0) after 1m0s
[04:42:08.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:36:0)
[04:42:08.300] Timer tick, asking Buildbucket for the build status
[04:42:11.543] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:11.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:37:0) after 1m0s
[04:43:11.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:37:0)
[04:43:11.566] Timer tick, asking Buildbucket for the build status
[04:43:11.879] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:11.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:38:0) after 1m0s
[04:44:11.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:38:0)
[04:44:11.965] Timer tick, asking Buildbucket for the build status
[04:44:12.076] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:12.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:39:0) after 1m0s
[04:45:12.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:39:0)
[04:45:12.076] Timer tick, asking Buildbucket for the build status
[04:45:12.310] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:12.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:40:0) after 1m0s
[04:46:12.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:40:0)
[04:46:12.329] Timer tick, asking Buildbucket for the build status
[04:46:12.422] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:12.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:41:0) after 1m0s
[04:47:12.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:41:0)
[04:47:12.443] Timer tick, asking Buildbucket for the build status
[04:47:12.586] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:12.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:42:0) after 1m0s
[04:48:15.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:42:0)
[04:48:15.176] Timer tick, asking Buildbucket for the build status
[04:48:15.722] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:15.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:43:0) after 1m0s
[04:49:15.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:43:0)
[04:49:15.820] Timer tick, asking Buildbucket for the build status
[04:49:15.940] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:15.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:44:0) after 1m0s
[04:50:16.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:44:0)
[04:50:16.024] Timer tick, asking Buildbucket for the build status
[04:50:16.103] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:16.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:45:0) after 1m0s
[04:51:16.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:45:0)
[04:51:16.134] Timer tick, asking Buildbucket for the build status
[04:51:16.277] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:16.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:46:0) after 1m0s
[04:52:16.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:46:0)
[04:52:16.298] Timer tick, asking Buildbucket for the build status
[04:52:16.367] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:47:0) after 1m0s
[04:53:16.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:47:0)
[04:53:16.336] Timer tick, asking Buildbucket for the build status
[04:53:16.601] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:16.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:48:0) after 1m0s
[04:54:16.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:48:0)
[04:54:16.648] Timer tick, asking Buildbucket for the build status
[04:54:16.839] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:16.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:49:0) after 1m0s
[04:55:16.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:49:0)
[04:55:16.837] Timer tick, asking Buildbucket for the build status
[04:55:16.955] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:16.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:50:0) after 1m0s
[04:56:16.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:50:0)
[04:56:16.978] Timer tick, asking Buildbucket for the build status
[04:56:17.093] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:17.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:51:0) after 1m0s
[04:57:17.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:51:0)
[04:57:17.143] Timer tick, asking Buildbucket for the build status
[04:57:17.429] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:17.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:52:0) after 1m0s
[04:58:17.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:52:0)
[04:58:17.466] Timer tick, asking Buildbucket for the build status
[04:58:17.549] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:17.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:53:0) after 1m0s
[04:59:17.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:53:0)
[04:59:17.535] Timer tick, asking Buildbucket for the build status
[04:59:17.633] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:17.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:54:0) after 1m0s
[05:00:17.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:54:0)
[05:00:17.651] Timer tick, asking Buildbucket for the build status
[05:00:17.959] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:17.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:55:0) after 1m0s
[05:01:17.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:55:0)
[05:01:17.957] Timer tick, asking Buildbucket for the build status
[05:01:18.035] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:18.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:56:0) after 1m0s
[05:02:17.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:56:0)
[05:02:17.760] Timer tick, asking Buildbucket for the build status
[05:02:18.070] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:18.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:57:0) after 1m0s
[05:03:18.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:57:0)
[05:03:18.110] Timer tick, asking Buildbucket for the build status
[05:03:18.188] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:18.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:58:0) after 1m0s
[05:04:18.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:58:0)
[05:04:18.248] Timer tick, asking Buildbucket for the build status
[05:04:18.360] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:18.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:59:0) after 1m0s
[05:05:18.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:59:0)
[05:05:18.123] Timer tick, asking Buildbucket for the build status
[05:05:18.253] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:18.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:60:0) after 1m0s
[05:06:18.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:60:0)
[05:06:18.265] Timer tick, asking Buildbucket for the build status
[05:06:18.522] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:18.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:61:0) after 1m0s
[05:07:18.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:61:0)
[05:07:18.539] Timer tick, asking Buildbucket for the build status
[05:07:18.624] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:18.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:62:0) after 1m0s
[05:08:18.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:62:0)
[05:08:18.692] Timer tick, asking Buildbucket for the build status
[05:08:18.830] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:18.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:63:0) after 1m0s
[05:09:18.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:63:0)
[05:09:18.833] Timer tick, asking Buildbucket for the build status
[05:09:19.605] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:19.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:64:0) after 1m0s
[05:10:19.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:64:0)
[05:10:19.530] Timer tick, asking Buildbucket for the build status
[05:10:19.751] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:19.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:65:0) after 1m0s
[05:11:20.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:65:0)
[05:11:20.188] Timer tick, asking Buildbucket for the build status
[05:11:20.313] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:20.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:66:0) after 1m0s
[05:12:20.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:66:0)
[05:12:20.389] Timer tick, asking Buildbucket for the build status
[05:12:20.508] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:20.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:67:0) after 1m0s
[05:13:20.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:67:0)
[05:13:20.571] Timer tick, asking Buildbucket for the build status
[05:13:20.667] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:20.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:68:0) after 1m0s
[05:14:21.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:68:0)
[05:14:21.186] Timer tick, asking Buildbucket for the build status
[05:14:21.348] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:21.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:69:0) after 1m0s
[05:15:21.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:69:0)
[05:15:21.396] Timer tick, asking Buildbucket for the build status
[05:15:21.509] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:21.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:70:0) after 1m0s
[05:16:21.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:70:0)
[05:16:21.539] Timer tick, asking Buildbucket for the build status
[05:16:21.631] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:21.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:71:0) after 1m0s
[05:17:21.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:71:0)
[05:17:21.678] Timer tick, asking Buildbucket for the build status
[05:17:21.765] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:21.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:72:0) after 1m0s
[05:18:21.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:72:0)
[05:18:21.777] Timer tick, asking Buildbucket for the build status
[05:18:22.098] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:22.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:73:0) after 1m0s
[05:19:22.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:73:0)
[05:19:22.289] Timer tick, asking Buildbucket for the build status
[05:19:22.491] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:22.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:74:0) after 1m0s
[05:20:22.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:74:0)
[05:20:22.690] Timer tick, asking Buildbucket for the build status
[05:20:22.804] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:22.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:75:0) after 1m0s
[05:21:22.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:75:0)
[05:21:22.904] Timer tick, asking Buildbucket for the build status
[05:21:23.108] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:23.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:76:0) after 1m0s
[05:22:23.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:76:0)
[05:22:23.211] Timer tick, asking Buildbucket for the build status
[05:22:23.331] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:23.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:77:0) after 1m0s
[05:23:23.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:77:0)
[05:23:23.383] Timer tick, asking Buildbucket for the build status
[05:23:23.458] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:23.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:78:0) after 1m0s
[05:24:23.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:78:0)
[05:24:23.522] Timer tick, asking Buildbucket for the build status
[05:24:23.704] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:23.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:79:0) after 1m0s
[05:25:23.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:79:0)
[05:25:23.774] Timer tick, asking Buildbucket for the build status
[05:25:23.908] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:23.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:80:0) after 1m0s
[05:26:23.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:80:0)
[05:26:23.928] Timer tick, asking Buildbucket for the build status
[05:26:24.409] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:24.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:81:0) after 1m0s
[05:27:24.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:81:0)
[05:27:24.429] Timer tick, asking Buildbucket for the build status
[05:27:24.518] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:24.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:82:0) after 1m0s
[05:28:24.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:82:0)
[05:28:24.723] Timer tick, asking Buildbucket for the build status
[05:28:24.801] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:24.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:83:0) after 1m0s
[05:29:24.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:83:0)
[05:29:24.846] Timer tick, asking Buildbucket for the build status
[05:29:25.029] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:25.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:84:0) after 1m0s
[05:30:25.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:84:0)
[05:30:25.088] Timer tick, asking Buildbucket for the build status
[05:30:25.175] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:25.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:85:0) after 1m0s
[05:31:25.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:85:0)
[05:31:25.199] Timer tick, asking Buildbucket for the build status
[05:31:25.613] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:25.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:86:0) after 1m0s
[05:32:25.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:86:0)
[05:32:25.636] Timer tick, asking Buildbucket for the build status
[05:32:25.725] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:25.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:87:0) after 1m0s
[05:33:25.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:87:0)
[05:33:25.792] Timer tick, asking Buildbucket for the build status
[05:33:25.873] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:25.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:88:0) after 1m0s
[05:34:25.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:88:0)
[05:34:25.906] Timer tick, asking Buildbucket for the build status
[05:34:26.139] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:26.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:89:0) after 1m0s
[05:35:26.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:89:0)
[05:35:26.130] Timer tick, asking Buildbucket for the build status
[05:35:26.223] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:26.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:90:0) after 1m0s
[05:36:26.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:90:0)
[05:36:26.235] Timer tick, asking Buildbucket for the build status
[05:36:26.534] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:26.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:91:0) after 1m0s
[05:37:26.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:91:0)
[05:37:26.579] Timer tick, asking Buildbucket for the build status
[05:37:26.677] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:26.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:92:0) after 1m0s
[05:38:26.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:92:0)
[05:38:26.695] Timer tick, asking Buildbucket for the build status
[05:38:26.936] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:26.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:93:0) after 1m0s
[05:39:26.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:93:0)
[05:39:26.936] Timer tick, asking Buildbucket for the build status
[05:39:27.385] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:27.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:94:0) after 1m0s
[05:40:27.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:94:0)
[05:40:27.460] Timer tick, asking Buildbucket for the build status
[05:40:27.704] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:27.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:95:0) after 1m0s
[05:41:27.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:95:0)
[05:41:27.718] Timer tick, asking Buildbucket for the build status
[05:41:27.800] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:27.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:96:0) after 1m0s
[05:42:27.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:96:0)
[05:42:27.935] Timer tick, asking Buildbucket for the build status
[05:42:28.035] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:28.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:97:0) after 1m0s
[05:43:28.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:97:0)
[05:43:28.153] Timer tick, asking Buildbucket for the build status
[05:43:28.326] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:28.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:98:0) after 1m0s
[05:44:28.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:98:0)
[05:44:28.415] Timer tick, asking Buildbucket for the build status
[05:44:28.601] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:28.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:99:0) after 1m0s
[05:45:28.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:99:0)
[05:45:28.621] Timer tick, asking Buildbucket for the build status
[05:45:28.703] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:28.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:100:0) after 1m0s
[05:46:28.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:100:0)
[05:46:28.728] Timer tick, asking Buildbucket for the build status
[05:46:29.112] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:29.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:101:0) after 1m0s
[05:47:29.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:101:0)
[05:47:29.792] Timer tick, asking Buildbucket for the build status
[05:47:29.892] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:29.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:102:0) after 1m0s
[05:48:30.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:102:0)
[05:48:30.013] Timer tick, asking Buildbucket for the build status
[05:48:30.157] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:30.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:103:0) after 1m0s
[05:49:30.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:103:0)
[05:49:30.395] Timer tick, asking Buildbucket for the build status
[05:49:30.497] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:30.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:104:0) after 1m0s
[05:50:30.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:104:0)
[05:50:30.551] Timer tick, asking Buildbucket for the build status
[05:50:30.625] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:30.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:105:0) after 1m0s
[05:51:30.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:105:0)
[05:51:30.696] Timer tick, asking Buildbucket for the build status
[05:51:30.776] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:30.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:106:0) after 1m0s
[05:52:30.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:106:0)
[05:52:30.817] Timer tick, asking Buildbucket for the build status
[05:52:31.004] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:31.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:107:0) after 1m0s
[05:53:31.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:107:0)
[05:53:31.139] Timer tick, asking Buildbucket for the build status
[05:53:31.220] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:31.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:108:0) after 1m0s
[05:54:31.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:108:0)
[05:54:31.274] Timer tick, asking Buildbucket for the build status
[05:54:31.623] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:31.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:109:0) after 1m0s
[05:55:31.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:109:0)
[05:55:31.717] Timer tick, asking Buildbucket for the build status
[05:55:31.819] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:31.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:110:0) after 1m0s
[05:56:32.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:110:0)
[05:56:32.010] Timer tick, asking Buildbucket for the build status
[05:56:32.154] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:32.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:111:0) after 1m0s
[05:57:32.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:111:0)
[05:57:32.208] Timer tick, asking Buildbucket for the build status
[05:57:32.397] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:32.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:112:0) after 1m0s
[05:58:32.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:112:0)
[05:58:32.427] Timer tick, asking Buildbucket for the build status
[05:58:32.541] Build 8854807980741215760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:32.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020238042816327232:113:0) after 1m0s
[05:59:27.636] Received PubSub notification, asking Buildbucket for the build status
[05:59:27.744] Build 8854807980741215760: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:59:27.744] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613800766526511",
"created_by": "project:chromium",
"created_ts": "1613794074266431",
"failure_reason": "BUILD_FAILURE",
"id": "8854807980741215760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53590e5d3bef76e402a1a48a83fd91766bb097ae\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FeedbackTest.SubmissionTest\"}, \"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\": \"53590e5d3bef76e402a1a48a83fd91766bb097ae\", \"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-24-re5n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22704, \"got_angle_revision\": \"6af603e1e0699f7741bc01c77c3432b07e51f6fc\", \"got_dawn_revision\": \"7e79207ae91a7ad192729981c6d62176e78863c9\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"53590e5d3bef76e402a1a48a83fd91766bb097ae\", \"got_revision_cp\": \"refs/heads/master@{#856042}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"bc1a66c7cfe12f1fb1f12c38b35148822b36beca\", \"got_v8_revision\": \"e7f275688dbc4e03f9b6346ab70cd2835fe7d6d0\", \"got_v8_revision_cp\": \"refs/heads/9.0.218@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"53590e5d3bef76e402a1a48a83fd91766bb097ae\", \"swarm_hashes_refs/heads/master(at){#856042}_without_patch\": {\"absl_hardening_tests\": \"64154f19c0bf62be2d76a5552e6340c8f7c4809c\", \"accessibility_unittests\": \"4d5eb9aed5643f8d4efcb09fd8740d004e7134de\", \"angle_unittests\": \"b4f8e71a616ad47069aa66109f52eae77e4e7781\", \"app_list_unittests\": \"1c3ae20f7799c95936854c20a0ef9248c72118c8\", \"app_shell_unittests\": \"5b053503424fad14790265e49a7485b2dd9bc074\", \"ash_unittests\": \"1020d94b8cd36f1a1b9830a245fa2b17d9163356\", \"aura_unittests\": \"742612e5d452c581e89fb8a850b5147a724a5dac\", \"base_unittests\": \"c44a48c47931850b4f4e749a6b86322eca64aacb\", \"base_util_unittests\": \"e12c50be938fba42061c7ff5a7fed6ec31d21b2f\", \"blink_common_unittests\": \"529a75dd99aaada8f32c92d6ae4945aefe39c621\", \"blink_fuzzer_unittests\": \"da0b3587677491516b0eb77031055f72ea3690e2\", \"blink_heap_unittests\": \"4a035d056e50e7d9a71baf8db609b3461761bcaf\", \"blink_platform_unittests\": \"a2b5ac32a24258e2479766ffe051852c066cfe9d\", \"blink_unittests\": \"e427339c8bc8f5e89308a4ae55389651e093edd1\", \"boringssl_crypto_tests\": \"5835d80890e041e197f9bad61dd3a758581e12bd\", \"boringssl_ssl_tests\": \"296898f466ce9e576e4b56bb3236fe01e0a76415\", \"browser_tests\": \"afedfc9adcd41f4fe2e5c017cb415fb3318896c7\", \"capture_unittests\": \"7f2ab1879786f0e1d60492a35ab6dfedca2bc626\", \"cast_unittests\": \"62f9bb8355fc77098bcf8beb30d90ff31ecd3772\", \"cc_unittests\": \"4d2878cf01c77b7acc77660f7b9bdd1ca999786c\", \"chrome_app_unittests\": \"cc22aed315d5112cf6ce6b4794c3213e2515dceb\", \"chromedriver_unittests\": \"a84a325cf968b2da96fa11cf211b251379b79310\", \"chromeos_components_unittests\": \"cddebe63c988f1160b9332f0ec20ec956b60e661\", \"chromeos_unittests\": \"d09e2c5be00d780bd763711991b2fe1f573c0c20\", \"components_browsertests\": \"d77b5c196971aec6210139c4be5f7342f03b2df7\", \"components_unittests\": \"a05ed64f3bb5be35367d3568ccb2fc374e1bf8e5\", \"compositor_unittests\": \"70327708757fe328be316ff5d5844bc9509495ff\", \"content_browsertests\": \"d39cfef15e83a8b1683fa5e7a6049643b569d0e5\", \"content_unittests\": \"b1cd91c0952bb48275e48c6c2130beeec5e949df\", \"crashpad_tests\": \"4c52c0111a192d2f25591d172e7370bed3380e9c\", \"crypto_unittests\": \"69b31015a58bd950d7a4b67a5fe7d27bd59f51c7\", \"dbus_unittests\": \"d98c6daeebc29111d4cdc6d0d7c5c3fc8ff4986c\", \"device_unittests\": \"475923b64551aad897ae6f962ac07e32d7c48380\", \"display_unittests\": \"eb04579dae63eecf3d8ee77f9c82921e0b46a14a\", \"events_unittests\": \"3be6769a0d1e0504b6937dcbc0b2604e5aaa0788\", \"exo_unittests\": \"5f2879d55348fb2cb47ca6bf4753109e35c1789d\", \"extensions_browsertests\": \"f75324db4f08c7c04f685607d8a27ec4a2224659\", \"extensions_unittests\": \"60149a7f86c5b966b639df627b16074fdd8d39b2\", \"filesystem_service_unittests\": \"69f4d3371686f4f77d18af15ddc63db41113554a\", \"gcm_unit_tests\": \"c867b51b6ee365e9df42d2dff0fbbb37be9abacd\", \"gfx_unittests\": \"eae06b9aea1084d5868a21682937010c33f1388c\", \"gin_unittests\": \"0b0fb8b47482922192d9ab1c260add700bcdda54\", \"gl_unittests_ozone\": \"ff08adaf844a33f78fc346db0d80a46468fcf992\", \"google_apis_unittests\": \"0d29cc779cad83c90836dddbcd726ea595858dae\", \"gpu_unittests\": \"7fa801f2e50903d0fdcc9d924add2399a7c56b17\", \"gwp_asan_unittests\": \"500b20ae2893da44fb61b9e4dbcccadc6ab09a73\", \"interactive_ui_tests\": \"895944f1b43b0497e99a2cb901b780f0a1d1b1f1\", \"ipc_tests\": \"e63c4c7537355611fbe5fbac6246cfde31611f0f\", \"jingle_unittests\": \"8eec3c1eee7c02f35bf96f947f1e4148c998aef9\", \"keyboard_unittests\": \"0ab0cf3f2e4d19009a5a66ac8fa4cd51711b2bf9\", \"latency_unittests\": \"51b6011e993c0cd4449baf2d07a0eca496cf5a99\", \"libjingle_xmpp_unittests\": \"cb500c3700cdfbd1cd2d32cb2175a8e08979b13d\", \"liburlpattern_unittests\": \"7ba9d49328f34eb2d8180bc1334a571a1b70081e\", \"media_blink_unittests\": \"a84cf71008656a08d1cd063ab81ba264ae78d6dc\", \"media_unittests\": \"1d0a7dc3a37bcb9cd4eab295a88bc72328375de5\", \"message_center_unittests\": \"963544301ba63e09c76901ac5637af312ceb7382\", \"midi_unittests\": \"d07a39242f755ae009399e9ef4cb727a7393e8db\", \"mojo_core_unittests\": \"942d38844e84061d6afe0d7d4f9d6c899f46bfda\", \"mojo_unittests\": \"e96d2dc20b6b06f9278058c6c22ed36e5bb7fa3a\", \"nacl_helper_nonsfi_unittests\": \"facf40061d5dcf2b393469fdfcff8bd78ef79843\", \"nacl_loader_unittests\": \"581d31f7fe5beff31b9585c0f091933f48d4c967\", \"native_theme_unittests\": \"c9e70a2a399a1f7d87900bf55d2dea63bbb306e5\", \"net_unittests\": \"83172490cd28d74faeed52de720d1a9eba6d44e7\", \"ozone_gl_unittests\": \"8dfa9da3f89be55d09be734f8fc50dd6ad3fa0af\", \"ozone_unittests\": \"6b2104ac5fc90f7ae4876942445f5279e8cae9e8\", \"ozone_x11_unittests\": \"bcee0c1f7dbe8f5849ff7c9cff9adc150f8c36b7\", \"pdf_unittests\": \"0f79c3808e743f7e5cfbc97acac75edc65cef6ca\", \"perfetto_unittests\": \"d959a699fd56d77069d33b60de3e5df82578521f\", \"ppapi_unittests\": \"9f3ce49dd307fae45e54342123e5d5437891b118\", \"printing_unittests\": \"2fd29b16824c300d8f6e6183c0be8ecd3b68190b\", \"remoting_unittests\": \"148f1a55a103838e2372571958d68241eb272b01\", \"sandbox_linux_unittests\": \"6b57881eb9b01e5fd61174c2b2a2370521c15576\", \"service_manager_unittests\": \"11756bd31c6c1d159406640813e40d89fe3fb8f6\", \"services_unittests\": \"a7c3d8ccb6ee307f19ef1ffadbc579a85164ca30\", \"shell_dialogs_unittests\": \"81ef99655abd3443059aa3ee2dd939b51ba5840f\", \"shell_encryption_unittests\": \"ac58a613c83f7fedd6700ad9d5d15b9a2fb762b8\", \"skia_unittests\": \"2259c55fb9630761ae012672637b2639059d863f\", \"snapshot_unittests\": \"e7a21934297b8de3daac5b01fe9127b54b825f98\", \"sql_unittests\": \"5ea280fc5a98495f65b19b0643674d23132b35f6\", \"storage_unittests\": \"4f45de600f6a9b70f0c2a04d55a918606e653021\", \"sync_integration_tests\": \"9aa12fbfa1e909e91bfaa42974296c80cb7eeae3\", \"traffic_annotation_auditor_unittests\": \"7192d5048b4cc41e613973a966a14550e3bd0846\", \"ui_base_unittests\": \"b76d8ff4034c1d7e5fa0dd76b4378fb9554c16d4\", \"ui_chromeos_unittests\": \"f710132835ef21a85f41c297bb31d19b061c4301\", \"ui_touch_selection_unittests\": \"3a4cf71b40cb03db300db9ff1fa4a65f5607674c\", \"unit_tests\": \"6148c4b2b9a1e0466144691321cadf11b3d56180\", \"url_unittests\": \"f29f8c0cfcf0f4f1ad4d7a2f25689098792decb5\", \"usage_time_limit_unittests\": \"a7bb19ab5010342ca1309f01f1ba12216e483771\", \"views_unittests\": \"04ec366b26692af51640e5223a75302aab795e29\", \"viz_unittests\": \"9076f354ae43e4b49d575db0b5e85ae501213cdf\", \"wm_unittests\": \"bd0d05dad6c04807f09cefaa27bff554173fdde3\", \"wtf_unittests\": \"2bc1729952ba87a07e6f46bf11606607faf2c246\", \"zlib_unittests\": \"81e186ee37b50b5d832bcf27f2ad01c1f21e0697\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_288b090d6274f2a2f913a0241f3e1a83c28ff98db6eccb4d2a91107c37eb954f_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-24-re5n\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FeedbackTest.SubmissionTest\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613794437394761",
"status": "COMPLETED",
"status_changed_ts": "1613794437705222",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22704",
"builder:linux-chromeos-dbg",
"buildset:commit/git/53590e5d3bef76e402a1a48a83fd91766bb097ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53590e5d3bef76e402a1a48a83fd91766bb097ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020238042816327232",
"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/8854807980741215760/+/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:51d67183b4f91c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613800766947026",
"url": "https://ci.chromium.org/b/8854807980741215760",
"utcnow_ts": "1613800767736733"
}
}
[05:59:27.744] Invocation finished in 1h51m34.841247399s with status FAILED