[21:25:01.269] New invocation is queued and will start shortly
[21:25:02.831] Starting the invocation (attempt 1)
[21:25:02.875] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:25:02.875] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:25:02.875] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027964130774172944",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a2a00a6cb4542822d1148eae35684e039971fb68\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027964130774172944",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a2a00a6cb4542822d1148eae35684e039971fb68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2a00a6cb4542822d1148eae35684e039971fb68",
"gitiles_ref:refs/heads/master"
]
}
[21:25:03.805] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606425903006197",
"id": "8862534068287595584",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2a00a6cb4542822d1148eae35684e039971fb68\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606425903628838",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21488",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a2a00a6cb4542822d1148eae35684e039971fb68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2a00a6cb4542822d1148eae35684e039971fb68",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027964130774172944",
"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/8862534068287595584/+/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": "1606425903628956",
"url": "https://ci.chromium.org/b/8862534068287595584",
"utcnow_ts": "1606425903794689"
}
}
[21:25:03.805] Task URL: https://ci.chromium.org/b/8862534068287595584
[21:25:03.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:2:0) after 1m0s
[21:26:04.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:2:0)
[21:26:04.149] Timer tick, asking Buildbucket for the build status
[21:26:04.238] Build 8862534068287595584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:04.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:3:0) after 1m0s
[21:27:04.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:3:0)
[21:27:04.414] Timer tick, asking Buildbucket for the build status
[21:27:04.677] Build 8862534068287595584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:04.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:4:0) after 1m0s
[21:28:04.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:4:0)
[21:28:04.842] Timer tick, asking Buildbucket for the build status
[21:28:04.974] Build 8862534068287595584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:04.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:5:0) after 1m0s
[21:29:05.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:5:0)
[21:29:05.016] Timer tick, asking Buildbucket for the build status
[21:29:05.100] Build 8862534068287595584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:05.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:6:0) after 1m0s
[21:30:02.474] Received PubSub notification, asking Buildbucket for the build status
[21:30:02.639] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:05.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:6:0)
[21:30:05.205] Timer tick, asking Buildbucket for the build status
[21:30:05.318] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:05.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:8:0) after 1m0s
[21:31:05.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:8:0)
[21:31:05.869] Timer tick, asking Buildbucket for the build status
[21:31:07.283] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:07.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:9:0) after 1m0s
[21:32:07.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:9:0)
[21:32:07.382] Timer tick, asking Buildbucket for the build status
[21:32:07.453] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:07.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:10:0) after 1m0s
[21:33:07.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:10:0)
[21:33:07.569] Timer tick, asking Buildbucket for the build status
[21:33:07.622] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:07.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:11:0) after 1m0s
[21:34:07.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:11:0)
[21:34:07.751] Timer tick, asking Buildbucket for the build status
[21:34:07.945] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:07.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:12:0) after 1m0s
[21:35:07.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:12:0)
[21:35:07.967] Timer tick, asking Buildbucket for the build status
[21:35:08.082] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:08.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:13:0) after 1m0s
[21:36:08.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:13:0)
[21:36:08.163] Timer tick, asking Buildbucket for the build status
[21:36:08.389] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:08.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:14:0) after 1m0s
[21:37:08.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:14:0)
[21:37:08.427] Timer tick, asking Buildbucket for the build status
[21:37:08.498] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:08.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:15:0) after 1m0s
[21:38:08.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:15:0)
[21:38:08.596] Timer tick, asking Buildbucket for the build status
[21:38:08.733] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:08.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:16:0) after 1m0s
[21:39:08.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:16:0)
[21:39:08.771] Timer tick, asking Buildbucket for the build status
[21:39:08.853] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:08.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:17:0) after 1m0s
[21:40:08.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:17:0)
[21:40:08.904] Timer tick, asking Buildbucket for the build status
[21:40:09.074] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:09.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:18:0) after 1m0s
[21:41:09.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:18:0)
[21:41:09.124] Timer tick, asking Buildbucket for the build status
[21:41:09.348] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:09.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:19:0) after 1m0s
[21:42:09.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:19:0)
[21:42:09.416] Timer tick, asking Buildbucket for the build status
[21:42:09.577] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:09.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:20:0) after 1m0s
[21:43:09.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:20:0)
[21:43:09.686] Timer tick, asking Buildbucket for the build status
[21:43:09.782] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:21:0) after 1m0s
[21:44:09.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:21:0)
[21:44:09.919] Timer tick, asking Buildbucket for the build status
[21:44:10.049] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:10.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:22:0) after 1m0s
[21:45:10.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:22:0)
[21:45:10.089] Timer tick, asking Buildbucket for the build status
[21:45:10.315] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:10.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:23:0) after 1m0s
[21:46:10.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:23:0)
[21:46:10.495] Timer tick, asking Buildbucket for the build status
[21:46:10.565] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:10.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:24:0) after 1m0s
[21:47:10.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:24:0)
[21:47:10.707] Timer tick, asking Buildbucket for the build status
[21:47:10.783] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:10.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:25:0) after 1m0s
[21:48:10.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:25:0)
[21:48:10.831] Timer tick, asking Buildbucket for the build status
[21:48:10.890] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:10.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:26:0) after 1m0s
[21:49:10.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:26:0)
[21:49:10.969] Timer tick, asking Buildbucket for the build status
[21:49:11.026] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:11.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:27:0) after 1m0s
[21:50:11.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:27:0)
[21:50:11.073] Timer tick, asking Buildbucket for the build status
[21:50:12.117] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:12.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:28:0) after 1m0s
[21:51:12.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:28:0)
[21:51:12.277] Timer tick, asking Buildbucket for the build status
[21:51:12.521] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:12.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:29:0) after 1m0s
[21:52:12.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:29:0)
[21:52:12.580] Timer tick, asking Buildbucket for the build status
[21:52:12.653] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:12.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:30:0) after 1m0s
[21:53:12.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:30:0)
[21:53:12.797] Timer tick, asking Buildbucket for the build status
[21:53:13.074] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:13.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:31:0) after 1m0s
[21:54:13.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:31:0)
[21:54:13.204] Timer tick, asking Buildbucket for the build status
[21:54:13.303] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:13.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:32:0) after 1m0s
[21:55:13.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:32:0)
[21:55:13.460] Timer tick, asking Buildbucket for the build status
[21:55:13.576] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:13.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:33:0) after 1m0s
[21:56:13.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:33:0)
[21:56:13.660] Timer tick, asking Buildbucket for the build status
[21:56:13.797] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:13.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:34:0) after 1m0s
[21:57:13.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:34:0)
[21:57:13.858] Timer tick, asking Buildbucket for the build status
[21:57:13.949] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:13.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:35:0) after 1m0s
[21:58:14.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:35:0)
[21:58:14.005] Timer tick, asking Buildbucket for the build status
[21:58:14.290] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:14.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:36:0) after 1m0s
[21:59:14.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:36:0)
[21:59:14.352] Timer tick, asking Buildbucket for the build status
[21:59:14.468] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:14.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:37:0) after 1m0s
[22:00:14.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:37:0)
[22:00:14.515] Timer tick, asking Buildbucket for the build status
[22:00:14.841] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:14.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:38:0) after 1m0s
[22:01:14.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:38:0)
[22:01:14.898] Timer tick, asking Buildbucket for the build status
[22:01:15.216] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:15.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:39:0) after 1m0s
[22:02:15.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:39:0)
[22:02:15.243] Timer tick, asking Buildbucket for the build status
[22:02:15.568] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:15.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:40:0) after 1m0s
[22:03:15.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:40:0)
[22:03:15.681] Timer tick, asking Buildbucket for the build status
[22:03:15.862] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:15.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:41:0) after 1m0s
[22:04:15.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:41:0)
[22:04:15.869] Timer tick, asking Buildbucket for the build status
[22:04:15.980] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:15.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:42:0) after 1m0s
[22:05:15.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:42:0)
[22:05:15.967] Timer tick, asking Buildbucket for the build status
[22:05:16.401] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:16.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:43:0) after 1m0s
[22:06:16.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:43:0)
[22:06:16.459] Timer tick, asking Buildbucket for the build status
[22:06:16.597] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:16.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:44:0) after 1m0s
[22:07:16.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:44:0)
[22:07:16.618] Timer tick, asking Buildbucket for the build status
[22:07:16.681] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:16.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:45:0) after 1m0s
[22:08:16.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:45:0)
[22:08:16.666] Timer tick, asking Buildbucket for the build status
[22:08:16.744] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:16.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:46:0) after 1m0s
[22:09:16.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:46:0)
[22:09:16.751] Timer tick, asking Buildbucket for the build status
[22:09:16.832] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:16.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:47:0) after 1m0s
[22:10:16.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:47:0)
[22:10:16.845] Timer tick, asking Buildbucket for the build status
[22:10:16.988] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:16.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:48:0) after 1m0s
[22:11:17.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:48:0)
[22:11:17.003] Timer tick, asking Buildbucket for the build status
[22:11:17.242] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:17.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:49:0) after 1m0s
[22:12:17.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:49:0)
[22:12:17.240] Timer tick, asking Buildbucket for the build status
[22:12:17.666] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:17.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:50:0) after 1m0s
[22:13:17.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:50:0)
[22:13:17.722] Timer tick, asking Buildbucket for the build status
[22:13:17.835] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:17.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:51:0) after 1m0s
[22:14:17.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:51:0)
[22:14:17.855] Timer tick, asking Buildbucket for the build status
[22:14:17.989] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:17.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:52:0) after 1m0s
[22:15:18.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:52:0)
[22:15:18.025] Timer tick, asking Buildbucket for the build status
[22:15:18.428] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:18.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:53:0) after 1m0s
[22:16:18.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:53:0)
[22:16:18.454] Timer tick, asking Buildbucket for the build status
[22:16:18.553] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:18.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:54:0) after 1m0s
[22:17:18.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:54:0)
[22:17:18.601] Timer tick, asking Buildbucket for the build status
[22:17:18.808] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:18.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:55:0) after 1m0s
[22:18:18.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:55:0)
[22:18:18.847] Timer tick, asking Buildbucket for the build status
[22:18:19.135] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:19.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:56:0) after 1m0s
[22:19:19.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:56:0)
[22:19:19.271] Timer tick, asking Buildbucket for the build status
[22:19:19.462] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:19.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:57:0) after 1m0s
[22:20:19.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:57:0)
[22:20:19.486] Timer tick, asking Buildbucket for the build status
[22:20:19.620] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:19.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:58:0) after 1m0s
[22:21:19.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:58:0)
[22:21:19.737] Timer tick, asking Buildbucket for the build status
[22:21:19.917] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:19.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:59:0) after 1m0s
[22:22:19.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:59:0)
[22:22:19.967] Timer tick, asking Buildbucket for the build status
[22:22:20.051] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:20.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:60:0) after 1m0s
[22:23:20.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:60:0)
[22:23:20.121] Timer tick, asking Buildbucket for the build status
[22:23:20.338] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:20.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:61:0) after 1m0s
[22:24:20.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:61:0)
[22:24:20.455] Timer tick, asking Buildbucket for the build status
[22:24:20.604] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:20.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:62:0) after 1m0s
[22:25:20.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:62:0)
[22:25:20.600] Timer tick, asking Buildbucket for the build status
[22:25:21.771] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:21.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:63:0) after 1m0s
[22:26:21.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:63:0)
[22:26:21.820] Timer tick, asking Buildbucket for the build status
[22:26:22.565] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:22.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:64:0) after 1m0s
[22:27:22.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:64:0)
[22:27:22.586] Timer tick, asking Buildbucket for the build status
[22:27:22.718] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:22.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:65:0) after 1m0s
[22:28:22.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:65:0)
[22:28:22.806] Timer tick, asking Buildbucket for the build status
[22:28:23.101] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:23.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:66:0) after 1m0s
[22:29:23.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:66:0)
[22:29:23.125] Timer tick, asking Buildbucket for the build status
[22:29:23.229] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:23.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:67:0) after 1m0s
[22:30:23.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:67:0)
[22:30:23.305] Timer tick, asking Buildbucket for the build status
[22:30:23.783] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:23.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:68:0) after 1m0s
[22:31:24.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:68:0)
[22:31:24.027] Timer tick, asking Buildbucket for the build status
[22:31:24.534] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:24.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:69:0) after 1m0s
[22:32:24.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:69:0)
[22:32:24.718] Timer tick, asking Buildbucket for the build status
[22:32:24.883] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:24.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:70:0) after 1m0s
[22:33:25.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:70:0)
[22:33:25.003] Timer tick, asking Buildbucket for the build status
[22:33:25.192] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:25.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:71:0) after 1m0s
[22:34:25.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:71:0)
[22:34:25.216] Timer tick, asking Buildbucket for the build status
[22:34:26.000] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:26.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:72:0) after 1m0s
[22:35:26.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:72:0)
[22:35:26.039] Timer tick, asking Buildbucket for the build status
[22:35:26.212] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:26.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:73:0) after 1m0s
[22:36:26.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:73:0)
[22:36:26.346] Timer tick, asking Buildbucket for the build status
[22:36:26.621] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:26.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:74:0) after 1m0s
[22:37:26.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:74:0)
[22:37:26.727] Timer tick, asking Buildbucket for the build status
[22:37:26.846] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:26.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:75:0) after 1m0s
[22:38:26.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:75:0)
[22:38:26.859] Timer tick, asking Buildbucket for the build status
[22:38:26.987] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:26.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:76:0) after 1m0s
[22:39:27.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:76:0)
[22:39:27.021] Timer tick, asking Buildbucket for the build status
[22:39:27.144] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:27.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:77:0) after 1m0s
[22:40:27.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:77:0)
[22:40:27.209] Timer tick, asking Buildbucket for the build status
[22:40:27.359] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:27.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:78:0) after 1m0s
[22:41:27.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:78:0)
[22:41:27.501] Timer tick, asking Buildbucket for the build status
[22:41:27.607] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:27.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:79:0) after 1m0s
[22:42:27.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:79:0)
[22:42:27.650] Timer tick, asking Buildbucket for the build status
[22:42:27.775] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:27.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:80:0) after 1m0s
[22:43:27.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:80:0)
[22:43:27.800] Timer tick, asking Buildbucket for the build status
[22:43:27.879] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:27.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:81:0) after 1m0s
[22:44:27.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:81:0)
[22:44:27.873] Timer tick, asking Buildbucket for the build status
[22:44:28.049] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:28.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:82:0) after 1m0s
[22:45:28.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:82:0)
[22:45:28.076] Timer tick, asking Buildbucket for the build status
[22:45:28.344] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:28.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:83:0) after 1m0s
[22:46:28.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:83:0)
[22:46:28.349] Timer tick, asking Buildbucket for the build status
[22:46:28.543] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:28.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:84:0) after 1m0s
[22:47:28.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:84:0)
[22:47:28.565] Timer tick, asking Buildbucket for the build status
[22:47:28.653] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:28.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:85:0) after 1m0s
[22:48:28.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:85:0)
[22:48:28.707] Timer tick, asking Buildbucket for the build status
[22:48:28.806] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:28.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:86:0) after 1m0s
[22:49:28.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:86:0)
[22:49:28.851] Timer tick, asking Buildbucket for the build status
[22:49:28.915] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:28.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:87:0) after 1m0s
[22:50:28.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:87:0)
[22:50:28.937] Timer tick, asking Buildbucket for the build status
[22:50:29.043] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:29.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:88:0) after 1m0s
[22:51:29.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:88:0)
[22:51:29.071] Timer tick, asking Buildbucket for the build status
[22:51:29.140] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:29.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:89:0) after 1m0s
[22:52:29.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:89:0)
[22:52:29.207] Timer tick, asking Buildbucket for the build status
[22:52:29.290] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:29.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:90:0) after 1m0s
[22:53:29.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:90:0)
[22:53:29.328] Timer tick, asking Buildbucket for the build status
[22:53:31.052] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:31.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:91:0) after 1m0s
[22:54:31.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:91:0)
[22:54:31.181] Timer tick, asking Buildbucket for the build status
[22:54:31.317] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:31.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:92:0) after 1m0s
[22:55:31.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:92:0)
[22:55:31.433] Timer tick, asking Buildbucket for the build status
[22:55:31.547] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:31.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:93:0) after 1m0s
[22:56:31.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:93:0)
[22:56:31.813] Timer tick, asking Buildbucket for the build status
[22:56:31.929] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:94:0) after 1m0s
[22:57:32.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:94:0)
[22:57:32.016] Timer tick, asking Buildbucket for the build status
[22:57:32.567] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:32.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:95:0) after 1m0s
[22:58:32.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:95:0)
[22:58:32.653] Timer tick, asking Buildbucket for the build status
[22:58:32.735] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:96:0) after 1m0s
[22:59:32.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:96:0)
[22:59:32.860] Timer tick, asking Buildbucket for the build status
[22:59:32.951] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:32.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:97:0) after 1m0s
[23:00:32.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:97:0)
[23:00:32.965] Timer tick, asking Buildbucket for the build status
[23:00:33.099] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:33.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:98:0) after 1m0s
[23:01:33.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:98:0)
[23:01:33.126] Timer tick, asking Buildbucket for the build status
[23:01:33.396] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:33.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:99:0) after 1m0s
[23:02:33.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:99:0)
[23:02:33.426] Timer tick, asking Buildbucket for the build status
[23:02:33.508] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:33.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:100:0) after 1m0s
[23:03:33.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:100:0)
[23:03:33.541] Timer tick, asking Buildbucket for the build status
[23:03:33.657] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:33.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:101:0) after 1m0s
[23:04:33.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:101:0)
[23:04:33.743] Timer tick, asking Buildbucket for the build status
[23:04:33.805] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:33.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:102:0) after 1m0s
[23:05:33.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:102:0)
[23:05:33.869] Timer tick, asking Buildbucket for the build status
[23:05:34.143] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:34.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:103:0) after 1m0s
[23:06:34.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:103:0)
[23:06:34.196] Timer tick, asking Buildbucket for the build status
[23:06:34.298] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:34.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:104:0) after 1m0s
[23:07:34.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:104:0)
[23:07:34.327] Timer tick, asking Buildbucket for the build status
[23:07:34.541] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:34.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:105:0) after 1m0s
[23:08:34.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:105:0)
[23:08:34.556] Timer tick, asking Buildbucket for the build status
[23:08:34.696] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:34.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:106:0) after 1m0s
[23:09:34.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:106:0)
[23:09:34.824] Timer tick, asking Buildbucket for the build status
[23:09:34.893] Build 8862534068287595584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027964130774172944:107:0) after 1m0s
[23:10:25.411] Received PubSub notification, asking Buildbucket for the build status
[23:10:25.485] Build 8862534068287595584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:10:25.485] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606432224631949",
"created_by": "project:chromium",
"created_ts": "1606425903006197",
"id": "8862534068287595584",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2a00a6cb4542822d1148eae35684e039971fb68\"}}",
"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\": \"a2a00a6cb4542822d1148eae35684e039971fb68\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-95-2ty1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21488, \"got_angle_revision\": \"f60823d387fe8ada147ad230cad7cdd9a4657c94\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"a2a00a6cb4542822d1148eae35684e039971fb68\", \"got_revision_cp\": \"refs/heads/master@{#831424}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"0326ad058cd220e7ad2c3663124ebce467eb771f\", \"got_v8_revision_cp\": \"refs/heads/8.9.62@{#1}\", \"got_webrtc_revision\": \"0d863f72a8c747c1b41f2798e5201e1abcdaec2b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32704}\", \"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\": \"a2a00a6cb4542822d1148eae35684e039971fb68\", \"swarm_hashes_refs/heads/master(at){#831424}_without_patch\": {\"absl_hardening_tests\": \"4fd4276d13e4f03627f6b27779e6b2d27e81670c\", \"accessibility_unittests\": \"9315019ae999841649703f98c26a764bb3a9b78b\", \"angle_unittests\": \"4aa516708631be11aeb39202da009e2c808663e2\", \"app_list_unittests\": \"6c44e16b2f91a7835357d76eb6ab477d46b5e90c\", \"app_shell_unittests\": \"908d68b55ad45ee91672feabc44ca93d3a53f646\", \"ash_unittests\": \"9d0efdc1b78fc3c3c091c5fc8b1aa2250da90acb\", \"aura_unittests\": \"e5a5e1c14d40dd99920bbbdf11271f7790d87384\", \"base_unittests\": \"23efc75b65d720e089f7525f017ce94703ee8d23\", \"base_util_unittests\": \"b6ce14c29e738086839b76437708bd2acb85ee16\", \"blink_common_unittests\": \"0c3e2103b1d44fd55f417916b6e059d29f3aea4f\", \"blink_fuzzer_unittests\": \"847497e76c367e38290bf1dec094d0a479c7ff67\", \"blink_heap_unittests\": \"013e8946054d1444561ba8fd83067b5175741098\", \"blink_platform_unittests\": \"c685257acc698389700154e7f9f625137f9309a8\", \"blink_unittests\": \"86addc8c068d91d17d6cb873412a74a1bd0d6c26\", \"boringssl_crypto_tests\": \"a8d2d22a64038b85ed75499e7fc5c432faed650b\", \"boringssl_ssl_tests\": \"70c3d7e2893d5f998de945af4a898d20d08bf9c5\", \"browser_tests\": \"e2d9d78df4c2374e182b21038cfd98e3fc4dbe6f\", \"capture_unittests\": \"4ae9622159103b61607d588c2f4fb5dbe1dc03c8\", \"cast_unittests\": \"e793f5ed3db664436dc1d2edd2aae569a5677650\", \"cc_unittests\": \"80c7ff55c7f36ebc1864d9132f088bd1c70fc50d\", \"chrome_app_unittests\": \"331937c22c4d16a75a00099cd2f757941f4c3b57\", \"chromedriver_unittests\": \"168acd0769c7e0047d260c0fc6c8eb53b3c55160\", \"chromeos_components_unittests\": \"d47a7a489f6e87f2bc9edd8d83e5303dbba4c2e9\", \"chromeos_unittests\": \"7aa9f8dfd82b844b989facd278d1d7492fa8d6b6\", \"components_browsertests\": \"8893c447aedb336121ecb649a3ca41adadf27628\", \"components_unittests\": \"f1940b137d9bc49ae5c990a8dfb86deebc2a3005\", \"compositor_unittests\": \"9b23d8782e1cb9ee1cc9fba2fa12677ab14f68cb\", \"content_browsertests\": \"78d3ca76e6539d608be4af40dea4200bace88670\", \"content_unittests\": \"1591949358bb4ef9fcf15daece54474ff096fff4\", \"crashpad_tests\": \"4432a5dc0a7e5503761034ff44b199c75ea74b47\", \"crypto_unittests\": \"5a7b3414331a86fa894abc669bbdd8d8fc39aa45\", \"dbus_unittests\": \"bd6b39ae3a399736bfc94b3d2dc3802638b2009d\", \"device_unittests\": \"0f87c10136773876cbe74449690a17069fefbfdc\", \"display_unittests\": \"1e8d2149fb969e33646a8944328940f3fe077d77\", \"events_unittests\": \"82029f131859f6b77a384648ac8d6c1c59c0e840\", \"exo_unittests\": \"35e8ed5dc4998dd54c765fe79adc911a5a11f834\", \"extensions_browsertests\": \"070e02778a52c4ca7934879493d09e75a7b54e15\", \"extensions_unittests\": \"d01452eaf5fc0f05137e1255cf1925da9415b344\", \"filesystem_service_unittests\": \"a1b78fe6c9f0a82ad9ebd28534bce6be657a45ad\", \"gcm_unit_tests\": \"2ed680e3ba7743cab791fb3cded621672391165d\", \"gfx_unittests\": \"e662fe992d0da5ad142e68f16ad49cf2bee4c1b8\", \"gin_unittests\": \"affa42b443e5cd09501038204726c3f4f81ac25e\", \"gl_unittests_ozone\": \"43bcc7ed599ed4ed3228dbce98a1c41ce2b8c53a\", \"google_apis_unittests\": \"32ff52ac3480b5fcc4887fcd517f00863a70acf5\", \"gpu_unittests\": \"ff45d7c56d203c07eeebababc3befc1e0e0bc6c9\", \"gwp_asan_unittests\": \"824b935c0e11cc542b93d05fe3e19f596c76e549\", \"interactive_ui_tests\": \"a9ef0273c6f3c78cabe4164670f3c47b8bb71ba1\", \"ipc_tests\": \"a6cbe05b70db61b1d9631a261ff997f5c8f44612\", \"jingle_unittests\": \"067c8ad2fe7d6796617fc1ca6fa29f4e948341a1\", \"keyboard_unittests\": \"b51396a1fd330f02863ac7946f25b496ba1b2d96\", \"latency_unittests\": \"8bc74619cf87d1b217a9b0b7f7d9d7d18a53a193\", \"libjingle_xmpp_unittests\": \"c24f7ae8e3b5a0b891ddbb900a9cdc4b3f4f9fac\", \"liburlpattern_unittests\": \"519cadcafbae399ea498d4cc906fdbb831bb0c9a\", \"media_blink_unittests\": \"363a14041ad0d5a0bff5f2d077be097177d451f4\", \"media_unittests\": \"dfdb1dddc4b12dde9d8022e6718fa68e4fed022a\", \"message_center_unittests\": \"0528e798bf586e9c8139b2cd3a5329aec5672758\", \"midi_unittests\": \"57ece83bb1e31700eadf790200ec85d0b2e38ecb\", \"mojo_core_unittests\": \"f0fc94a7f2c4f68b19f0fab903a49b5a94146961\", \"mojo_unittests\": \"17c45a00089604a55f6c240ba649fe888488d3ba\", \"nacl_helper_nonsfi_unittests\": \"e9d5b96c6eb113b2d6e60f9fcbff3fa507a31032\", \"nacl_loader_unittests\": \"08087a1c79e3581b28278cc6a5633d95a822a043\", \"native_theme_unittests\": \"198415e567fee295152952cc2f0997ecc20627ed\", \"net_unittests\": \"19069a60d546f4091868c9b531b02be1bd4c2e4f\", \"ozone_gl_unittests\": \"a316edd3cd25fa0ea79d55abb7aa43ea33f8ca83\", \"ozone_unittests\": \"bc1a8c45ae000f5e4310f697500876e9e413a2a9\", \"ozone_x11_unittests\": \"25a841d0b6eefb6c1e5f1a3f40a8d370c6636597\", \"pdf_unittests\": \"a8f0ea924a9bfbde52615c936aecfd9de90484dc\", \"perfetto_unittests\": \"ca3688e98b6b9ca8409600e63e4d5a856ad247e8\", \"ppapi_unittests\": \"b92698b2f79212821215aeb53fa6ecfc560ee0c2\", \"printing_unittests\": \"217056bfa8343cbc372aba62b775a95b9e068928\", \"remoting_unittests\": \"f77bb3bc7487260dfa38b5662789243abebf8000\", \"sandbox_linux_unittests\": \"753c7623f9d1fcd1e7a3ba0006c1efc2b500075e\", \"service_manager_unittests\": \"e56fa290bfb677f48a2a611176c4dc986d8a4e98\", \"services_unittests\": \"d1d4258ca0c2e475c91f6670fc109ae1683bf670\", \"shell_dialogs_unittests\": \"b484566dc7fe974ad4f339029cbbd794243d1cd7\", \"skia_unittests\": \"b25f2981977feb2c2f88973c064e95b259a33c62\", \"snapshot_unittests\": \"bf48a2167f54f9b95ec4f014d293a719c73b3161\", \"sql_unittests\": \"dfb4aed1dedad1801ad1b69221b563d5eecc92a4\", \"storage_unittests\": \"acbccc618f443e0caeb6b0d46b4ab6feb4673787\", \"sync_integration_tests\": \"d7cbd650adf8ca77836198f938d5240cbb83f066\", \"traffic_annotation_auditor_unittests\": \"d1d05538063299a42b9c8fa0441bfb0571c1f536\", \"ui_base_unittests\": \"aab20d082651c5dcea989badded223165f6370d5\", \"ui_chromeos_unittests\": \"ae0a465c87bee518df3e207ade9f1783fd6e4991\", \"ui_touch_selection_unittests\": \"3a113844feae4cc897ecfe04aec5114d9ce2dbe2\", \"unit_tests\": \"d89e12201a0aee39178bdcd06f9b3e448c4a58ae\", \"url_unittests\": \"7037ee52f298de5380ae00008c0065db32213bfb\", \"usage_time_limit_unittests\": \"6573ee2df18c6edb1399e28bad82c1e92a3ab446\", \"views_unittests\": \"1927ed44671ba557aa1dd3dd71a9616c9a9f9956\", \"viz_unittests\": \"1e26301b9ce8d45dc708977ffddd429c28c8ac53\", \"wm_unittests\": \"53da59f53c786dc80e2929e6a2c302df919e7db8\", \"wtf_unittests\": \"625705ef42895849c120e0ed2963ce2ee1893340\", \"zlib_unittests\": \"9d38da4b5816777fb47daee052a993944b2f1bd1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_79ddf9721ca7b7ce79374811fb2c516b44ee31d85deee669f4d7a1736cefaf3b_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_dbe717e93dfefb94e765b2da7ffc34b16e5134b01772a8d37ee52c1fe1505654_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-95-2ty1\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606426201412691",
"status": "COMPLETED",
"status_changed_ts": "1606432225024546",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21488",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a2a00a6cb4542822d1148eae35684e039971fb68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2a00a6cb4542822d1148eae35684e039971fb68",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027964130774172944",
"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/8862534068287595584/+/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:501f438aeb6bd710",
"user_agent:luci-scheduler"
],
"updated_ts": "1606432225029404",
"url": "https://ci.chromium.org/b/8862534068287595584",
"utcnow_ts": "1606432225477094"
}
}
[23:10:25.485] Invocation finished in 1h45m24.233305317s with status SUCCEEDED