[02:29:07.516] New invocation is queued and will start shortly
[02:29:09.291] Starting the invocation (attempt 1)
[02:29:09.344] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:29:09.345] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:29:09.345] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026586043703073248",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9026586043703073248",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0",
"gitiles_ref:refs/heads/master"
]
}
[02:29:10.013] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607740149454351",
"id": "8861155981003935008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607740149887731",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21713",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026586043703073248",
"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/8861155981003935008/+/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": "1607740149887881",
"url": "https://ci.chromium.org/b/8861155981003935008",
"utcnow_ts": "1607740150004213"
}
}
[02:29:10.013] Task URL: https://ci.chromium.org/b/8861155981003935008
[02:29:10.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:2:0) after 1m0s
[02:29:48.678] Received PubSub notification, asking Buildbucket for the build status
[02:29:48.770] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:10.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:2:0)
[02:30:10.043] Timer tick, asking Buildbucket for the build status
[02:30:10.112] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:10.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:4:0) after 1m0s
[02:31:10.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:4:0)
[02:31:10.208] Timer tick, asking Buildbucket for the build status
[02:31:10.297] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:5:0) after 1m0s
[02:32:10.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:5:0)
[02:32:10.339] Timer tick, asking Buildbucket for the build status
[02:32:10.431] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:10.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:6:0) after 1m0s
[02:33:10.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:6:0)
[02:33:10.476] Timer tick, asking Buildbucket for the build status
[02:33:10.626] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:10.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:7:0) after 1m0s
[02:34:10.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:7:0)
[02:34:10.669] Timer tick, asking Buildbucket for the build status
[02:34:10.745] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:10.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:8:0) after 1m0s
[02:35:10.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:8:0)
[02:35:10.765] Timer tick, asking Buildbucket for the build status
[02:35:10.877] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:10.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:9:0) after 1m0s
[02:36:10.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:9:0)
[02:36:10.919] Timer tick, asking Buildbucket for the build status
[02:36:11.030] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:11.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:10:0) after 1m0s
[02:37:11.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:10:0)
[02:37:11.079] Timer tick, asking Buildbucket for the build status
[02:37:11.214] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:11.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:11:0) after 1m0s
[02:38:11.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:11:0)
[02:38:11.517] Timer tick, asking Buildbucket for the build status
[02:38:11.629] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:11.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:12:0) after 1m0s
[02:39:11.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:12:0)
[02:39:11.797] Timer tick, asking Buildbucket for the build status
[02:39:11.925] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:11.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:13:0) after 1m0s
[02:40:11.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:13:0)
[02:40:11.951] Timer tick, asking Buildbucket for the build status
[02:40:12.023] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:12.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:14:0) after 1m0s
[02:41:12.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:14:0)
[02:41:12.079] Timer tick, asking Buildbucket for the build status
[02:41:12.340] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:12.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:15:0) after 1m0s
[02:42:12.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:15:0)
[02:42:12.384] Timer tick, asking Buildbucket for the build status
[02:42:12.442] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:12.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:16:0) after 1m0s
[02:43:12.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:16:0)
[02:43:12.484] Timer tick, asking Buildbucket for the build status
[02:43:12.541] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:12.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:17:0) after 1m0s
[02:44:12.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:17:0)
[02:44:12.560] Timer tick, asking Buildbucket for the build status
[02:44:12.665] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:12.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:18:0) after 1m0s
[02:45:12.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:18:0)
[02:45:12.689] Timer tick, asking Buildbucket for the build status
[02:45:12.766] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:12.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:19:0) after 1m0s
[02:46:12.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:19:0)
[02:46:12.786] Timer tick, asking Buildbucket for the build status
[02:46:12.905] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:12.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:20:0) after 1m0s
[02:47:12.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:20:0)
[02:47:12.961] Timer tick, asking Buildbucket for the build status
[02:47:13.035] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:21:0) after 1m0s
[02:48:13.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:21:0)
[02:48:13.057] Timer tick, asking Buildbucket for the build status
[02:48:13.122] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:13.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:22:0) after 1m0s
[02:49:13.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:22:0)
[02:49:13.150] Timer tick, asking Buildbucket for the build status
[02:49:13.256] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:13.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:23:0) after 1m0s
[02:50:13.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:23:0)
[02:50:13.286] Timer tick, asking Buildbucket for the build status
[02:50:13.357] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:13.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:24:0) after 1m0s
[02:51:13.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:24:0)
[02:51:13.441] Timer tick, asking Buildbucket for the build status
[02:51:13.496] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:13.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:25:0) after 1m0s
[02:52:13.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:25:0)
[02:52:13.625] Timer tick, asking Buildbucket for the build status
[02:52:13.684] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:13.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:26:0) after 1m0s
[02:53:13.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:26:0)
[02:53:13.733] Timer tick, asking Buildbucket for the build status
[02:53:13.845] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:13.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:27:0) after 1m0s
[02:54:14.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:27:0)
[02:54:14.016] Timer tick, asking Buildbucket for the build status
[02:54:14.171] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:14.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:28:0) after 1m0s
[02:55:14.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:28:0)
[02:55:14.278] Timer tick, asking Buildbucket for the build status
[02:55:14.345] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:14.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:29:0) after 1m0s
[02:56:14.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:29:0)
[02:56:14.499] Timer tick, asking Buildbucket for the build status
[02:56:14.740] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:14.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:30:0) after 1m0s
[02:57:14.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:30:0)
[02:57:14.906] Timer tick, asking Buildbucket for the build status
[02:57:15.253] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:15.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:31:0) after 1m0s
[02:58:15.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:31:0)
[02:58:15.303] Timer tick, asking Buildbucket for the build status
[02:58:15.617] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:15.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:32:0) after 1m0s
[02:59:15.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:32:0)
[02:59:15.668] Timer tick, asking Buildbucket for the build status
[02:59:15.775] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:15.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:33:0) after 1m0s
[03:00:15.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:33:0)
[03:00:15.785] Timer tick, asking Buildbucket for the build status
[03:00:15.979] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:15.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:34:0) after 1m0s
[03:01:16.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:34:0)
[03:01:16.031] Timer tick, asking Buildbucket for the build status
[03:01:16.097] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:16.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:35:0) after 1m0s
[03:02:16.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:35:0)
[03:02:16.091] Timer tick, asking Buildbucket for the build status
[03:02:16.160] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:16.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:36:0) after 1m0s
[03:03:16.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:36:0)
[03:03:16.206] Timer tick, asking Buildbucket for the build status
[03:03:16.267] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:16.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:37:0) after 1m0s
[03:04:16.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:37:0)
[03:04:16.286] Timer tick, asking Buildbucket for the build status
[03:04:16.397] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:38:0) after 1m0s
[03:05:16.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:38:0)
[03:05:16.420] Timer tick, asking Buildbucket for the build status
[03:05:16.543] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:16.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:39:0) after 1m0s
[03:06:16.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:39:0)
[03:06:16.546] Timer tick, asking Buildbucket for the build status
[03:06:16.617] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:16.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:40:0) after 1m0s
[03:07:16.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:40:0)
[03:07:16.652] Timer tick, asking Buildbucket for the build status
[03:07:16.738] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:16.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:41:0) after 1m0s
[03:08:16.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:41:0)
[03:08:16.833] Timer tick, asking Buildbucket for the build status
[03:08:16.936] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:42:0) after 1m0s
[03:09:16.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:42:0)
[03:09:16.988] Timer tick, asking Buildbucket for the build status
[03:09:17.432] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:17.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:43:0) after 1m0s
[03:10:17.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:43:0)
[03:10:17.483] Timer tick, asking Buildbucket for the build status
[03:10:17.811] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:17.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:44:0) after 1m0s
[03:11:17.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:44:0)
[03:11:17.788] Timer tick, asking Buildbucket for the build status
[03:11:18.047] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:18.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:45:0) after 1m0s
[03:12:18.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:45:0)
[03:12:18.145] Timer tick, asking Buildbucket for the build status
[03:12:18.616] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:18.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:46:0) after 1m0s
[03:13:18.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:46:0)
[03:13:18.655] Timer tick, asking Buildbucket for the build status
[03:13:18.824] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:18.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:47:0) after 1m0s
[03:14:19.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:47:0)
[03:14:19.469] Timer tick, asking Buildbucket for the build status
[03:14:19.583] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:19.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:48:0) after 1m0s
[03:15:19.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:48:0)
[03:15:19.756] Timer tick, asking Buildbucket for the build status
[03:15:19.858] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:19.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:49:0) after 1m0s
[03:16:20.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:49:0)
[03:16:20.028] Timer tick, asking Buildbucket for the build status
[03:16:20.185] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:20.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:50:0) after 1m0s
[03:17:20.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:50:0)
[03:17:20.237] Timer tick, asking Buildbucket for the build status
[03:17:20.378] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:20.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:51:0) after 1m0s
[03:18:20.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:51:0)
[03:18:20.465] Timer tick, asking Buildbucket for the build status
[03:18:21.191] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:21.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:52:0) after 1m0s
[03:19:21.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:52:0)
[03:19:21.888] Timer tick, asking Buildbucket for the build status
[03:19:22.625] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:22.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:53:0) after 1m0s
[03:20:22.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:53:0)
[03:20:22.874] Timer tick, asking Buildbucket for the build status
[03:20:22.977] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:22.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:54:0) after 1m0s
[03:21:23.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:54:0)
[03:21:23.121] Timer tick, asking Buildbucket for the build status
[03:21:23.255] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:23.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:55:0) after 1m0s
[03:22:23.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:55:0)
[03:22:23.596] Timer tick, asking Buildbucket for the build status
[03:22:24.146] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:24.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:56:0) after 1m0s
[03:23:24.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:56:0)
[03:23:24.200] Timer tick, asking Buildbucket for the build status
[03:23:24.303] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:24.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:57:0) after 1m0s
[03:24:24.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:57:0)
[03:24:24.357] Timer tick, asking Buildbucket for the build status
[03:24:24.544] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:24.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:58:0) after 1m0s
[03:25:24.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:58:0)
[03:25:24.883] Timer tick, asking Buildbucket for the build status
[03:25:25.004] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:25.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:59:0) after 1m0s
[03:26:25.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:59:0)
[03:26:25.232] Timer tick, asking Buildbucket for the build status
[03:26:25.296] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:25.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:60:0) after 1m0s
[03:27:25.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:60:0)
[03:27:25.415] Timer tick, asking Buildbucket for the build status
[03:27:25.507] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:25.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:61:0) after 1m0s
[03:28:26.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:61:0)
[03:28:26.243] Timer tick, asking Buildbucket for the build status
[03:28:26.308] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:26.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:62:0) after 1m0s
[03:29:26.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:62:0)
[03:29:26.449] Timer tick, asking Buildbucket for the build status
[03:29:26.579] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:26.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:63:0) after 1m0s
[03:30:26.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:63:0)
[03:30:26.889] Timer tick, asking Buildbucket for the build status
[03:30:27.218] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:27.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:64:0) after 1m0s
[03:31:27.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:64:0)
[03:31:27.258] Timer tick, asking Buildbucket for the build status
[03:31:27.381] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:27.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:65:0) after 1m0s
[03:32:27.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:65:0)
[03:32:27.456] Timer tick, asking Buildbucket for the build status
[03:32:27.592] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:27.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:66:0) after 1m0s
[03:33:27.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:66:0)
[03:33:27.672] Timer tick, asking Buildbucket for the build status
[03:33:27.782] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:27.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:67:0) after 1m0s
[03:34:27.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:67:0)
[03:34:27.837] Timer tick, asking Buildbucket for the build status
[03:34:27.962] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:27.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:68:0) after 1m0s
[03:35:28.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:68:0)
[03:35:28.009] Timer tick, asking Buildbucket for the build status
[03:35:28.087] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:28.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:69:0) after 1m0s
[03:36:28.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:69:0)
[03:36:28.121] Timer tick, asking Buildbucket for the build status
[03:36:28.191] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:28.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:70:0) after 1m0s
[03:37:28.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:70:0)
[03:37:28.196] Timer tick, asking Buildbucket for the build status
[03:37:28.313] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:28.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:71:0) after 1m0s
[03:38:28.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:71:0)
[03:38:28.445] Timer tick, asking Buildbucket for the build status
[03:38:28.730] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:28.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:72:0) after 1m0s
[03:39:28.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:72:0)
[03:39:28.782] Timer tick, asking Buildbucket for the build status
[03:39:28.891] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:28.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:73:0) after 1m0s
[03:40:28.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:73:0)
[03:40:28.938] Timer tick, asking Buildbucket for the build status
[03:40:29.057] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:29.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:74:0) after 1m0s
[03:41:29.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:74:0)
[03:41:29.204] Timer tick, asking Buildbucket for the build status
[03:41:29.295] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:29.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:75:0) after 1m0s
[03:42:29.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:75:0)
[03:42:29.345] Timer tick, asking Buildbucket for the build status
[03:42:29.410] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:29.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:76:0) after 1m0s
[03:43:29.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:76:0)
[03:43:29.466] Timer tick, asking Buildbucket for the build status
[03:43:29.539] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:29.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:77:0) after 1m0s
[03:44:29.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:77:0)
[03:44:29.615] Timer tick, asking Buildbucket for the build status
[03:44:29.814] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:29.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:78:0) after 1m0s
[03:45:29.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:78:0)
[03:45:29.912] Timer tick, asking Buildbucket for the build status
[03:45:30.028] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:79:0) after 1m0s
[03:46:30.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:79:0)
[03:46:30.038] Timer tick, asking Buildbucket for the build status
[03:46:30.108] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:30.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:80:0) after 1m0s
[03:47:30.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:80:0)
[03:47:30.107] Timer tick, asking Buildbucket for the build status
[03:47:30.184] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:30.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:81:0) after 1m0s
[03:48:30.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:81:0)
[03:48:30.204] Timer tick, asking Buildbucket for the build status
[03:48:30.268] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:30.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:82:0) after 1m0s
[03:49:30.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:82:0)
[03:49:30.298] Timer tick, asking Buildbucket for the build status
[03:49:30.611] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:30.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:83:0) after 1m0s
[03:50:30.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:83:0)
[03:50:30.683] Timer tick, asking Buildbucket for the build status
[03:50:30.789] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:30.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:84:0) after 1m0s
[03:51:30.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:84:0)
[03:51:30.852] Timer tick, asking Buildbucket for the build status
[03:51:30.933] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:30.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:85:0) after 1m0s
[03:52:31.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:85:0)
[03:52:31.025] Timer tick, asking Buildbucket for the build status
[03:52:31.195] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:31.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:86:0) after 1m0s
[03:53:31.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:86:0)
[03:53:31.217] Timer tick, asking Buildbucket for the build status
[03:53:31.298] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:31.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:87:0) after 1m0s
[03:54:31.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:87:0)
[03:54:31.321] Timer tick, asking Buildbucket for the build status
[03:54:31.437] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:31.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:88:0) after 1m0s
[03:55:31.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:88:0)
[03:55:31.459] Timer tick, asking Buildbucket for the build status
[03:55:31.575] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:31.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:89:0) after 1m0s
[03:56:31.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:89:0)
[03:56:31.691] Timer tick, asking Buildbucket for the build status
[03:56:31.823] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:31.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:90:0) after 1m0s
[03:57:31.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:90:0)
[03:57:31.901] Timer tick, asking Buildbucket for the build status
[03:57:31.980] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:31.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:91:0) after 1m0s
[03:58:32.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:91:0)
[03:58:32.121] Timer tick, asking Buildbucket for the build status
[03:58:32.392] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:32.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:92:0) after 1m0s
[03:59:32.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:92:0)
[03:59:32.549] Timer tick, asking Buildbucket for the build status
[03:59:32.650] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:32.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:93:0) after 1m0s
[04:00:32.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:93:0)
[04:00:32.747] Timer tick, asking Buildbucket for the build status
[04:00:33.016] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:33.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:94:0) after 1m0s
[04:01:33.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:94:0)
[04:01:33.179] Timer tick, asking Buildbucket for the build status
[04:01:33.420] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:33.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:95:0) after 1m0s
[04:02:33.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:95:0)
[04:02:33.458] Timer tick, asking Buildbucket for the build status
[04:02:33.547] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:33.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:96:0) after 1m0s
[04:03:33.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:96:0)
[04:03:33.750] Timer tick, asking Buildbucket for the build status
[04:03:33.831] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:33.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:97:0) after 1m0s
[04:04:34.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:97:0)
[04:04:34.081] Timer tick, asking Buildbucket for the build status
[04:04:34.246] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:34.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:98:0) after 1m0s
[04:05:34.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:98:0)
[04:05:34.427] Timer tick, asking Buildbucket for the build status
[04:05:34.539] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:34.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:99:0) after 1m0s
[04:06:34.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:99:0)
[04:06:34.629] Timer tick, asking Buildbucket for the build status
[04:06:34.700] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:34.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:100:0) after 1m0s
[04:07:34.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:100:0)
[04:07:34.888] Timer tick, asking Buildbucket for the build status
[04:07:35.616] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:35.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:101:0) after 1m0s
[04:08:35.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:101:0)
[04:08:35.788] Timer tick, asking Buildbucket for the build status
[04:08:35.903] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:35.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:102:0) after 1m0s
[04:09:35.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:102:0)
[04:09:35.922] Timer tick, asking Buildbucket for the build status
[04:09:36.204] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:36.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:103:0) after 1m0s
[04:10:36.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:103:0)
[04:10:36.232] Timer tick, asking Buildbucket for the build status
[04:10:36.312] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:36.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:104:0) after 1m0s
[04:11:36.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:104:0)
[04:11:36.396] Timer tick, asking Buildbucket for the build status
[04:11:36.477] Build 8861155981003935008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:36.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026586043703073248:105:0) after 1m0s
[04:12:19.372] Received PubSub notification, asking Buildbucket for the build status
[04:12:20.219] Build 8861155981003935008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:12:20.219] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607746337895765",
"created_by": "project:chromium",
"created_ts": "1607740149454351",
"id": "8861155981003935008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0\"}}",
"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\": \"e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0\", \"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-3-vx80\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21713, \"got_angle_revision\": \"8326b26a790f48a1d328413855e81cedeff1acc5\", \"got_dawn_revision\": \"ed883bc1d977e3c87579f206e094f36d443e1cfe\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0\", \"got_revision_cp\": \"refs/heads/master@{#836378}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"4f90750776f88d42c6ec2e5cef071d098fce3c15\", \"got_v8_revision\": \"da7e8b6d32ad49a5594c067d805edf9fdfc90f52\", \"got_v8_revision_cp\": \"refs/heads/8.9.139@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0\", \"swarm_hashes_refs/heads/master(at){#836378}_without_patch\": {\"absl_hardening_tests\": \"3d98a7931552c97a2be053056c9068c82b29422a\", \"accessibility_unittests\": \"88ab0cdb12c7b1c7476f3dd90dbd66ff87ad183c\", \"angle_unittests\": \"7d1b7c4fe9fc33445d080b2107b09d307e788116\", \"app_list_unittests\": \"37a966e4a31cdf59c783de120645f8548c6cc8bc\", \"app_shell_unittests\": \"89333573871f1db18d56f072b378f179c92f1c55\", \"ash_unittests\": \"a4c37411ff2f657ade1a2f9d626ed827a12b4daa\", \"aura_unittests\": \"8c2d2f63911ef036e4d20e71bae5f13ee6f42474\", \"base_unittests\": \"c2c95ecd8413e2204b7625fb9a24db1930a84a9f\", \"base_util_unittests\": \"35751627f05ce0b55c3ee608a14f307e36a7e681\", \"blink_common_unittests\": \"0fb8fd5c4201d4c7c30f9be7641e0c1ba17fe6f1\", \"blink_fuzzer_unittests\": \"8940ffc674cde86d93c619b63f635293ac459681\", \"blink_heap_unittests\": \"35b56075b7aaa793cc8e11d3984958e385df60cf\", \"blink_platform_unittests\": \"afc9073af33d3157083717c7e508a110fc657c85\", \"blink_unittests\": \"2ffe538b51b20029ec6d00586ffa71b4290246b7\", \"boringssl_crypto_tests\": \"e98650c0faef1545381c8241bb88c81ead3cafc2\", \"boringssl_ssl_tests\": \"e94fb8c575ce66ec21ff9839996e4ad0e37170d9\", \"browser_tests\": \"e69cd04b1b44bc3dbbd99ce77d7515c619dc5fc4\", \"capture_unittests\": \"c89e3e06b1507f1c5a0342fa6251989a11f4e24e\", \"cast_unittests\": \"d4050b4436381e2115d5732cf649f7d3b40bd09c\", \"cc_unittests\": \"7caeecf54ce2dd1650e1c9b56fb3a9397c5d9aff\", \"chrome_app_unittests\": \"58e8b144bab8c4a86314be47136ec12eeca70854\", \"chromedriver_unittests\": \"ad862534e7ff9520ec99a0b868a3f1b64ff901e7\", \"chromeos_components_unittests\": \"ad4d70211600dadbdc1a7982134a0406dd6c4813\", \"chromeos_unittests\": \"da42a68ac2b0b443a4c46e7a0e0bd84bf69c05f5\", \"components_browsertests\": \"2f4162742da524626dc27f222f0a4dadaacf0d3e\", \"components_unittests\": \"17648f1ff2e6c747c4d4a885e5b39bab5ca9cceb\", \"compositor_unittests\": \"8a557d1568914bda9cf501d09a5899d95acd7a51\", \"content_browsertests\": \"9e229c1baf1d06cd4762104688e1793382d8e151\", \"content_unittests\": \"0714b54ea5f5f804a83011601cdafc86fbab2a82\", \"crashpad_tests\": \"1ad7d7d514706581108c85e91d51c5bf5157bd88\", \"crypto_unittests\": \"d88c93177aa30087fbaa16961e6e7e472c9a9d85\", \"dbus_unittests\": \"9492bae93dfcd58bc6190ce5558a806a7e3bd90f\", \"device_unittests\": \"1254f4cacc4b86067d234b8844f4859e912c835d\", \"display_unittests\": \"d5b956a52e303f07d3352ce2ca9eed69fab29ca3\", \"events_unittests\": \"cd1ebd7870d0cd840d432d662e51117d63742ecb\", \"exo_unittests\": \"31e43622af10d035796096efd872ff970c126ddc\", \"extensions_browsertests\": \"8f7c4d127de46803185e3689cd691ad0b947a68e\", \"extensions_unittests\": \"45ff9cbf762a4aed94b3f9ff80df9f2327757a26\", \"filesystem_service_unittests\": \"4e992359a19fb3c131c89f85a597a44866f942dd\", \"gcm_unit_tests\": \"46cd2e5d1d3c00ef19c830bbe2715d954620d938\", \"gfx_unittests\": \"50b3473a313eb8583d8de1bcc6bef2044716b464\", \"gin_unittests\": \"21d53c94743b8eda6b9ec194a25347254b88e7fe\", \"gl_unittests_ozone\": \"60e098b7da0acdafa4a44425c5eb31f196b7de09\", \"google_apis_unittests\": \"668d60dfa8e4f8b216ecbd163350119f67e2ed36\", \"gpu_unittests\": \"71cce58eea71180a811e539aa79e54871b80dffa\", \"gwp_asan_unittests\": \"6613f7a716602fd80826d3020620f63ed3eb258b\", \"interactive_ui_tests\": \"6427cdcc6c7d27de5775dcab03317f27adb2818e\", \"ipc_tests\": \"85f6046ff1ebf4c5524f914f531d5e02846c1606\", \"jingle_unittests\": \"5231268dfa1b3bc9d96cd7c1836f44671bbd298b\", \"keyboard_unittests\": \"0becc7d9f44c1f080970428954e5307e6472b483\", \"latency_unittests\": \"f7ecf28c2ca8b9a2bba008b7aaa1917135710f64\", \"libjingle_xmpp_unittests\": \"f454c6c9d38829dc83ddaf49f94ecc4b87c8abb5\", \"liburlpattern_unittests\": \"3492fbc09c855a4574df1965c95c8c547f84ac80\", \"media_blink_unittests\": \"f1617bfe6d62ebb2d912637426ea63ec134cdf48\", \"media_unittests\": \"a9f681c39e53b73b3a160a6bc75e63960244d66b\", \"message_center_unittests\": \"b110398516a4c60021a7533d59a4030b7f63d65e\", \"midi_unittests\": \"7c70bec0506eafcdb18a92cd4fd0f7fa3c406001\", \"mojo_core_unittests\": \"1e3c4caff035a39f417a8f36ab328005e50875b6\", \"mojo_unittests\": \"312382ad2f02bebcd57956a7e6bf861362ec3385\", \"nacl_helper_nonsfi_unittests\": \"8729acfde2c804700271a02ee0e0dc65a4bcf2db\", \"nacl_loader_unittests\": \"b97da9b6102966f3734021a854c3b4dc7b943755\", \"native_theme_unittests\": \"7ed483b02153acc8c1e0357cc286c1b9b9fd6a7b\", \"net_unittests\": \"54e8080a5fc07a4f5cd9505994d2cb2e090360c4\", \"ozone_gl_unittests\": \"2cdd4a6639f402cd6d85e44fd31d506d22d8e606\", \"ozone_unittests\": \"a3d29f55ca6ffd1083615d08bc11641f35e5cfd0\", \"ozone_x11_unittests\": \"952a0c200398076a9725db06d54204e4799d5923\", \"pdf_unittests\": \"de2aaa6bd5b7131b0fb39a4e6202ae600fe525b8\", \"perfetto_unittests\": \"14b76f8b99f31601a57e22121d9c4dd7c7a1cb64\", \"ppapi_unittests\": \"0e9cf3b676d261324a392fc3c9260a602b8afffe\", \"printing_unittests\": \"d79344e51f9c20385d15465ae570f2b9b25965e3\", \"remoting_unittests\": \"76049ca7c18abd228ee69d9f4a23aae24f5fb68e\", \"sandbox_linux_unittests\": \"352333b3d4d27a5370d197bd4a0a95989a73bd6f\", \"service_manager_unittests\": \"11458d44e66b07ffdbae469dceb0859b2fc483c2\", \"services_unittests\": \"635ead5f6603a4d156ec9f5a94cac4133434ceb0\", \"shell_dialogs_unittests\": \"fd77a0f88f6941a4ebc7245ba859d09453361f8c\", \"shell_encryption_unittests\": \"6c3f3b6fdf9d8c204c6ef0028343082aa4e11ae7\", \"skia_unittests\": \"080b25408150821e9a5d7363ef3149d768a4737d\", \"snapshot_unittests\": \"ee765a05f3d2648cb8c45c3e0b779abeaadac082\", \"sql_unittests\": \"d2ddc5fe45cd98e77cf51ebffec00aefcc9e9733\", \"storage_unittests\": \"6e352af6cc0c83b484bfaa5dbb2e75e64b791726\", \"sync_integration_tests\": \"c7f1a068608afb877b104dd17c9d5cb10cf0a7b3\", \"traffic_annotation_auditor_unittests\": \"dd7feae48996c5fb18df02482ecf9189cdf481c5\", \"ui_base_unittests\": \"ebc002409c27b283d6457e08ad15b87038e8feff\", \"ui_chromeos_unittests\": \"ee4737cc8b642ba38053bf6d2ac6b6514f6f6a61\", \"ui_touch_selection_unittests\": \"b6de67f10380ceb51ddd560166f1b24b7d1e242a\", \"unit_tests\": \"67059f72f9f0d9590b404247686023674d7d35d1\", \"url_unittests\": \"aff9bc35b94f3c2941395343ddf0b98750921cbe\", \"usage_time_limit_unittests\": \"a10b30cb78b1556ffc49b081f20f83af7d1a5cc6\", \"views_unittests\": \"a1ccf054ac8f530061663c2d9ca8f9db62463167\", \"viz_unittests\": \"45daa594face41cba36e4641315ed29de9b7fc35\", \"wm_unittests\": \"7f06b6d0bfe8107c50872f6cd5e0686f73acf515\", \"wtf_unittests\": \"23b0976eb1073051560e900e98335494951d3b39\", \"zlib_unittests\": \"f33e8ba2833b71c4c7c0074f9dbac3f5e72d198a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_044050a0b4755a97cb04ff168eea18de1c19686e4e919408295086b0f826607c_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_b492a6a54599c40c9efefa6e5d1cdf990fad3125ae5ed8fb1c6f132ff9c1d569_v2\", \"builder_b73f380ff82aebbfe08c374279666467ed7ae9f4699bdf686b893daa00950c8e_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_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-3-vx80\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607740188041828",
"status": "COMPLETED",
"status_changed_ts": "1607746338597169",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21713",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e00de8f5d92a180cf0ada9ea4b672ff08bdfc8f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026586043703073248",
"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/8861155981003935008/+/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:506d995974710c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607746338629990",
"url": "https://ci.chromium.org/b/8861155981003935008",
"utcnow_ts": "1607746340199203"
}
}
[04:12:20.219] Invocation finished in 1h43m12.722011789s with status SUCCEEDED