[18:21:02.354] New invocation is queued and will start shortly
[18:21:03.704] Starting the invocation (attempt 1)
[18:21:03.748] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:21:03.748] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:21:03.748] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018644218382123904",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"926746ffc05e65388c45ea503b04f90c1b0f95f4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018644218382123904",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/926746ffc05e65388c45ea503b04f90c1b0f95f4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/926746ffc05e65388c45ea503b04f90c1b0f95f4",
"gitiles_ref:refs/heads/master"
]
}
[18:21:04.615] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615314063832132",
"id": "8853214156161853696",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"926746ffc05e65388c45ea503b04f90c1b0f95f4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615314064247420",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22925",
"builder:linux-chromeos-dbg",
"buildset:commit/git/926746ffc05e65388c45ea503b04f90c1b0f95f4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/926746ffc05e65388c45ea503b04f90c1b0f95f4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018644218382123904",
"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/8853214156161853696/+/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": "1615314064247564",
"url": "https://ci.chromium.org/b/8853214156161853696",
"utcnow_ts": "1615314064608182"
}
}
[18:21:04.615] Task URL: https://ci.chromium.org/b/8853214156161853696
[18:21:04.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:2:0) after 1m0s
[18:22:04.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:2:0)
[18:22:04.731] Timer tick, asking Buildbucket for the build status
[18:22:04.819] Build 8853214156161853696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:04.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:3:0) after 1m0s
[18:23:04.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:3:0)
[18:23:04.930] Timer tick, asking Buildbucket for the build status
[18:23:05.046] Build 8853214156161853696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:05.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:4:0) after 1m0s
[18:23:51.934] Received PubSub notification, asking Buildbucket for the build status
[18:23:52.067] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:05.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:4:0)
[18:24:05.111] Timer tick, asking Buildbucket for the build status
[18:24:05.211] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:05.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:6:0) after 1m0s
[18:25:05.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:6:0)
[18:25:05.175] Timer tick, asking Buildbucket for the build status
[18:25:05.835] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:05.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:7:0) after 1m0s
[18:26:05.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:7:0)
[18:26:05.888] Timer tick, asking Buildbucket for the build status
[18:26:05.999] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:05.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:8:0) after 1m0s
[18:27:06.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:8:0)
[18:27:06.051] Timer tick, asking Buildbucket for the build status
[18:27:06.354] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:06.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:9:0) after 1m0s
[18:28:06.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:9:0)
[18:28:06.434] Timer tick, asking Buildbucket for the build status
[18:28:06.504] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:06.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:10:0) after 1m0s
[18:29:06.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:10:0)
[18:29:06.521] Timer tick, asking Buildbucket for the build status
[18:29:06.641] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:06.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:11:0) after 1m0s
[18:30:06.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:11:0)
[18:30:06.651] Timer tick, asking Buildbucket for the build status
[18:30:06.787] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:06.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:12:0) after 1m0s
[18:31:07.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:12:0)
[18:31:07.013] Timer tick, asking Buildbucket for the build status
[18:31:07.170] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:07.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:13:0) after 1m0s
[18:32:07.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:13:0)
[18:32:07.196] Timer tick, asking Buildbucket for the build status
[18:32:07.426] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:07.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:14:0) after 1m0s
[18:33:07.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:14:0)
[18:33:07.465] Timer tick, asking Buildbucket for the build status
[18:33:07.530] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:07.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:15:0) after 1m0s
[18:34:07.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:15:0)
[18:34:07.569] Timer tick, asking Buildbucket for the build status
[18:34:07.636] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:07.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:16:0) after 1m0s
[18:35:07.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:16:0)
[18:35:07.679] Timer tick, asking Buildbucket for the build status
[18:35:07.770] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:07.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:17:0) after 1m0s
[18:36:07.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:17:0)
[18:36:07.936] Timer tick, asking Buildbucket for the build status
[18:36:08.150] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:08.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:18:0) after 1m0s
[18:37:08.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:18:0)
[18:37:08.215] Timer tick, asking Buildbucket for the build status
[18:37:08.288] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:08.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:19:0) after 1m0s
[18:38:08.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:19:0)
[18:38:08.526] Timer tick, asking Buildbucket for the build status
[18:38:08.662] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:08.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:20:0) after 1m0s
[18:39:08.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:20:0)
[18:39:08.832] Timer tick, asking Buildbucket for the build status
[18:39:08.912] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:08.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:21:0) after 1m0s
[18:40:09.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:21:0)
[18:40:09.029] Timer tick, asking Buildbucket for the build status
[18:40:09.152] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:09.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:22:0) after 1m0s
[18:41:09.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:22:0)
[18:41:09.251] Timer tick, asking Buildbucket for the build status
[18:41:09.340] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:09.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:23:0) after 1m0s
[18:42:09.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:23:0)
[18:42:09.362] Timer tick, asking Buildbucket for the build status
[18:42:09.639] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:09.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:24:0) after 1m0s
[18:43:09.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:24:0)
[18:43:09.703] Timer tick, asking Buildbucket for the build status
[18:43:09.818] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:09.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:25:0) after 1m0s
[18:44:10.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:25:0)
[18:44:10.127] Timer tick, asking Buildbucket for the build status
[18:44:10.194] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:10.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:26:0) after 1m0s
[18:45:10.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:26:0)
[18:45:10.339] Timer tick, asking Buildbucket for the build status
[18:45:10.419] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:10.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:27:0) after 1m0s
[18:46:10.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:27:0)
[18:46:10.439] Timer tick, asking Buildbucket for the build status
[18:46:10.528] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:10.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:28:0) after 1m0s
[18:47:10.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:28:0)
[18:47:10.597] Timer tick, asking Buildbucket for the build status
[18:47:10.678] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:10.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:29:0) after 1m0s
[18:48:10.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:29:0)
[18:48:10.783] Timer tick, asking Buildbucket for the build status
[18:48:10.867] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:10.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:30:0) after 1m0s
[18:49:11.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:30:0)
[18:49:11.241] Timer tick, asking Buildbucket for the build status
[18:49:11.333] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:11.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:31:0) after 1m0s
[18:50:11.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:31:0)
[18:50:11.578] Timer tick, asking Buildbucket for the build status
[18:50:11.843] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:11.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:32:0) after 1m0s
[18:51:11.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:32:0)
[18:51:11.865] Timer tick, asking Buildbucket for the build status
[18:51:12.066] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:12.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:33:0) after 1m0s
[18:52:12.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:33:0)
[18:52:12.099] Timer tick, asking Buildbucket for the build status
[18:52:12.437] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:12.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:34:0) after 1m0s
[18:53:12.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:34:0)
[18:53:12.520] Timer tick, asking Buildbucket for the build status
[18:53:12.613] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:12.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:35:0) after 1m0s
[18:54:12.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:35:0)
[18:54:12.685] Timer tick, asking Buildbucket for the build status
[18:54:12.941] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:12.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:36:0) after 1m0s
[18:55:13.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:36:0)
[18:55:13.012] Timer tick, asking Buildbucket for the build status
[18:55:13.140] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:13.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:37:0) after 1m0s
[18:56:13.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:37:0)
[18:56:13.452] Timer tick, asking Buildbucket for the build status
[18:56:13.534] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:13.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:38:0) after 1m0s
[18:57:13.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:38:0)
[18:57:13.645] Timer tick, asking Buildbucket for the build status
[18:57:13.794] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:13.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:39:0) after 1m0s
[18:58:13.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:39:0)
[18:58:13.853] Timer tick, asking Buildbucket for the build status
[18:58:14.147] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:14.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:40:0) after 1m0s
[18:59:14.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:40:0)
[18:59:14.226] Timer tick, asking Buildbucket for the build status
[18:59:14.376] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:14.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:41:0) after 1m0s
[19:00:14.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:41:0)
[19:00:14.392] Timer tick, asking Buildbucket for the build status
[19:00:14.567] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:14.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:42:0) after 1m0s
[19:01:14.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:42:0)
[19:01:14.615] Timer tick, asking Buildbucket for the build status
[19:01:14.714] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:14.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:43:0) after 1m0s
[19:02:14.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:43:0)
[19:02:14.815] Timer tick, asking Buildbucket for the build status
[19:02:14.916] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:14.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:44:0) after 1m0s
[19:03:15.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:44:0)
[19:03:15.017] Timer tick, asking Buildbucket for the build status
[19:03:15.714] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:15.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:45:0) after 1m0s
[19:04:15.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:45:0)
[19:04:15.825] Timer tick, asking Buildbucket for the build status
[19:04:15.926] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:15.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:46:0) after 1m0s
[19:05:16.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:46:0)
[19:05:16.028] Timer tick, asking Buildbucket for the build status
[19:05:16.224] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:16.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:47:0) after 1m0s
[19:06:16.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:47:0)
[19:06:16.308] Timer tick, asking Buildbucket for the build status
[19:06:16.390] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:16.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:48:0) after 1m0s
[19:07:16.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:48:0)
[19:07:16.469] Timer tick, asking Buildbucket for the build status
[19:07:16.614] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:49:0) after 1m0s
[19:08:16.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:49:0)
[19:08:16.641] Timer tick, asking Buildbucket for the build status
[19:08:16.735] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:16.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:50:0) after 1m0s
[19:09:16.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:50:0)
[19:09:16.753] Timer tick, asking Buildbucket for the build status
[19:09:16.861] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:16.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:51:0) after 1m0s
[19:10:16.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:51:0)
[19:10:16.878] Timer tick, asking Buildbucket for the build status
[19:10:16.972] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:16.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:52:0) after 1m0s
[19:11:16.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:52:0)
[19:11:16.998] Timer tick, asking Buildbucket for the build status
[19:11:17.094] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:17.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:53:0) after 1m0s
[19:12:17.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:53:0)
[19:12:17.209] Timer tick, asking Buildbucket for the build status
[19:12:17.311] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:17.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:54:0) after 1m0s
[19:13:17.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:54:0)
[19:13:17.398] Timer tick, asking Buildbucket for the build status
[19:13:17.663] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:17.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:55:0) after 1m0s
[19:14:17.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:55:0)
[19:14:17.784] Timer tick, asking Buildbucket for the build status
[19:14:19.008] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:19.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:56:0) after 1m0s
[19:15:19.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:56:0)
[19:15:19.089] Timer tick, asking Buildbucket for the build status
[19:15:19.176] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:19.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:57:0) after 1m0s
[19:16:19.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:57:0)
[19:16:19.305] Timer tick, asking Buildbucket for the build status
[19:16:19.514] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:19.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:58:0) after 1m0s
[19:17:19.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:58:0)
[19:17:19.614] Timer tick, asking Buildbucket for the build status
[19:17:19.825] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:19.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:59:0) after 1m0s
[19:18:19.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:59:0)
[19:18:19.893] Timer tick, asking Buildbucket for the build status
[19:18:20.033] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:20.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:60:0) after 1m0s
[19:19:20.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:60:0)
[19:19:20.053] Timer tick, asking Buildbucket for the build status
[19:19:20.151] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:20.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:61:0) after 1m0s
[19:20:20.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:61:0)
[19:20:20.171] Timer tick, asking Buildbucket for the build status
[19:20:20.466] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:20.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:62:0) after 1m0s
[19:21:20.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:62:0)
[19:21:20.489] Timer tick, asking Buildbucket for the build status
[19:21:20.585] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:20.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:63:0) after 1m0s
[19:22:20.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:63:0)
[19:22:20.616] Timer tick, asking Buildbucket for the build status
[19:22:20.873] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:20.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:64:0) after 1m0s
[19:23:20.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:64:0)
[19:23:20.873] Timer tick, asking Buildbucket for the build status
[19:23:20.951] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:20.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:65:0) after 1m0s
[19:24:20.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:65:0)
[19:24:20.993] Timer tick, asking Buildbucket for the build status
[19:24:21.096] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:21.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:66:0) after 1m0s
[19:25:21.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:66:0)
[19:25:21.260] Timer tick, asking Buildbucket for the build status
[19:25:22.868] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:22.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:67:0) after 1m0s
[19:26:22.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:67:0)
[19:26:22.921] Timer tick, asking Buildbucket for the build status
[19:26:23.040] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:23.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:68:0) after 1m0s
[19:27:23.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:68:0)
[19:27:23.149] Timer tick, asking Buildbucket for the build status
[19:27:23.246] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:23.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:69:0) after 1m0s
[19:28:23.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:69:0)
[19:28:23.423] Timer tick, asking Buildbucket for the build status
[19:28:23.514] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:23.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:70:0) after 1m0s
[19:29:23.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:70:0)
[19:29:23.571] Timer tick, asking Buildbucket for the build status
[19:29:25.473] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:25.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:71:0) after 1m0s
[19:30:25.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:71:0)
[19:30:25.855] Timer tick, asking Buildbucket for the build status
[19:30:25.958] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:25.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:72:0) after 1m0s
[19:31:25.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:72:0)
[19:31:25.959] Timer tick, asking Buildbucket for the build status
[19:31:26.055] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:26.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:73:0) after 1m0s
[19:32:26.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:73:0)
[19:32:26.210] Timer tick, asking Buildbucket for the build status
[19:32:26.413] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:26.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:74:0) after 1m0s
[19:33:26.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:74:0)
[19:33:26.606] Timer tick, asking Buildbucket for the build status
[19:33:26.689] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:26.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:75:0) after 1m0s
[19:34:26.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:75:0)
[19:34:26.841] Timer tick, asking Buildbucket for the build status
[19:34:26.965] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:26.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:76:0) after 1m0s
[19:35:26.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:76:0)
[19:35:26.958] Timer tick, asking Buildbucket for the build status
[19:35:27.051] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:27.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:77:0) after 1m0s
[19:36:27.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:77:0)
[19:36:27.108] Timer tick, asking Buildbucket for the build status
[19:36:27.194] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:27.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:78:0) after 1m0s
[19:37:27.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:78:0)
[19:37:27.240] Timer tick, asking Buildbucket for the build status
[19:37:27.340] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:27.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:79:0) after 1m0s
[19:38:27.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:79:0)
[19:38:27.387] Timer tick, asking Buildbucket for the build status
[19:38:27.723] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:27.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:80:0) after 1m0s
[19:39:27.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:80:0)
[19:39:27.764] Timer tick, asking Buildbucket for the build status
[19:39:27.862] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:27.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:81:0) after 1m0s
[19:40:27.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:81:0)
[19:40:27.913] Timer tick, asking Buildbucket for the build status
[19:40:28.342] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:28.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:82:0) after 1m0s
[19:41:28.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:82:0)
[19:41:28.405] Timer tick, asking Buildbucket for the build status
[19:41:28.621] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:28.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:83:0) after 1m0s
[19:42:28.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:83:0)
[19:42:28.671] Timer tick, asking Buildbucket for the build status
[19:42:28.809] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:28.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:84:0) after 1m0s
[19:43:28.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:84:0)
[19:43:28.817] Timer tick, asking Buildbucket for the build status
[19:43:29.112] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:29.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:85:0) after 1m0s
[19:44:29.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:85:0)
[19:44:29.117] Timer tick, asking Buildbucket for the build status
[19:44:29.293] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:29.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:86:0) after 1m0s
[19:45:29.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:86:0)
[19:45:29.304] Timer tick, asking Buildbucket for the build status
[19:45:29.404] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:29.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:87:0) after 1m0s
[19:46:29.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:87:0)
[19:46:29.430] Timer tick, asking Buildbucket for the build status
[19:46:30.123] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:30.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:88:0) after 1m0s
[19:47:30.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:88:0)
[19:47:30.145] Timer tick, asking Buildbucket for the build status
[19:47:30.262] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:30.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:89:0) after 1m0s
[19:48:30.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:89:0)
[19:48:30.331] Timer tick, asking Buildbucket for the build status
[19:48:30.413] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:30.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:90:0) after 1m0s
[19:49:30.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:90:0)
[19:49:30.552] Timer tick, asking Buildbucket for the build status
[19:49:30.768] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:30.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:91:0) after 1m0s
[19:50:30.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:91:0)
[19:50:30.781] Timer tick, asking Buildbucket for the build status
[19:50:30.880] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:30.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:92:0) after 1m0s
[19:51:30.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:92:0)
[19:51:30.904] Timer tick, asking Buildbucket for the build status
[19:51:30.985] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:30.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:93:0) after 1m0s
[19:52:31.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:93:0)
[19:52:31.532] Timer tick, asking Buildbucket for the build status
[19:52:31.719] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:31.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:94:0) after 1m0s
[19:53:32.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:94:0)
[19:53:32.953] Timer tick, asking Buildbucket for the build status
[19:53:33.033] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:33.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:95:0) after 1m0s
[19:54:33.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:95:0)
[19:54:33.430] Timer tick, asking Buildbucket for the build status
[19:54:33.521] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:33.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:96:0) after 1m0s
[19:55:33.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:96:0)
[19:55:33.643] Timer tick, asking Buildbucket for the build status
[19:55:33.740] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:33.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:97:0) after 1m0s
[19:56:33.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:97:0)
[19:56:33.905] Timer tick, asking Buildbucket for the build status
[19:56:34.352] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:34.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:98:0) after 1m0s
[19:57:34.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:98:0)
[19:57:34.443] Timer tick, asking Buildbucket for the build status
[19:57:34.722] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:34.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:99:0) after 1m0s
[19:58:34.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:99:0)
[19:58:34.802] Timer tick, asking Buildbucket for the build status
[19:58:37.054] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:37.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:100:0) after 1m0s
[19:59:38.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:100:0)
[19:59:38.734] Timer tick, asking Buildbucket for the build status
[19:59:39.117] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:39.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:101:0) after 1m0s
[20:00:39.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:101:0)
[20:00:39.205] Timer tick, asking Buildbucket for the build status
[20:00:39.413] Build 8853214156161853696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:39.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018644218382123904:102:0) after 1m0s
[20:00:46.885] Received PubSub notification, asking Buildbucket for the build status
[20:00:46.978] Build 8853214156161853696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:00:46.979] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615320046178981",
"created_by": "project:chromium",
"created_ts": "1615314063832132",
"id": "8853214156161853696",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"926746ffc05e65388c45ea503b04f90c1b0f95f4\"}}",
"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\": \"926746ffc05e65388c45ea503b04f90c1b0f95f4\", \"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-201-1nl3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22925, \"got_angle_revision\": \"faa3915ee3f06dade41a2bc260d850b99c5c6845\", \"got_dawn_revision\": \"7fe018c06578ff04d0e4ec2a0ada2c34a82ef6b0\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"926746ffc05e65388c45ea503b04f90c1b0f95f4\", \"got_revision_cp\": \"refs/heads/master@{#861216}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"af560a8bf8228e4c3ec67af7a567370c75ff17bc\", \"got_v8_revision_cp\": \"refs/heads/9.1.81@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"926746ffc05e65388c45ea503b04f90c1b0f95f4\", \"swarm_hashes_refs/heads/master(at){#861216}_without_patch\": {\"absl_hardening_tests\": \"502b60ed75e6fb14e038f35c981e5a59079b2aa4\", \"accessibility_unittests\": \"53bf46cf6238d87c48748e93a7e3ea286f5b814c\", \"angle_unittests\": \"7bd88d5e3431b56629d214ac63922a901b064a58\", \"app_list_unittests\": \"6ff074e4256d9c69ab93b69ffa80432da7016cdf\", \"app_shell_unittests\": \"d702f6869f4e94070fb2773e8fbdf6caf6430dbe\", \"ash_unittests\": \"7057db5f16ab19cbbc56308aed51dcbdae3643bc\", \"aura_unittests\": \"e5d1b57e1c45a22b5ef3f8ccc16078e6cfa4221f\", \"base_unittests\": \"0e8146f2e0b803429782ed7e68972d18ec6207a0\", \"base_util_unittests\": \"0662b5be972e2b9a3d095b9d7e7e5f66f136a583\", \"blink_common_unittests\": \"0dab3630de66802151ba5c7042920dbdba520681\", \"blink_fuzzer_unittests\": \"d248dfe1c05b4747a50af14834881536ddb19688\", \"blink_heap_unittests\": \"16f4e634fa08949b5d1630e7d3e2a795ab66f7f2\", \"blink_platform_unittests\": \"3787769003fc546e38207f81bfab7445ce89e875\", \"blink_unittests\": \"c6897813c0634eb67709a15cc9fbae3c5c28fbbe\", \"boringssl_crypto_tests\": \"eba79d408bb8e67ed30f7ec0b1ceeb3e0a8796b7\", \"boringssl_ssl_tests\": \"a6c61478ae0129ac4bde2a8eae5f5a4099f498ae\", \"browser_tests\": \"acae899c7f5c0aae0cb93fe9b39b2bd71e217a9b\", \"capture_unittests\": \"82679925d5a1d17ba2ceab453204effc500cf2a9\", \"cast_unittests\": \"9ab097dac57aa6880d0bb5e3a1ea369540404c14\", \"cc_unittests\": \"60353ae0d393219aaaee33c6ad0aabd8aa7b3724\", \"chrome_app_unittests\": \"0cc5f66cf362e71342adfa1fd8bbdc0014d44d42\", \"chromedriver_unittests\": \"e5a6ab3c6dfdcb51884d93c5b8c6bd89170a9953\", \"chromeos_components_unittests\": \"c81527cdadd5c22dc66a22f4ea98a11e3429ffe3\", \"chromeos_unittests\": \"51448feaf3b3ebe131780bb4587bf13d5b8088c7\", \"color_unittests\": \"b41d833b3f9f24a7af0902080e16560dc9f45e0b\", \"components_browsertests\": \"b0737094c3a3366d4afecbc6650334014e80c5c8\", \"components_unittests\": \"991844f6172fc6f37f53ebfbfc4302bfaea38eca\", \"compositor_unittests\": \"fa4dd325886a134f61f5c8b7f9d8510590963175\", \"content_browsertests\": \"e0839f6d4ec961d034630d24fe2702d9b11887d8\", \"content_unittests\": \"b54fef11184507c9c64cd1e6d2442f038af0b8d6\", \"crashpad_tests\": \"1bacb7dc8e393a6967a87468279073ac4d52c411\", \"crypto_unittests\": \"c120fa61041bed5843250309d00580986b28b0af\", \"dbus_unittests\": \"99605d43ebe5e8e80895cb98959f917263f5c795\", \"device_unittests\": \"fd733b46c9450f123db5c1fce26e738881bbd5fb\", \"display_unittests\": \"e507eb6986faaa13b57be3805ea748bf6826d5ea\", \"events_unittests\": \"d60a960675c298ac95037e740e3727204d5e5817\", \"exo_unittests\": \"060d3f797b68d620b1991b3c27ac19f39837999a\", \"extensions_browsertests\": \"53f69a8c59a9124ce76ee2a0e5950f046f7b698c\", \"extensions_unittests\": \"d1b2297530a9a096590179386dc3836ca3c6cd2d\", \"filesystem_service_unittests\": \"0c10eba8c672d8753a5a541676e99ce07fb32a92\", \"gcm_unit_tests\": \"b5f673ab3d3ba1069df97b02f97fb5da80238d41\", \"gfx_unittests\": \"49d6db54a060afca8830b7d8ce87c6fd2855ea30\", \"gin_unittests\": \"824884da29adaed3dea4a427e438a12349b73b9b\", \"gl_unittests_ozone\": \"796dc4ddfce07250f132a239dee92fc2f3d83cb7\", \"google_apis_unittests\": \"673897fca70b9f4d822ce926f0016a2ac544fbce\", \"gpu_unittests\": \"f8f767093b6d75489514b3f58f6e7f130c4897b1\", \"gwp_asan_unittests\": \"ebca812c083544c970d2c913ff3e54614f839b62\", \"interactive_ui_tests\": \"1a57d9cf67aea0edd98f0dd1617048001c6a0484\", \"ipc_tests\": \"820f37ac83b6f5bc4a1ab6165d00587d93c9896d\", \"jingle_unittests\": \"a4832c986a7a0fe9ccef14805a6e7f7254272013\", \"keyboard_unittests\": \"34656298dc6bad06592c1444850309bfcc4ddcab\", \"latency_unittests\": \"8f0ee6dcced0fb861b29f248545cf6db7859c50f\", \"libjingle_xmpp_unittests\": \"5a3dbad4b13491d714f4087d41f384685a5ba864\", \"liburlpattern_unittests\": \"24a35a7ea144f18207744150f3e2d04aab6ab260\", \"media_blink_unittests\": \"b0193fc240d457afaac8062e8fd3ed556b06d53d\", \"media_unittests\": \"32fc54b0dcf54e3c6d6ddbbb3e8f6b72dd27342f\", \"message_center_unittests\": \"f06770b8a175c7fb1bd1d2da5cd361df102742c0\", \"midi_unittests\": \"cb24f3a7969197e057396c093743465f5198576b\", \"mojo_core_unittests\": \"e0936d9e692cfa28152c06e5677dc1bbb58a64f1\", \"mojo_unittests\": \"5d843cdb3094ccee160913a361eefaf1a713f3ec\", \"nacl_helper_nonsfi_unittests\": \"d1d0e4ecbbf46769a6755326cf43fa1b1002d5a4\", \"nacl_loader_unittests\": \"0bc2b96f436c76e0d308291ce04d28efc8230db9\", \"native_theme_unittests\": \"846686d8f17c3342cebbbeeb9414f34fd91ead39\", \"net_unittests\": \"7235d181d07ef2c3a2ec964c56a40b29dffbfb5d\", \"ozone_gl_unittests\": \"e5f99f7681956a803122f3f25747656feb58b144\", \"ozone_unittests\": \"6969d5d7da5d263d6c1e40175e62aa4046c2e6ec\", \"ozone_x11_unittests\": \"727643fc9d620f7ba8b3a208a1b70a38d1ecf78a\", \"pdf_unittests\": \"da4379146ea4f314ef3eb2500b35830e082cf073\", \"perfetto_unittests\": \"592197988336aa399a05018846b8560ac85bf08b\", \"ppapi_unittests\": \"ecc0aeac81ccf9d28887a73e10dc36227fe79928\", \"printing_unittests\": \"109aa45a4791c1ac69986d54e517c95eca9781dd\", \"remoting_unittests\": \"c717f7dfc421dbdea0afeb5537b94b24e9143d7d\", \"sandbox_linux_unittests\": \"af543626b5b7d1d53a2fa39521563d1137338e8c\", \"service_manager_unittests\": \"d6aa3f6df0585944b510d914b7909020ea3199ea\", \"services_unittests\": \"b7e9663a2967121154be7972f7942b858e4f3a80\", \"shell_dialogs_unittests\": \"40c9f4aefdff2cb53f6c35dfe3f2e965594a5188\", \"shell_encryption_unittests\": \"7a92a38e6678aa35719f7c751dc497b3ab4b1360\", \"skia_unittests\": \"033b0e5235638a06538845469de59e12c60f1eb6\", \"snapshot_unittests\": \"6f7dc32b35e8ac7bb6f46b94d8b9faa88c4e66dd\", \"sql_unittests\": \"70998da1c4cae4682d636ef8602de22b20089fa3\", \"storage_unittests\": \"4472bc4a2e5c19af1ebc992cb78aeddd666c7e6f\", \"sync_integration_tests\": \"87f8dfc3b7d826b3d850a33d4a2d450660ed2431\", \"traffic_annotation_auditor_unittests\": \"3d4d8abf2ee70d04df40bf5eea17955492404ef5\", \"ui_base_unittests\": \"f446206031a66f8d79b1a4e39d04141a98cf380a\", \"ui_chromeos_unittests\": \"06809cf1c91b6a3b886016145b78295fcaa9130a\", \"ui_touch_selection_unittests\": \"ccf366ef84ed711573c559f1e6644c700243dcdf\", \"unit_tests\": \"96f86cad5275afd2e1e245cc27acf39720648433\", \"url_unittests\": \"49c59366de9214c0076f62ff877f3cc05d559075\", \"usage_time_limit_unittests\": \"1ef474ea44204e8cb03f5da781ade0fafb668e91\", \"views_unittests\": \"5a4c18bb336679c322374d2e8f956b8a34127b15\", \"viz_unittests\": \"0606230aa69189bdfdd82aef61ef75f9d3143c57\", \"wayland_client_tests\": \"b9b8e538066078859155e2c4ec4b7dbe0ff06421\", \"wm_unittests\": \"595beb3516e237940ecd691e5bfb2379cfc88e87\", \"wtf_unittests\": \"13f0b7342447ac8cedb986af133ab7cabcbd08ee\", \"zlib_unittests\": \"522ff51e194715f2dc64a931f5f7ab510f95f9cc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_349e20fa0346c22afd9d85eafc166958d65f8d3eb174d2113a3f89c2e822dead_v2\", \"builder_3ee79eab7726d87d4f9bf92f4b58b9506b0a7a0d17f466f0c3d67bd50a4697d1_v2\", \"builder_4637b11d2a56187e25d14badb4fa154a12143e816e25cb34f5fe38c5c81ebb47_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-201-1nl3\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615314230908925",
"status": "COMPLETED",
"status_changed_ts": "1615320046443412",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22925",
"builder:linux-chromeos-dbg",
"buildset:commit/git/926746ffc05e65388c45ea503b04f90c1b0f95f4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/926746ffc05e65388c45ea503b04f90c1b0f95f4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018644218382123904",
"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/8853214156161853696/+/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:52310a1d1e0fff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615320046447415",
"url": "https://ci.chromium.org/b/8853214156161853696",
"utcnow_ts": "1615320046948821"
}
}
[20:00:46.979] Invocation finished in 1h39m44.647987186s with status SUCCEEDED