[03:33:50.167] New invocation is queued and will start shortly
[03:33:51.294] Starting the invocation (attempt 1)
[03:33:51.335] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:33:51.335] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:33:51.335] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020693169628947248",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020693169628947248",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e",
"gitiles_ref:refs/heads/master"
]
}
[03:33:51.838] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613360031415757",
"id": "8855263107657743520",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613360031739490",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22627",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020693169628947248",
"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/8855263107657743520/+/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": "1613360031739709",
"url": "https://ci.chromium.org/b/8855263107657743520",
"utcnow_ts": "1613360031827927"
}
}
[03:33:51.838] Task URL: https://ci.chromium.org/b/8855263107657743520
[03:33:51.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:2:0) after 1m0s
[03:34:51.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:2:0)
[03:34:51.891] Timer tick, asking Buildbucket for the build status
[03:34:52.039] Build 8855263107657743520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:52.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:3:0) after 1m0s
[03:35:52.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:3:0)
[03:35:52.056] Timer tick, asking Buildbucket for the build status
[03:35:52.501] Build 8855263107657743520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:52.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:4:0) after 1m0s
[03:36:52.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:4:0)
[03:36:52.524] Timer tick, asking Buildbucket for the build status
[03:36:52.710] Build 8855263107657743520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:52.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:5:0) after 1m0s
[03:37:52.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:5:0)
[03:37:52.758] Timer tick, asking Buildbucket for the build status
[03:37:52.830] Build 8855263107657743520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:52.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:6:0) after 1m0s
[03:38:03.015] Received PubSub notification, asking Buildbucket for the build status
[03:38:03.092] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:52.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:6:0)
[03:38:52.878] Timer tick, asking Buildbucket for the build status
[03:38:52.959] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:52.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:8:0) after 1m0s
[03:39:52.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:8:0)
[03:39:52.981] Timer tick, asking Buildbucket for the build status
[03:39:53.060] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:53.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:9:0) after 1m0s
[03:40:53.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:9:0)
[03:40:53.116] Timer tick, asking Buildbucket for the build status
[03:40:53.390] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:53.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:10:0) after 1m0s
[03:41:53.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:10:0)
[03:41:53.459] Timer tick, asking Buildbucket for the build status
[03:41:53.536] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:53.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:11:0) after 1m0s
[03:42:53.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:11:0)
[03:42:53.563] Timer tick, asking Buildbucket for the build status
[03:42:53.647] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:53.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:12:0) after 1m0s
[03:43:53.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:12:0)
[03:43:53.645] Timer tick, asking Buildbucket for the build status
[03:43:54.085] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:54.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:13:0) after 1m0s
[03:44:54.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:13:0)
[03:44:54.210] Timer tick, asking Buildbucket for the build status
[03:44:54.285] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:54.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:14:0) after 1m0s
[03:45:54.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:14:0)
[03:45:54.403] Timer tick, asking Buildbucket for the build status
[03:45:54.602] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:54.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:15:0) after 1m0s
[03:46:54.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:15:0)
[03:46:54.673] Timer tick, asking Buildbucket for the build status
[03:46:55.065] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:55.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:16:0) after 1m0s
[03:47:55.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:16:0)
[03:47:55.169] Timer tick, asking Buildbucket for the build status
[03:47:55.365] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:55.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:17:0) after 1m0s
[03:48:55.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:17:0)
[03:48:55.421] Timer tick, asking Buildbucket for the build status
[03:48:55.693] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:55.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:18:0) after 1m0s
[03:49:55.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:18:0)
[03:49:55.802] Timer tick, asking Buildbucket for the build status
[03:49:55.910] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:55.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:19:0) after 1m0s
[03:50:55.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:19:0)
[03:50:55.932] Timer tick, asking Buildbucket for the build status
[03:50:56.132] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:56.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:20:0) after 1m0s
[03:51:56.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:20:0)
[03:51:56.147] Timer tick, asking Buildbucket for the build status
[03:51:56.215] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:56.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:21:0) after 1m0s
[03:52:56.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:21:0)
[03:52:56.237] Timer tick, asking Buildbucket for the build status
[03:52:56.310] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:56.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:22:0) after 1m0s
[03:53:56.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:22:0)
[03:53:56.330] Timer tick, asking Buildbucket for the build status
[03:53:57.488] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:57.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:23:0) after 1m0s
[03:54:57.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:23:0)
[03:54:57.511] Timer tick, asking Buildbucket for the build status
[03:54:57.670] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:57.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:24:0) after 1m0s
[03:55:57.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:24:0)
[03:55:57.692] Timer tick, asking Buildbucket for the build status
[03:55:57.765] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:57.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:25:0) after 1m0s
[03:56:57.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:25:0)
[03:56:57.764] Timer tick, asking Buildbucket for the build status
[03:56:57.836] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:57.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:26:0) after 1m0s
[03:57:58.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:26:0)
[03:57:58.019] Timer tick, asking Buildbucket for the build status
[03:57:58.091] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:58.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:27:0) after 1m0s
[03:58:58.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:27:0)
[03:58:58.193] Timer tick, asking Buildbucket for the build status
[03:58:58.595] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:58.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:28:0) after 1m0s
[03:59:58.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:28:0)
[03:59:58.718] Timer tick, asking Buildbucket for the build status
[03:59:59.004] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:59.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:29:0) after 1m0s
[04:00:59.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:29:0)
[04:00:59.022] Timer tick, asking Buildbucket for the build status
[04:00:59.102] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:59.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:30:0) after 1m0s
[04:01:59.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:30:0)
[04:01:59.124] Timer tick, asking Buildbucket for the build status
[04:01:59.197] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:59.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:31:0) after 1m0s
[04:02:59.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:31:0)
[04:02:59.256] Timer tick, asking Buildbucket for the build status
[04:02:59.332] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:59.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:32:0) after 1m0s
[04:03:59.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:32:0)
[04:03:59.418] Timer tick, asking Buildbucket for the build status
[04:03:59.694] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:59.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:33:0) after 1m0s
[04:04:59.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:33:0)
[04:04:59.745] Timer tick, asking Buildbucket for the build status
[04:04:59.887] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:59.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:34:0) after 1m0s
[04:05:59.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:34:0)
[04:05:59.974] Timer tick, asking Buildbucket for the build status
[04:06:00.214] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:00.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:35:0) after 1m0s
[04:07:00.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:35:0)
[04:07:00.297] Timer tick, asking Buildbucket for the build status
[04:07:00.386] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:00.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:36:0) after 1m0s
[04:08:00.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:36:0)
[04:08:00.550] Timer tick, asking Buildbucket for the build status
[04:08:00.799] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:00.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:37:0) after 1m0s
[04:09:01.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:37:0)
[04:09:01.482] Timer tick, asking Buildbucket for the build status
[04:09:01.567] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:01.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:38:0) after 1m0s
[04:10:02.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:38:0)
[04:10:02.036] Timer tick, asking Buildbucket for the build status
[04:10:02.152] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:02.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:39:0) after 1m0s
[04:11:02.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:39:0)
[04:11:02.203] Timer tick, asking Buildbucket for the build status
[04:11:02.560] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:02.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:40:0) after 1m0s
[04:12:03.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:40:0)
[04:12:03.211] Timer tick, asking Buildbucket for the build status
[04:12:03.308] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:03.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:41:0) after 1m0s
[04:13:03.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:41:0)
[04:13:03.435] Timer tick, asking Buildbucket for the build status
[04:13:03.510] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:03.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:42:0) after 1m0s
[04:14:03.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:42:0)
[04:14:03.553] Timer tick, asking Buildbucket for the build status
[04:14:04.333] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:43:0) after 1m0s
[04:15:04.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:43:0)
[04:15:04.378] Timer tick, asking Buildbucket for the build status
[04:15:04.449] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:04.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:44:0) after 1m0s
[04:16:04.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:44:0)
[04:16:04.492] Timer tick, asking Buildbucket for the build status
[04:16:04.660] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:04.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:45:0) after 1m0s
[04:17:04.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:45:0)
[04:17:04.684] Timer tick, asking Buildbucket for the build status
[04:17:04.820] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:04.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:46:0) after 1m0s
[04:18:04.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:46:0)
[04:18:04.868] Timer tick, asking Buildbucket for the build status
[04:18:05.043] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:05.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:47:0) after 1m0s
[04:19:05.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:47:0)
[04:19:05.082] Timer tick, asking Buildbucket for the build status
[04:19:05.193] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:05.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:48:0) after 1m0s
[04:20:05.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:48:0)
[04:20:05.216] Timer tick, asking Buildbucket for the build status
[04:20:05.361] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:05.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:49:0) after 1m0s
[04:21:05.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:49:0)
[04:21:05.537] Timer tick, asking Buildbucket for the build status
[04:21:05.618] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:05.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:50:0) after 1m0s
[04:22:05.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:50:0)
[04:22:05.710] Timer tick, asking Buildbucket for the build status
[04:22:05.802] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:05.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:51:0) after 1m0s
[04:23:05.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:51:0)
[04:23:05.899] Timer tick, asking Buildbucket for the build status
[04:23:06.176] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:06.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:52:0) after 1m0s
[04:24:06.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:52:0)
[04:24:06.233] Timer tick, asking Buildbucket for the build status
[04:24:06.464] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:06.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:53:0) after 1m0s
[04:25:06.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:53:0)
[04:25:06.433] Timer tick, asking Buildbucket for the build status
[04:25:06.527] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:06.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:54:0) after 1m0s
[04:26:06.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:54:0)
[04:26:06.730] Timer tick, asking Buildbucket for the build status
[04:26:06.804] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:06.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:55:0) after 1m0s
[04:27:06.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:55:0)
[04:27:06.847] Timer tick, asking Buildbucket for the build status
[04:27:06.945] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:06.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:56:0) after 1m0s
[04:28:07.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:56:0)
[04:28:07.083] Timer tick, asking Buildbucket for the build status
[04:28:07.168] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:07.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:57:0) after 1m0s
[04:29:07.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:57:0)
[04:29:07.252] Timer tick, asking Buildbucket for the build status
[04:29:07.595] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:07.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:58:0) after 1m0s
[04:30:07.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:58:0)
[04:30:07.643] Timer tick, asking Buildbucket for the build status
[04:30:08.153] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:08.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:59:0) after 1m0s
[04:31:08.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:59:0)
[04:31:08.155] Timer tick, asking Buildbucket for the build status
[04:31:08.251] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:08.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:60:0) after 1m0s
[04:32:08.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:60:0)
[04:32:08.279] Timer tick, asking Buildbucket for the build status
[04:32:08.514] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:08.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:61:0) after 1m0s
[04:33:08.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:61:0)
[04:33:08.597] Timer tick, asking Buildbucket for the build status
[04:33:08.692] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:62:0) after 1m0s
[04:34:08.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:62:0)
[04:34:08.723] Timer tick, asking Buildbucket for the build status
[04:34:09.018] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:09.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:63:0) after 1m0s
[04:35:09.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:63:0)
[04:35:09.137] Timer tick, asking Buildbucket for the build status
[04:35:09.287] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:09.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:64:0) after 1m0s
[04:36:09.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:64:0)
[04:36:09.437] Timer tick, asking Buildbucket for the build status
[04:36:09.558] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:09.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:65:0) after 1m0s
[04:37:09.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:65:0)
[04:37:09.615] Timer tick, asking Buildbucket for the build status
[04:37:09.716] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:09.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:66:0) after 1m0s
[04:38:09.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:66:0)
[04:38:09.813] Timer tick, asking Buildbucket for the build status
[04:38:10.153] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:10.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:67:0) after 1m0s
[04:39:10.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:67:0)
[04:39:10.243] Timer tick, asking Buildbucket for the build status
[04:39:10.355] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:10.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:68:0) after 1m0s
[04:40:10.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:68:0)
[04:40:10.496] Timer tick, asking Buildbucket for the build status
[04:40:10.575] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:10.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:69:0) after 1m0s
[04:41:10.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:69:0)
[04:41:10.632] Timer tick, asking Buildbucket for the build status
[04:41:10.753] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:10.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:70:0) after 1m0s
[04:42:10.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:70:0)
[04:42:10.910] Timer tick, asking Buildbucket for the build status
[04:42:10.988] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:10.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:71:0) after 1m0s
[04:43:11.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:71:0)
[04:43:11.178] Timer tick, asking Buildbucket for the build status
[04:43:11.535] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:11.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:72:0) after 1m0s
[04:44:11.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:72:0)
[04:44:11.654] Timer tick, asking Buildbucket for the build status
[04:44:11.787] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:11.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:73:0) after 1m0s
[04:45:11.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:73:0)
[04:45:11.839] Timer tick, asking Buildbucket for the build status
[04:45:11.920] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:11.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:74:0) after 1m0s
[04:46:11.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:74:0)
[04:46:11.993] Timer tick, asking Buildbucket for the build status
[04:46:12.117] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:12.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:75:0) after 1m0s
[04:47:12.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:75:0)
[04:47:12.189] Timer tick, asking Buildbucket for the build status
[04:47:12.333] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:12.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:76:0) after 1m0s
[04:48:12.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:76:0)
[04:48:12.407] Timer tick, asking Buildbucket for the build status
[04:48:12.692] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:12.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:77:0) after 1m0s
[04:49:12.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:77:0)
[04:49:12.711] Timer tick, asking Buildbucket for the build status
[04:49:12.810] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:12.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:78:0) after 1m0s
[04:50:12.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:78:0)
[04:50:12.884] Timer tick, asking Buildbucket for the build status
[04:50:12.961] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:12.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:79:0) after 1m0s
[04:51:13.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:79:0)
[04:51:13.014] Timer tick, asking Buildbucket for the build status
[04:51:13.109] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:13.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:80:0) after 1m0s
[04:52:13.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:80:0)
[04:52:13.156] Timer tick, asking Buildbucket for the build status
[04:52:13.250] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:13.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:81:0) after 1m0s
[04:53:13.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:81:0)
[04:53:13.267] Timer tick, asking Buildbucket for the build status
[04:53:13.508] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:13.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:82:0) after 1m0s
[04:54:13.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:82:0)
[04:54:13.531] Timer tick, asking Buildbucket for the build status
[04:54:13.689] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:13.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:83:0) after 1m0s
[04:55:13.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:83:0)
[04:55:13.717] Timer tick, asking Buildbucket for the build status
[04:55:13.800] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:13.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:84:0) after 1m0s
[04:56:13.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:84:0)
[04:56:13.890] Timer tick, asking Buildbucket for the build status
[04:56:13.976] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:13.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:85:0) after 1m0s
[04:57:14.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:85:0)
[04:57:14.128] Timer tick, asking Buildbucket for the build status
[04:57:14.218] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:14.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:86:0) after 1m0s
[04:58:14.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:86:0)
[04:58:14.266] Timer tick, asking Buildbucket for the build status
[04:58:14.527] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:14.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:87:0) after 1m0s
[04:59:14.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:87:0)
[04:59:14.850] Timer tick, asking Buildbucket for the build status
[04:59:14.955] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:14.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:88:0) after 1m0s
[05:00:15.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:88:0)
[05:00:15.136] Timer tick, asking Buildbucket for the build status
[05:00:15.600] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:15.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:89:0) after 1m0s
[05:01:15.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:89:0)
[05:01:15.696] Timer tick, asking Buildbucket for the build status
[05:01:15.768] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:15.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:90:0) after 1m0s
[05:02:15.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:90:0)
[05:02:15.875] Timer tick, asking Buildbucket for the build status
[05:02:16.002] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:16.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:91:0) after 1m0s
[05:03:16.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:91:0)
[05:03:16.096] Timer tick, asking Buildbucket for the build status
[05:03:16.443] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:16.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:92:0) after 1m0s
[05:04:16.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:92:0)
[05:04:16.477] Timer tick, asking Buildbucket for the build status
[05:04:16.578] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:16.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:93:0) after 1m0s
[05:05:16.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:93:0)
[05:05:16.636] Timer tick, asking Buildbucket for the build status
[05:05:16.731] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:16.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:94:0) after 1m0s
[05:06:16.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:94:0)
[05:06:16.785] Timer tick, asking Buildbucket for the build status
[05:06:16.873] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:16.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:95:0) after 1m0s
[05:07:16.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:95:0)
[05:07:16.902] Timer tick, asking Buildbucket for the build status
[05:07:17.228] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:17.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:96:0) after 1m0s
[05:08:17.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:96:0)
[05:08:17.240] Timer tick, asking Buildbucket for the build status
[05:08:17.660] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:17.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:97:0) after 1m0s
[05:09:17.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:97:0)
[05:09:17.709] Timer tick, asking Buildbucket for the build status
[05:09:17.829] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:17.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:98:0) after 1m0s
[05:10:17.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:98:0)
[05:10:17.895] Timer tick, asking Buildbucket for the build status
[05:10:17.999] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:17.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:99:0) after 1m0s
[05:11:18.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:99:0)
[05:11:18.084] Timer tick, asking Buildbucket for the build status
[05:11:18.162] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:18.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:100:0) after 1m0s
[05:12:18.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:100:0)
[05:12:18.283] Timer tick, asking Buildbucket for the build status
[05:12:18.450] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:18.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:101:0) after 1m0s
[05:13:18.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:101:0)
[05:13:18.473] Timer tick, asking Buildbucket for the build status
[05:13:18.607] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:18.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:102:0) after 1m0s
[05:14:18.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:102:0)
[05:14:18.639] Timer tick, asking Buildbucket for the build status
[05:14:18.754] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:18.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:103:0) after 1m0s
[05:15:18.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:103:0)
[05:15:18.845] Timer tick, asking Buildbucket for the build status
[05:15:18.955] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:18.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:104:0) after 1m0s
[05:16:18.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:104:0)
[05:16:18.970] Timer tick, asking Buildbucket for the build status
[05:16:19.194] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:19.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:105:0) after 1m0s
[05:17:19.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:105:0)
[05:17:19.271] Timer tick, asking Buildbucket for the build status
[05:17:19.381] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:19.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:106:0) after 1m0s
[05:18:19.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:106:0)
[05:18:19.453] Timer tick, asking Buildbucket for the build status
[05:18:19.578] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:19.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:107:0) after 1m0s
[05:19:19.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:107:0)
[05:19:19.605] Timer tick, asking Buildbucket for the build status
[05:19:20.047] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:20.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:108:0) after 1m0s
[05:20:20.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:108:0)
[05:20:20.157] Timer tick, asking Buildbucket for the build status
[05:20:20.268] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:20.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:109:0) after 1m0s
[05:21:20.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:109:0)
[05:21:20.545] Timer tick, asking Buildbucket for the build status
[05:21:20.649] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:20.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:110:0) after 1m0s
[05:22:20.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:110:0)
[05:22:20.750] Timer tick, asking Buildbucket for the build status
[05:22:20.836] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:20.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:111:0) after 1m0s
[05:23:21.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:111:0)
[05:23:21.019] Timer tick, asking Buildbucket for the build status
[05:23:21.293] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:21.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:112:0) after 1m0s
[05:24:21.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:112:0)
[05:24:21.378] Timer tick, asking Buildbucket for the build status
[05:24:21.493] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:21.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:113:0) after 1m0s
[05:25:21.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:113:0)
[05:25:21.710] Timer tick, asking Buildbucket for the build status
[05:25:21.847] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:21.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:114:0) after 1m0s
[05:26:21.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:114:0)
[05:26:21.909] Timer tick, asking Buildbucket for the build status
[05:26:21.991] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:21.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:115:0) after 1m0s
[05:27:22.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:115:0)
[05:27:22.198] Timer tick, asking Buildbucket for the build status
[05:27:22.309] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:22.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:116:0) after 1m0s
[05:28:22.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:116:0)
[05:28:22.454] Timer tick, asking Buildbucket for the build status
[05:28:22.534] Build 8855263107657743520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:22.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020693169628947248:117:0) after 1m0s
[05:28:56.792] Received PubSub notification, asking Buildbucket for the build status
[05:28:56.865] Build 8855263107657743520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:28:56.865] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613366935665262",
"created_by": "project:chromium",
"created_ts": "1613360031415757",
"id": "8855263107657743520",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e\"}}",
"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\": \"e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-184-d4lj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22627, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e\", \"got_revision_cp\": \"refs/heads/master@{#853941}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e\", \"swarm_hashes_refs/heads/master(at){#853941}_without_patch\": {\"absl_hardening_tests\": \"f0c1d39a9c66ca0e54ba57f12da25a1660b9e4de\", \"accessibility_unittests\": \"fff0ca5bb83502ca16df4fcdb771e6117052e5b8\", \"angle_unittests\": \"934d0299ff991e54e0aca26ddf145416343f622f\", \"app_list_unittests\": \"5cfc8af95eefc02435ba3bb58a7120cf220cdeb1\", \"app_shell_unittests\": \"a67960ffae50a7859027cbed36a7a5e7d8dbe0d9\", \"ash_unittests\": \"87ea01200c592cca59259632a216c8c9f98d5e52\", \"aura_unittests\": \"bb3a9dc53ca932e8be0fb8cc451c12f9dc0939b0\", \"base_unittests\": \"e137630e6ce06a9b2d7ce9281ffdda9593951525\", \"base_util_unittests\": \"bd8f2050bfc828929a32cc017ed912336b1138f9\", \"blink_common_unittests\": \"fa2fe207abbc9151420b68f6dc1aed111fa07398\", \"blink_fuzzer_unittests\": \"aaef10f4af7007dd8bcdd31623b530916757e9aa\", \"blink_heap_unittests\": \"07ec9e4092e8e15558d7df063ff0565d160003d5\", \"blink_platform_unittests\": \"a9b51466a6ce57f9641cdf6b76604422cdaf0b28\", \"blink_unittests\": \"637c49809e96a0553ff225e156e9481f34c02851\", \"boringssl_crypto_tests\": \"108805d6678944821bd6e39c59143cd9258d58ba\", \"boringssl_ssl_tests\": \"2667d7ab05b590b64c92474daaddb939fcdc481f\", \"browser_tests\": \"589c6b186def1320224e88374422b94f1bd9f703\", \"capture_unittests\": \"61c6af2287ead7e443a60e97967b05386416926d\", \"cast_unittests\": \"10a5c231c84c425f0be0d4b644c837f77b8b7206\", \"cc_unittests\": \"145698b2da611898c6e83d9ef203630cd43fe5cb\", \"chrome_app_unittests\": \"25a80207923bf327ea2b0269798c2a5f7bbdd89f\", \"chromedriver_unittests\": \"0ef8d85a2099845ab6986aa6a2cbc890e85659b6\", \"chromeos_components_unittests\": \"e8f338940b92330266d39275a342399f2a3cf2e3\", \"chromeos_unittests\": \"6f4d1939697fd2ae09de37a684a99baa6fd8bd10\", \"components_browsertests\": \"c15f15149fbac18522f329559b29a1fb347a76a8\", \"components_unittests\": \"f5f8467e8db3b9243df8123de726d7cf6af25964\", \"compositor_unittests\": \"a4fde6a0edd5d2ecaf426cab0e56d3aebc0ddbc6\", \"content_browsertests\": \"72703b69dee9e4aa8b317d465e2375f517558560\", \"content_unittests\": \"2b96322e79b09aa6a5859c844a9618e01de45afa\", \"crashpad_tests\": \"a1662a14e3d11cd2db40531b83c18ee67448ac1e\", \"crypto_unittests\": \"3dbffa4fc678d164ec0b837733d59c67ded7127e\", \"dbus_unittests\": \"0916103ba3e5923a6b239be17c3129acc4455356\", \"device_unittests\": \"d7346f4c635684a95088cd39a0f9f239a1278616\", \"display_unittests\": \"001287f48b1f407890a1dd0069a5e7f2928ee5b7\", \"events_unittests\": \"9546d480389472a7596408bd9ffc99fe531e6567\", \"exo_unittests\": \"b608b3ec1b29b148b61a61c7cf3608e6e2ce2be9\", \"extensions_browsertests\": \"af92c7bd65fa9669bca345e8b735f4a3eb89742b\", \"extensions_unittests\": \"08ee5c2c55770612e0a4aa1bb5850f6007fc793a\", \"filesystem_service_unittests\": \"d208ed36be44739ef369e89a7b66c7b704fcb672\", \"gcm_unit_tests\": \"368fe483ca5f80800d9ee264de5dee35c34f3db5\", \"gfx_unittests\": \"a134b0b2a08ead291ce2395d99ea6ffd97e688c9\", \"gin_unittests\": \"f9fcf575a05b2b086445f061d6186e8d74f10ae1\", \"gl_unittests_ozone\": \"9021b07dffeb4c11187effe5a8d8b208cb4dab65\", \"google_apis_unittests\": \"45094bd8ade59011c2932bc1bb0708610c63b816\", \"gpu_unittests\": \"456215110c9792327c11b022ef2d7ac09a8fec69\", \"gwp_asan_unittests\": \"0aa4a0dbd78691d5a004449ee122c9da4e66eff0\", \"interactive_ui_tests\": \"b220a13126dde4adc93fe8d2cbedb94e6806abb6\", \"ipc_tests\": \"9d14198e39c76ff0f6ac59064a13a1a72be229c1\", \"jingle_unittests\": \"90c4ca5f0d1a94c699de165941fed220ab7e61c6\", \"keyboard_unittests\": \"22d18248ad4cd401785ee5cd6cb9daaa183ea131\", \"latency_unittests\": \"819f72214af09d421d2d7b0226366330891aefb6\", \"libjingle_xmpp_unittests\": \"d253cc2514663887a6c7840772b1787a53fdb9fa\", \"liburlpattern_unittests\": \"6e6acc6cd5bd5be77befb152e8adb31d46cb0522\", \"media_blink_unittests\": \"15b5019057d4a973227f7a097d9b09fef8f26f50\", \"media_unittests\": \"62528f5725a47f4dbba53ec1898503fcb2bdea58\", \"message_center_unittests\": \"11d4908bee870a580787329607bb6df189bc6ec2\", \"midi_unittests\": \"4694566a6a5bbd4c284e5a4fe3598df8567e4e5b\", \"mojo_core_unittests\": \"c3fbdc1e5b4168175e7c63c72554d3bec5cd49e1\", \"mojo_unittests\": \"b4f59b8368d3b2c614d575d3af8982e4b2dfa66c\", \"nacl_helper_nonsfi_unittests\": \"bc19a9159ab18c9af23bca7e0d53e977150b6a12\", \"nacl_loader_unittests\": \"b2e31be29b777d92220e87c1e197df28bf333360\", \"native_theme_unittests\": \"797effd749aa24762df0e610bdba02f0f7e216ad\", \"net_unittests\": \"e0428071688799070b62ed1ffc1d5a937eeb0919\", \"ozone_gl_unittests\": \"76b98644b2a6c1ccf4e7cb20dd1d90c9ca815b12\", \"ozone_unittests\": \"0f6bad36e8300c9854fcb5e4b5c0f759a591f5f3\", \"ozone_x11_unittests\": \"a0946bf783c0e688451f025ff65777126d9b852f\", \"pdf_unittests\": \"9a37901ba67c0d96a08dfb77e6000c3f38aaffbb\", \"perfetto_unittests\": \"c8fc118aa67e5386f148564e31ca79f3ebc7d6e9\", \"ppapi_unittests\": \"3711767bc929f4ea714eb21856ad9ef56a72d6b4\", \"printing_unittests\": \"5e3b2e327ddfb4e08b1ed850dfb6f12704f90486\", \"remoting_unittests\": \"df1a6749f4bcb1f7815dd3f8ca9bafeb34c0580e\", \"sandbox_linux_unittests\": \"330660aad56daf5a87e5eb5909bdccda3236e8c8\", \"service_manager_unittests\": \"26d45513523821a0b7b47dc9ee9d3bfb5f6668ca\", \"services_unittests\": \"30d8690882028d22383b374dfe3a75b0c0794703\", \"shell_dialogs_unittests\": \"7826e38d5b6e4642a2390e3aa531c414971573df\", \"shell_encryption_unittests\": \"678d871cb512b4e31911fdad6b14bde46b30c848\", \"skia_unittests\": \"d4f2f4e5f2b072068b409545b598097f5e752060\", \"snapshot_unittests\": \"c564f2784165ff01b4f7b2722a4bbeadc453ca04\", \"sql_unittests\": \"118604fce1d19aa2b45ab5c485dfbbdfce271a81\", \"storage_unittests\": \"de9ce0eecf011b91513d8fd580894e94cf308eac\", \"sync_integration_tests\": \"87fa2fa8e85ec54d54842d3db595f2c8c4106be6\", \"traffic_annotation_auditor_unittests\": \"72a27a99a2e24593418d078d7700e46954cd4ba9\", \"ui_base_unittests\": \"e2a7207d926d3528a4411ec05aeecde7b3733c67\", \"ui_chromeos_unittests\": \"ccd28e4b9eef09101cd6e3962d220abc874a710a\", \"ui_touch_selection_unittests\": \"c838271fe2fdf1e3c1948fd6963d83d85e0991cc\", \"unit_tests\": \"29172c35a68b91bb1f25b20d02324b9ee140b9bc\", \"url_unittests\": \"bca8b882dec9b2bd30631f2153c69ae234219304\", \"usage_time_limit_unittests\": \"b65e88897a819e765b9693d9d4984df88835fc47\", \"views_unittests\": \"f36e6a6e31e233a0be062317ce6a4066904924d7\", \"viz_unittests\": \"ff9c3b68d8603bf6d31de277a97bb13d1f179722\", \"wm_unittests\": \"b411065e62f0894366166b6d444542a0042ec149\", \"wtf_unittests\": \"55bfdf69040618cc716c593b43560df13e4bde9e\", \"zlib_unittests\": \"33ef4daaa8b84eddd9365fb93dc6af0b0d0fbf6b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-184-d4lj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5696-2a606bc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613360281287145",
"status": "COMPLETED",
"status_changed_ts": "1613366935986511",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22627",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5c73cb6ac9d3d1bc025b7eb11c082b2c70be38e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020693169628947248",
"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/8855263107657743520/+/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:51bc91f246fbd410",
"user_agent:luci-scheduler"
],
"updated_ts": "1613366935991485",
"url": "https://ci.chromium.org/b/8855263107657743520",
"utcnow_ts": "1613366936855573"
}
}
[05:28:56.865] Invocation finished in 1h55m6.714620513s with status SUCCEEDED