[17:48:38.627] New invocation is queued and will start shortly
[17:48:39.805] Starting the invocation (attempt 1)
[17:48:39.840] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:48:39.841] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:48:39.841] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018736853486632384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018736853486632384",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366",
"gitiles_ref:refs/heads/master"
]
}
[17:48:40.512] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1615225719954119",
"id": "8853306791431846144",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615225720368393",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22911",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018736853486632384",
"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/8853306791431846144/+/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": "1615225720368526",
"url": "https://ci.chromium.org/b/8853306791431846144",
"utcnow_ts": "1615225720502586"
}
}
[17:48:40.512] Task URL: https://ci.chromium.org/b/8853306791431846144
[17:48:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:2:0) after 1m0s
[17:49:16.458] Received PubSub notification, asking Buildbucket for the build status
[17:49:17.863] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:40.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:2:0)
[17:49:40.529] Timer tick, asking Buildbucket for the build status
[17:49:40.678] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:40.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:4:0) after 1m0s
[17:50:40.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:4:0)
[17:50:40.765] Timer tick, asking Buildbucket for the build status
[17:50:41.015] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:41.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:5:0) after 1m0s
[17:51:41.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:5:0)
[17:51:41.029] Timer tick, asking Buildbucket for the build status
[17:51:41.462] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:41.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:6:0) after 1m0s
[17:52:41.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:6:0)
[17:52:41.456] Timer tick, asking Buildbucket for the build status
[17:52:41.539] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:41.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:7:0) after 1m0s
[17:53:41.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:7:0)
[17:53:41.548] Timer tick, asking Buildbucket for the build status
[17:53:41.628] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:8:0) after 1m0s
[17:54:41.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:8:0)
[17:54:41.656] Timer tick, asking Buildbucket for the build status
[17:54:43.279] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:43.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:9:0) after 1m0s
[17:55:43.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:9:0)
[17:55:43.301] Timer tick, asking Buildbucket for the build status
[17:55:44.235] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:44.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:10:0) after 1m0s
[17:56:44.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:10:0)
[17:56:44.253] Timer tick, asking Buildbucket for the build status
[17:56:44.432] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:11:0) after 1m0s
[17:57:44.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:11:0)
[17:57:44.459] Timer tick, asking Buildbucket for the build status
[17:57:44.592] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:44.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:12:0) after 1m0s
[17:58:44.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:12:0)
[17:58:44.609] Timer tick, asking Buildbucket for the build status
[17:58:44.783] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:44.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:13:0) after 1m0s
[17:59:44.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:13:0)
[17:59:44.816] Timer tick, asking Buildbucket for the build status
[17:59:44.879] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:44.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:14:0) after 1m0s
[18:00:44.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:14:0)
[18:00:44.891] Timer tick, asking Buildbucket for the build status
[18:00:45.014] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:45.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:15:0) after 1m0s
[18:01:45.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:15:0)
[18:01:45.054] Timer tick, asking Buildbucket for the build status
[18:01:45.168] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:45.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:16:0) after 1m0s
[18:02:45.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:16:0)
[18:02:45.186] Timer tick, asking Buildbucket for the build status
[18:02:45.326] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:45.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:17:0) after 1m0s
[18:03:45.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:17:0)
[18:03:45.343] Timer tick, asking Buildbucket for the build status
[18:03:45.434] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:45.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:18:0) after 1m0s
[18:04:45.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:18:0)
[18:04:45.450] Timer tick, asking Buildbucket for the build status
[18:04:45.542] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:45.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:19:0) after 1m0s
[18:05:45.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:19:0)
[18:05:45.642] Timer tick, asking Buildbucket for the build status
[18:05:45.793] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:45.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:20:0) after 1m0s
[18:06:45.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:20:0)
[18:06:45.809] Timer tick, asking Buildbucket for the build status
[18:06:46.004] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:46.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:21:0) after 1m0s
[18:07:46.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:21:0)
[18:07:46.026] Timer tick, asking Buildbucket for the build status
[18:07:46.117] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:46.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:22:0) after 1m0s
[18:08:46.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:22:0)
[18:08:46.112] Timer tick, asking Buildbucket for the build status
[18:08:46.209] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:46.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:23:0) after 1m0s
[18:09:46.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:23:0)
[18:09:46.254] Timer tick, asking Buildbucket for the build status
[18:09:46.470] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:46.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:24:0) after 1m0s
[18:10:46.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:24:0)
[18:10:46.496] Timer tick, asking Buildbucket for the build status
[18:10:46.571] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:46.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:25:0) after 1m0s
[18:11:46.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:25:0)
[18:11:46.617] Timer tick, asking Buildbucket for the build status
[18:11:46.731] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:46.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:26:0) after 1m0s
[18:12:46.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:26:0)
[18:12:46.751] Timer tick, asking Buildbucket for the build status
[18:12:46.849] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:46.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:27:0) after 1m0s
[18:13:46.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:27:0)
[18:13:46.922] Timer tick, asking Buildbucket for the build status
[18:13:47.052] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:47.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:28:0) after 1m0s
[18:14:47.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:28:0)
[18:14:47.139] Timer tick, asking Buildbucket for the build status
[18:14:47.239] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:47.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:29:0) after 1m0s
[18:15:47.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:29:0)
[18:15:47.566] Timer tick, asking Buildbucket for the build status
[18:15:47.631] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:47.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:30:0) after 1m0s
[18:16:47.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:30:0)
[18:16:47.695] Timer tick, asking Buildbucket for the build status
[18:16:47.801] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:47.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:31:0) after 1m0s
[18:17:47.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:31:0)
[18:17:47.882] Timer tick, asking Buildbucket for the build status
[18:17:47.968] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:47.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:32:0) after 1m0s
[18:18:48.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:32:0)
[18:18:48.002] Timer tick, asking Buildbucket for the build status
[18:18:48.081] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:48.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:33:0) after 1m0s
[18:19:48.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:33:0)
[18:19:48.125] Timer tick, asking Buildbucket for the build status
[18:19:48.205] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:48.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:34:0) after 1m0s
[18:20:48.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:34:0)
[18:20:48.216] Timer tick, asking Buildbucket for the build status
[18:20:48.336] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:48.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:35:0) after 1m0s
[18:21:48.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:35:0)
[18:21:48.477] Timer tick, asking Buildbucket for the build status
[18:21:48.835] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:48.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:36:0) after 1m0s
[18:22:48.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:36:0)
[18:22:48.841] Timer tick, asking Buildbucket for the build status
[18:22:48.922] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:48.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:37:0) after 1m0s
[18:23:49.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:37:0)
[18:23:49.062] Timer tick, asking Buildbucket for the build status
[18:23:49.799] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:49.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:38:0) after 1m0s
[18:24:49.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:38:0)
[18:24:49.852] Timer tick, asking Buildbucket for the build status
[18:24:50.024] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:50.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:39:0) after 1m0s
[18:25:50.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:39:0)
[18:25:50.035] Timer tick, asking Buildbucket for the build status
[18:25:50.141] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:50.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:40:0) after 1m0s
[18:26:50.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:40:0)
[18:26:50.274] Timer tick, asking Buildbucket for the build status
[18:26:50.351] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:50.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:41:0) after 1m0s
[18:27:50.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:41:0)
[18:27:50.359] Timer tick, asking Buildbucket for the build status
[18:27:50.600] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:50.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:42:0) after 1m0s
[18:28:50.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:42:0)
[18:28:50.681] Timer tick, asking Buildbucket for the build status
[18:28:50.968] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:50.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:43:0) after 1m0s
[18:29:51.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:43:0)
[18:29:51.057] Timer tick, asking Buildbucket for the build status
[18:29:51.133] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:51.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:44:0) after 1m0s
[18:30:51.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:44:0)
[18:30:51.149] Timer tick, asking Buildbucket for the build status
[18:30:51.231] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:51.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:45:0) after 1m0s
[18:31:51.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:45:0)
[18:31:51.257] Timer tick, asking Buildbucket for the build status
[18:31:51.326] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:51.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:46:0) after 1m0s
[18:32:51.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:46:0)
[18:32:51.415] Timer tick, asking Buildbucket for the build status
[18:32:51.541] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:51.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:47:0) after 1m0s
[18:33:51.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:47:0)
[18:33:51.634] Timer tick, asking Buildbucket for the build status
[18:33:51.853] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:51.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:48:0) after 1m0s
[18:34:51.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:48:0)
[18:34:51.924] Timer tick, asking Buildbucket for the build status
[18:34:52.837] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:52.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:49:0) after 1m0s
[18:35:52.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:49:0)
[18:35:52.894] Timer tick, asking Buildbucket for the build status
[18:35:52.985] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:52.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:50:0) after 1m0s
[18:36:53.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:50:0)
[18:36:53.044] Timer tick, asking Buildbucket for the build status
[18:36:53.156] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:53.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:51:0) after 1m0s
[18:37:53.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:51:0)
[18:37:53.236] Timer tick, asking Buildbucket for the build status
[18:37:53.354] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:53.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:52:0) after 1m0s
[18:38:53.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:52:0)
[18:38:53.386] Timer tick, asking Buildbucket for the build status
[18:38:53.629] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:53.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:53:0) after 1m0s
[18:39:53.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:53:0)
[18:39:53.672] Timer tick, asking Buildbucket for the build status
[18:39:53.815] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:53.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:54:0) after 1m0s
[18:40:53.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:54:0)
[18:40:53.843] Timer tick, asking Buildbucket for the build status
[18:40:54.971] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:54.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:55:0) after 1m0s
[18:41:54.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:55:0)
[18:41:54.974] Timer tick, asking Buildbucket for the build status
[18:41:55.065] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:55.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:56:0) after 1m0s
[18:42:55.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:56:0)
[18:42:55.080] Timer tick, asking Buildbucket for the build status
[18:42:55.235] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:55.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:57:0) after 1m0s
[18:43:55.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:57:0)
[18:43:55.366] Timer tick, asking Buildbucket for the build status
[18:43:55.485] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:55.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:58:0) after 1m0s
[18:44:55.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:58:0)
[18:44:55.601] Timer tick, asking Buildbucket for the build status
[18:44:56.016] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:56.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:59:0) after 1m0s
[18:45:56.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:59:0)
[18:45:56.171] Timer tick, asking Buildbucket for the build status
[18:45:56.461] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:56.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:60:0) after 1m0s
[18:46:56.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:60:0)
[18:46:56.484] Timer tick, asking Buildbucket for the build status
[18:46:56.554] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:56.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:61:0) after 1m0s
[18:47:56.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:61:0)
[18:47:56.582] Timer tick, asking Buildbucket for the build status
[18:47:56.699] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:56.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:62:0) after 1m0s
[18:48:56.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:62:0)
[18:48:56.726] Timer tick, asking Buildbucket for the build status
[18:48:56.836] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:56.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:63:0) after 1m0s
[18:49:56.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:63:0)
[18:49:56.950] Timer tick, asking Buildbucket for the build status
[18:49:59.142] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:59.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:64:0) after 1m0s
[18:50:59.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:64:0)
[18:50:59.622] Timer tick, asking Buildbucket for the build status
[18:50:59.778] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:59.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:65:0) after 1m0s
[18:51:59.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:65:0)
[18:51:59.862] Timer tick, asking Buildbucket for the build status
[18:52:00.808] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:00.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:66:0) after 1m0s
[18:53:00.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:66:0)
[18:53:00.794] Timer tick, asking Buildbucket for the build status
[18:53:01.093] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:01.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:67:0) after 1m0s
[18:54:01.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:67:0)
[18:54:01.144] Timer tick, asking Buildbucket for the build status
[18:54:01.241] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:01.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:68:0) after 1m0s
[18:55:02.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:68:0)
[18:55:02.350] Timer tick, asking Buildbucket for the build status
[18:55:02.439] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:02.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:69:0) after 1m0s
[18:56:02.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:69:0)
[18:56:02.837] Timer tick, asking Buildbucket for the build status
[18:56:03.318] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:03.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:70:0) after 1m0s
[18:57:03.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:70:0)
[18:57:03.376] Timer tick, asking Buildbucket for the build status
[18:57:04.383] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:04.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:71:0) after 1m0s
[18:58:04.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:71:0)
[18:58:04.477] Timer tick, asking Buildbucket for the build status
[18:58:04.606] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:04.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:72:0) after 1m0s
[18:59:04.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:72:0)
[18:59:04.754] Timer tick, asking Buildbucket for the build status
[18:59:04.923] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:04.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:73:0) after 1m0s
[19:00:05.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:73:0)
[19:00:05.015] Timer tick, asking Buildbucket for the build status
[19:00:05.521] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:05.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:74:0) after 1m0s
[19:01:05.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:74:0)
[19:01:05.865] Timer tick, asking Buildbucket for the build status
[19:01:05.972] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:05.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:75:0) after 1m0s
[19:02:06.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:75:0)
[19:02:06.104] Timer tick, asking Buildbucket for the build status
[19:02:06.199] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:06.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:76:0) after 1m0s
[19:03:06.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:76:0)
[19:03:06.361] Timer tick, asking Buildbucket for the build status
[19:03:06.656] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:06.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:77:0) after 1m0s
[19:04:06.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:77:0)
[19:04:06.677] Timer tick, asking Buildbucket for the build status
[19:04:06.840] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:06.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:78:0) after 1m0s
[19:05:06.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:78:0)
[19:05:06.860] Timer tick, asking Buildbucket for the build status
[19:05:06.948] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:06.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:79:0) after 1m0s
[19:06:07.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:79:0)
[19:06:07.028] Timer tick, asking Buildbucket for the build status
[19:06:07.118] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:07.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:80:0) after 1m0s
[19:07:07.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:80:0)
[19:07:07.314] Timer tick, asking Buildbucket for the build status
[19:07:07.558] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:07.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:81:0) after 1m0s
[19:08:07.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:81:0)
[19:08:07.793] Timer tick, asking Buildbucket for the build status
[19:08:08.478] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:08.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:82:0) after 1m0s
[19:09:08.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:82:0)
[19:09:08.525] Timer tick, asking Buildbucket for the build status
[19:09:08.981] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:08.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:83:0) after 1m0s
[19:10:09.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:83:0)
[19:10:09.028] Timer tick, asking Buildbucket for the build status
[19:10:09.126] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:09.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:84:0) after 1m0s
[19:11:09.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:84:0)
[19:11:09.172] Timer tick, asking Buildbucket for the build status
[19:11:09.281] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:09.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:85:0) after 1m0s
[19:12:09.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:85:0)
[19:12:09.396] Timer tick, asking Buildbucket for the build status
[19:12:09.543] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:09.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:86:0) after 1m0s
[19:13:09.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:86:0)
[19:13:09.564] Timer tick, asking Buildbucket for the build status
[19:13:09.847] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:09.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:87:0) after 1m0s
[19:14:09.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:87:0)
[19:14:09.925] Timer tick, asking Buildbucket for the build status
[19:14:10.153] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:10.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:88:0) after 1m0s
[19:15:10.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:88:0)
[19:15:10.164] Timer tick, asking Buildbucket for the build status
[19:15:10.241] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:10.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:89:0) after 1m0s
[19:16:10.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:89:0)
[19:16:10.286] Timer tick, asking Buildbucket for the build status
[19:16:12.364] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:12.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:90:0) after 1m0s
[19:17:12.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:90:0)
[19:17:12.428] Timer tick, asking Buildbucket for the build status
[19:17:12.561] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:12.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:91:0) after 1m0s
[19:18:12.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:91:0)
[19:18:12.546] Timer tick, asking Buildbucket for the build status
[19:18:12.720] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:12.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:92:0) after 1m0s
[19:19:12.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:92:0)
[19:19:12.808] Timer tick, asking Buildbucket for the build status
[19:19:12.917] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:12.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:93:0) after 1m0s
[19:20:13.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:93:0)
[19:20:13.045] Timer tick, asking Buildbucket for the build status
[19:20:13.216] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:13.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:94:0) after 1m0s
[19:21:13.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:94:0)
[19:21:13.253] Timer tick, asking Buildbucket for the build status
[19:21:13.626] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:13.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:95:0) after 1m0s
[19:22:13.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:95:0)
[19:22:13.743] Timer tick, asking Buildbucket for the build status
[19:22:13.862] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:13.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:96:0) after 1m0s
[19:23:14.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:96:0)
[19:23:14.096] Timer tick, asking Buildbucket for the build status
[19:23:14.294] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:14.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:97:0) after 1m0s
[19:24:14.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:97:0)
[19:24:14.500] Timer tick, asking Buildbucket for the build status
[19:24:14.632] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:14.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:98:0) after 1m0s
[19:25:14.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:98:0)
[19:25:14.681] Timer tick, asking Buildbucket for the build status
[19:25:14.810] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:14.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:99:0) after 1m0s
[19:26:14.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:99:0)
[19:26:14.922] Timer tick, asking Buildbucket for the build status
[19:26:15.244] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:15.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:100:0) after 1m0s
[19:27:15.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:100:0)
[19:27:15.314] Timer tick, asking Buildbucket for the build status
[19:27:15.394] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:15.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:101:0) after 1m0s
[19:28:15.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:101:0)
[19:28:15.575] Timer tick, asking Buildbucket for the build status
[19:28:15.650] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:15.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:102:0) after 1m0s
[19:29:15.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:102:0)
[19:29:15.806] Timer tick, asking Buildbucket for the build status
[19:29:16.113] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:16.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:103:0) after 1m0s
[19:30:16.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:103:0)
[19:30:16.189] Timer tick, asking Buildbucket for the build status
[19:30:19.224] Build 8853306791431846144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:19.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018736853486632384:104:0) after 1m0s
[19:30:30.144] Received PubSub notification, asking Buildbucket for the build status
[19:30:30.246] Build 8853306791431846144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:30:30.246] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615231828323217",
"created_by": "project:chromium",
"created_ts": "1615225719954119",
"id": "8853306791431846144",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366\"}}",
"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\": \"9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366\", \"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-176-31uw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22911, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366\", \"got_revision_cp\": \"refs/heads/master@{#860769}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"ad7609182d57f01afd2e2769869b7c3e23282119\", \"got_v8_revision_cp\": \"refs/heads/9.1.65@{#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\": \"9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366\", \"swarm_hashes_refs/heads/master(at){#860769}_without_patch\": {\"absl_hardening_tests\": \"9de80d07aa6209f4f40fa464dd4877df6a52a94c\", \"accessibility_unittests\": \"0877edd804568dd682b8ec55f83feb9eda0eda89\", \"angle_unittests\": \"648f29cf678a6c1bf296ce5454c1ce97e8e667ab\", \"app_list_unittests\": \"08d17f377d9b71b9e9ad6183787aa3c50eece3ef\", \"app_shell_unittests\": \"cb52f412d2b27bb530594b82daeeaa588b338902\", \"ash_unittests\": \"dc30a46272d8211b262c2e521fdb250089166031\", \"aura_unittests\": \"7ddaab3020de23eb9c87f21215bfc457efbdf79d\", \"base_unittests\": \"2b5a7c99ce7fb5dcd92a14970f0e7b25b8eb80ac\", \"base_util_unittests\": \"616e2f5736d0737a4b5b73eded84131249b868cd\", \"blink_common_unittests\": \"b69456d181852e4824aab0076c7ce545674a8d31\", \"blink_fuzzer_unittests\": \"e82709b54b1f26c66c782d782024178ea9b3f107\", \"blink_heap_unittests\": \"74af367023f2c72a85fbf51ea5dcba1c00bd55ea\", \"blink_platform_unittests\": \"46a38e4e566ae4749be3acc3c1bfbafb288aa0a7\", \"blink_unittests\": \"5102744d409c23a3cac83f07f470fb19c30354f9\", \"boringssl_crypto_tests\": \"bd2a54996d7c393ddd34e4e6be7178fa911efab2\", \"boringssl_ssl_tests\": \"365ee4f1f85e06b12e1576f481ae11bb05d5e944\", \"browser_tests\": \"ddbbc1edf43c2965a442583a2b30c377434a435d\", \"capture_unittests\": \"7870940395f5d0ee79b3940885a243f700288664\", \"cast_unittests\": \"c71875f6054e41448d00c3bec41a3203ca5176b0\", \"cc_unittests\": \"46fbef26f4953c9fac8b7dfb6038dbf99231010c\", \"chrome_app_unittests\": \"c75e12691a98908a35b65f9b84ea39ac52e045de\", \"chromedriver_unittests\": \"e0bb82934da6839decce08e19fcb126f630d7c54\", \"chromeos_components_unittests\": \"fd85c21d16b38d4e965259fb852767076d19783f\", \"chromeos_unittests\": \"556377758369da5e4d6e6c198cb6217b496403d0\", \"color_unittests\": \"d74a38d1f5c607b31a8cb7008204f3590fdc427f\", \"components_browsertests\": \"a92e51b6de3325efb1b76dfe5a4249faa6f8b665\", \"components_unittests\": \"078f6c8325f0022d6b95eeca78f5dac0be8d9200\", \"compositor_unittests\": \"f97706564694b752db6f81354409b815230824b6\", \"content_browsertests\": \"ddcb069be13d1ca16342c3881d01b56a28b337ef\", \"content_unittests\": \"29789acbee7a55db91eb2473d7a0ee500eab1ad7\", \"crashpad_tests\": \"36e0e6d9d93879aa8984a4a7e4668c05f3e0a9c3\", \"crypto_unittests\": \"2eaddf53744726fce05a4fb6a613faa43fbd8281\", \"dbus_unittests\": \"54495281ff070ae91238dcdf6fcc69986faf96c8\", \"device_unittests\": \"553a9f0589677692a1359fd2c42a3598f0c7e56d\", \"display_unittests\": \"28675272d053b1db0608581b177aa1eba46d7044\", \"events_unittests\": \"1b2c2cb04155496cfd92aa12767ff257422fb9fb\", \"exo_unittests\": \"0d7f56b7630508d02cb003dcbea340edd477e08c\", \"extensions_browsertests\": \"02947228b6c89c254c0bcf5237534020f470ad5c\", \"extensions_unittests\": \"e2fc0b96e5530bdfa94f0794b19ace69f97e4b03\", \"filesystem_service_unittests\": \"b745feb7d71f30698def9fac346e148095f20fef\", \"gcm_unit_tests\": \"68bf969c335acee43f4d500d4bea2f88b2c2a45f\", \"gfx_unittests\": \"517f2f9da2e15f78cc21ea0a2ec47f79aaa6306f\", \"gin_unittests\": \"f0ab86a10b0c47f6d6a04e6a2342e5f340903d37\", \"gl_unittests_ozone\": \"c596ca9597e57d08f103b9417f280960dea79930\", \"google_apis_unittests\": \"bb6b6388e9c988268ff369c9a77567602b518df1\", \"gpu_unittests\": \"f957e2a2f762918093ce0953f564bc876b43f855\", \"gwp_asan_unittests\": \"467aac991e80041482e13f10df86ba0eeca9251d\", \"interactive_ui_tests\": \"4e02b69759823c7f3a815af3d6e7fd207d983375\", \"ipc_tests\": \"1d227d63f433214210a79437f9997a526eadbc47\", \"jingle_unittests\": \"a477bccc80c1d6717974e3d8f938ca5464504c90\", \"keyboard_unittests\": \"0452c16865c68abce467c84c799c6a96fe1043d8\", \"latency_unittests\": \"2877e32b079f9e4d14f935ba4ec82a10b475dca6\", \"libjingle_xmpp_unittests\": \"9ea4b7fa4884997c915e56e1b8f370d245441cb2\", \"liburlpattern_unittests\": \"16b3ec392ea168433668e76494c769f185c40be3\", \"media_blink_unittests\": \"9f8cf64a3e1ae7572fe1d81e192dc0e84c50d233\", \"media_unittests\": \"bb09538ef27586a8f56ff0fde64add21691b990a\", \"message_center_unittests\": \"57f5009944f5502630ac01bb5b6c5c66293b888d\", \"midi_unittests\": \"75e3442d7f1a2e698cdffe69b09173d13f4c6856\", \"mojo_core_unittests\": \"a22e06f811879f4189b46157f900d919b086c85a\", \"mojo_unittests\": \"070036060005b149596c657252e522e13a877957\", \"nacl_helper_nonsfi_unittests\": \"76f0f569c02e475dcf971c29b080f30330f1265d\", \"nacl_loader_unittests\": \"0acc222c876ebcd73abd5aa74ce750a3a54857f1\", \"native_theme_unittests\": \"80bb1f69ad31c40e26884c8c010254a1251cb8fb\", \"net_unittests\": \"90f7cd21053bd1b4959642ce30a50a7d5aca6b45\", \"ozone_gl_unittests\": \"971020ffb26bd38cad928f54e75c2ecce5911421\", \"ozone_unittests\": \"426f404e9818c6f4f9912a4382cf735cd411e50e\", \"ozone_x11_unittests\": \"324104a115b758156a8a4fca53ff180b98d09339\", \"pdf_unittests\": \"6c0cab56a7c0b4326c8c9726037f7d024f123360\", \"perfetto_unittests\": \"6d7701b26739fd9036d9bad31dab6b9874511dc6\", \"ppapi_unittests\": \"e0992fd9a60d044390b6b3585c7ce4905ff312e3\", \"printing_unittests\": \"dce1e938a70b5949a1fa1d1cb4be477c81df6788\", \"remoting_unittests\": \"bc3fb4da5b3c3cb31a7d32c49373f15723cfdb3f\", \"sandbox_linux_unittests\": \"fb7f18bc8a16d06ae159586dd5e83eddf2b1a3fa\", \"service_manager_unittests\": \"87661903aebf28cddbc1c2a1602008a40d969b67\", \"services_unittests\": \"829d182878a9c3b791e92bcd455e80e9be42bf75\", \"shell_dialogs_unittests\": \"1d580befddb77f3100c1729818df11ad041f3b40\", \"shell_encryption_unittests\": \"fac10c69ac64dc91a2c651e02df41cbfc845f544\", \"skia_unittests\": \"dc63604602ed2352b1237252e1a4535b5bbce681\", \"snapshot_unittests\": \"3640c755ee6d59794f216895c9c07d1d8d6d521a\", \"sql_unittests\": \"362265dc6652c1152f44df2970544426bd029a41\", \"storage_unittests\": \"fd45f789fd0087de52e0a957cf33d5356f28a48a\", \"sync_integration_tests\": \"6431337883c1a6c710b04065e686f1a6db4500e9\", \"traffic_annotation_auditor_unittests\": \"41259dc5ff432c3fcfbdb3bb7ed7397e56425fe7\", \"ui_base_unittests\": \"b13cac012f3b4ec230d0b83fd8bebb78aa6659f4\", \"ui_chromeos_unittests\": \"13b3348470dcb972b39a3f4e2352813cace30e89\", \"ui_touch_selection_unittests\": \"841d8283b06a0b697bc00fdfc2d66505078365b0\", \"unit_tests\": \"74559923defb75362eb357a1d6e04e095daa281e\", \"url_unittests\": \"665bb0876e0e998d48c6127e200b2512df92c404\", \"usage_time_limit_unittests\": \"5ceaff8ba81d03a8649abcd949675cf72cbd3bca\", \"views_unittests\": \"0b983c7c32dbc77cecebf01a0ef9c797d401d713\", \"viz_unittests\": \"ee2b42d9387b29bd2984e311ef4d95ed70b2a06b\", \"wayland_client_tests\": \"29816cb2346b1e37d055cffba395b07ff3a81d6d\", \"wm_unittests\": \"ff8a7ac5e4936f7d25a80e9265555c703487c7b8\", \"wtf_unittests\": \"671191943246e02ea530e0e7c2f07ab217b85043\", \"zlib_unittests\": \"5be96f3c5ba831e6525665a13dcbcc33d3eb6754\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_de6b7a4556553e5c716563e6aa155a105cc4f0b63061ff921cc2886efab12e23_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-176-31uw\"], \"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\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615225755390476",
"status": "COMPLETED",
"status_changed_ts": "1615231828921353",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22911",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d5c0e13d2a67c9ee9d43a1e7f1b76b7ee5e3366",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018736853486632384",
"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/8853306791431846144/+/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:522bc6176d2b3610",
"user_agent:luci-scheduler"
],
"updated_ts": "1615231828941174",
"url": "https://ci.chromium.org/b/8853306791431846144",
"utcnow_ts": "1615231830236125"
}
}
[19:30:30.246] Invocation finished in 1h41m51.635347574s with status SUCCEEDED