[20:52:08.149] New invocation is queued and will start shortly
[20:52:09.227] Starting the invocation (attempt 1)
[20:52:09.306] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:52:09.306] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:52:09.306] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018091130401855632",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c466d9136d049b8f448507315d7c6c0149594a11\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018091130401855632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c466d9136d049b8f448507315d7c6c0149594a11",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c466d9136d049b8f448507315d7c6c0149594a11",
"gitiles_ref:refs/heads/master"
]
}
[20:52:10.530] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615841529385925",
"id": "8852661068441905984",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c466d9136d049b8f448507315d7c6c0149594a11\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615841530294613",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22996",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c466d9136d049b8f448507315d7c6c0149594a11",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c466d9136d049b8f448507315d7c6c0149594a11",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018091130401855632",
"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/8852661068441905984/+/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": "1615841530294757",
"url": "https://ci.chromium.org/b/8852661068441905984",
"utcnow_ts": "1615841530511754"
}
}
[20:52:10.530] Task URL: https://ci.chromium.org/b/8852661068441905984
[20:52:10.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:2:0) after 1m0s
[20:53:10.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:2:0)
[20:53:10.671] Timer tick, asking Buildbucket for the build status
[20:53:10.781] Build 8852661068441905984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:10.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:3:0) after 1m0s
[20:54:10.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:3:0)
[20:54:10.896] Timer tick, asking Buildbucket for the build status
[20:54:11.089] Build 8852661068441905984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:11.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:4:0) after 1m0s
[20:54:56.140] Received PubSub notification, asking Buildbucket for the build status
[20:54:56.243] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:11.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:4:0)
[20:55:11.085] Timer tick, asking Buildbucket for the build status
[20:55:11.143] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:11.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:6:0) after 1m0s
[20:56:11.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:6:0)
[20:56:11.182] Timer tick, asking Buildbucket for the build status
[20:56:11.604] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:11.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:7:0) after 1m0s
[20:57:11.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:7:0)
[20:57:11.656] Timer tick, asking Buildbucket for the build status
[20:57:12.287] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:12.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:8:0) after 1m0s
[20:58:12.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:8:0)
[20:58:12.318] Timer tick, asking Buildbucket for the build status
[20:58:12.766] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:12.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:9:0) after 1m0s
[20:59:12.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:9:0)
[20:59:12.788] Timer tick, asking Buildbucket for the build status
[20:59:12.938] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:12.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:10:0) after 1m0s
[21:00:12.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:10:0)
[21:00:12.992] Timer tick, asking Buildbucket for the build status
[21:00:13.082] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:13.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:11:0) after 1m0s
[21:01:13.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:11:0)
[21:01:13.097] Timer tick, asking Buildbucket for the build status
[21:01:13.202] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:13.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:12:0) after 1m0s
[21:02:13.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:12:0)
[21:02:13.277] Timer tick, asking Buildbucket for the build status
[21:02:14.536] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:14.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:13:0) after 1m0s
[21:03:14.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:13:0)
[21:03:14.681] Timer tick, asking Buildbucket for the build status
[21:03:14.812] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:14.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:14:0) after 1m0s
[21:04:14.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:14:0)
[21:04:14.922] Timer tick, asking Buildbucket for the build status
[21:04:14.989] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:14.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:15:0) after 1m0s
[21:05:15.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:15:0)
[21:05:15.081] Timer tick, asking Buildbucket for the build status
[21:05:15.169] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:15.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:16:0) after 1m0s
[21:06:15.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:16:0)
[21:06:15.216] Timer tick, asking Buildbucket for the build status
[21:06:15.283] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:15.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:17:0) after 1m0s
[21:07:15.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:17:0)
[21:07:15.281] Timer tick, asking Buildbucket for the build status
[21:07:15.417] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:15.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:18:0) after 1m0s
[21:08:15.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:18:0)
[21:08:15.537] Timer tick, asking Buildbucket for the build status
[21:08:15.635] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:15.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:19:0) after 1m0s
[21:09:15.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:19:0)
[21:09:15.668] Timer tick, asking Buildbucket for the build status
[21:09:15.742] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:15.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:20:0) after 1m0s
[21:10:15.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:20:0)
[21:10:15.821] Timer tick, asking Buildbucket for the build status
[21:10:15.952] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:15.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:21:0) after 1m0s
[21:11:16.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:21:0)
[21:11:16.459] Timer tick, asking Buildbucket for the build status
[21:11:16.533] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:16.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:22:0) after 1m0s
[21:12:17.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:22:0)
[21:12:17.206] Timer tick, asking Buildbucket for the build status
[21:12:17.520] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:17.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:23:0) after 1m0s
[21:13:17.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:23:0)
[21:13:17.542] Timer tick, asking Buildbucket for the build status
[21:13:17.761] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:17.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:24:0) after 1m0s
[21:14:17.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:24:0)
[21:14:17.757] Timer tick, asking Buildbucket for the build status
[21:14:17.831] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:17.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:25:0) after 1m0s
[21:15:17.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:25:0)
[21:15:17.880] Timer tick, asking Buildbucket for the build status
[21:15:18.487] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:18.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:26:0) after 1m0s
[21:16:18.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:26:0)
[21:16:18.595] Timer tick, asking Buildbucket for the build status
[21:16:18.737] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:18.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:27:0) after 1m0s
[21:17:18.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:27:0)
[21:17:18.845] Timer tick, asking Buildbucket for the build status
[21:17:20.674] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:20.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:28:0) after 1m0s
[21:18:20.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:28:0)
[21:18:20.741] Timer tick, asking Buildbucket for the build status
[21:18:21.387] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:21.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:29:0) after 1m0s
[21:19:21.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:29:0)
[21:19:21.508] Timer tick, asking Buildbucket for the build status
[21:19:21.607] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:21.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:30:0) after 1m0s
[21:20:22.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:30:0)
[21:20:22.134] Timer tick, asking Buildbucket for the build status
[21:20:22.239] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:22.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:31:0) after 1m0s
[21:21:22.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:31:0)
[21:21:22.241] Timer tick, asking Buildbucket for the build status
[21:21:22.457] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:22.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:32:0) after 1m0s
[21:22:22.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:32:0)
[21:22:22.451] Timer tick, asking Buildbucket for the build status
[21:22:22.549] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:22.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:33:0) after 1m0s
[21:23:22.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:33:0)
[21:23:22.656] Timer tick, asking Buildbucket for the build status
[21:23:22.765] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:22.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:34:0) after 1m0s
[21:24:22.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:34:0)
[21:24:22.815] Timer tick, asking Buildbucket for the build status
[21:24:22.908] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:22.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:35:0) after 1m0s
[21:25:22.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:35:0)
[21:25:22.977] Timer tick, asking Buildbucket for the build status
[21:25:23.486] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:23.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:36:0) after 1m0s
[21:26:23.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:36:0)
[21:26:23.516] Timer tick, asking Buildbucket for the build status
[21:26:23.601] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:23.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:37:0) after 1m0s
[21:27:23.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:37:0)
[21:27:23.634] Timer tick, asking Buildbucket for the build status
[21:27:24.268] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:24.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:38:0) after 1m0s
[21:28:24.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:38:0)
[21:28:24.294] Timer tick, asking Buildbucket for the build status
[21:28:24.392] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:24.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:39:0) after 1m0s
[21:29:24.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:39:0)
[21:29:24.415] Timer tick, asking Buildbucket for the build status
[21:29:24.550] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:24.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:40:0) after 1m0s
[21:30:24.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:40:0)
[21:30:24.574] Timer tick, asking Buildbucket for the build status
[21:30:24.695] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:24.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:41:0) after 1m0s
[21:31:25.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:41:0)
[21:31:25.175] Timer tick, asking Buildbucket for the build status
[21:31:25.351] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:25.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:42:0) after 1m0s
[21:32:25.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:42:0)
[21:32:25.663] Timer tick, asking Buildbucket for the build status
[21:32:25.909] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:25.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:43:0) after 1m0s
[21:33:25.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:43:0)
[21:33:25.936] Timer tick, asking Buildbucket for the build status
[21:33:26.747] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:26.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:44:0) after 1m0s
[21:34:26.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:44:0)
[21:34:26.742] Timer tick, asking Buildbucket for the build status
[21:34:26.817] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:26.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:45:0) after 1m0s
[21:35:26.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:45:0)
[21:35:26.835] Timer tick, asking Buildbucket for the build status
[21:35:28.985] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:28.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:46:0) after 1m0s
[21:36:29.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:46:0)
[21:36:29.079] Timer tick, asking Buildbucket for the build status
[21:36:29.380] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:29.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:47:0) after 1m0s
[21:37:29.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:47:0)
[21:37:29.615] Timer tick, asking Buildbucket for the build status
[21:37:29.757] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:29.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:48:0) after 1m0s
[21:38:30.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:48:0)
[21:38:30.093] Timer tick, asking Buildbucket for the build status
[21:38:30.166] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:30.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:49:0) after 1m0s
[21:39:30.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:49:0)
[21:39:30.287] Timer tick, asking Buildbucket for the build status
[21:39:30.996] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:30.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:50:0) after 1m0s
[21:40:31.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:50:0)
[21:40:31.038] Timer tick, asking Buildbucket for the build status
[21:40:31.170] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:31.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:51:0) after 1m0s
[21:41:31.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:51:0)
[21:41:31.186] Timer tick, asking Buildbucket for the build status
[21:41:31.283] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:31.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:52:0) after 1m0s
[21:42:31.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:52:0)
[21:42:31.379] Timer tick, asking Buildbucket for the build status
[21:42:31.482] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:31.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:53:0) after 1m0s
[21:43:31.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:53:0)
[21:43:31.543] Timer tick, asking Buildbucket for the build status
[21:43:31.625] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:31.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:54:0) after 1m0s
[21:44:31.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:54:0)
[21:44:31.689] Timer tick, asking Buildbucket for the build status
[21:44:31.776] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:31.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:55:0) after 1m0s
[21:45:32.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:55:0)
[21:45:32.052] Timer tick, asking Buildbucket for the build status
[21:45:32.758] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:32.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:56:0) after 1m0s
[21:46:32.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:56:0)
[21:46:32.810] Timer tick, asking Buildbucket for the build status
[21:46:32.908] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:32.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:57:0) after 1m0s
[21:47:32.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:57:0)
[21:47:32.960] Timer tick, asking Buildbucket for the build status
[21:47:33.086] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:33.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:58:0) after 1m0s
[21:48:33.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:58:0)
[21:48:33.215] Timer tick, asking Buildbucket for the build status
[21:48:36.829] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:36.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:59:0) after 1m0s
[21:49:36.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:59:0)
[21:49:36.963] Timer tick, asking Buildbucket for the build status
[21:49:37.296] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:37.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:60:0) after 1m0s
[21:50:37.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:60:0)
[21:50:37.307] Timer tick, asking Buildbucket for the build status
[21:50:37.437] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:37.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:61:0) after 1m0s
[21:51:37.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:61:0)
[21:51:37.465] Timer tick, asking Buildbucket for the build status
[21:51:37.558] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:37.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:62:0) after 1m0s
[21:52:37.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:62:0)
[21:52:37.916] Timer tick, asking Buildbucket for the build status
[21:52:38.029] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:38.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:63:0) after 1m0s
[21:53:38.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:63:0)
[21:53:38.255] Timer tick, asking Buildbucket for the build status
[21:53:38.365] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:38.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:64:0) after 1m0s
[21:54:38.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:64:0)
[21:54:38.454] Timer tick, asking Buildbucket for the build status
[21:54:38.762] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:38.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:65:0) after 1m0s
[21:55:38.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:65:0)
[21:55:38.823] Timer tick, asking Buildbucket for the build status
[21:55:38.943] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:38.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:66:0) after 1m0s
[21:56:38.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:66:0)
[21:56:38.988] Timer tick, asking Buildbucket for the build status
[21:56:39.950] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:39.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:67:0) after 1m0s
[21:57:40.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:67:0)
[21:57:40.175] Timer tick, asking Buildbucket for the build status
[21:57:40.285] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:40.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:68:0) after 1m0s
[21:58:40.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:68:0)
[21:58:40.509] Timer tick, asking Buildbucket for the build status
[21:58:40.783] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:40.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:69:0) after 1m0s
[21:59:40.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:69:0)
[21:59:40.871] Timer tick, asking Buildbucket for the build status
[21:59:40.962] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:40.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:70:0) after 1m0s
[22:00:41.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:70:0)
[22:00:41.026] Timer tick, asking Buildbucket for the build status
[22:00:41.200] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:71:0) after 1m0s
[22:01:41.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:71:0)
[22:01:41.173] Timer tick, asking Buildbucket for the build status
[22:01:41.339] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:41.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:72:0) after 1m0s
[22:02:41.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:72:0)
[22:02:41.682] Timer tick, asking Buildbucket for the build status
[22:02:42.454] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:42.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:73:0) after 1m0s
[22:03:42.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:73:0)
[22:03:42.544] Timer tick, asking Buildbucket for the build status
[22:03:42.668] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:42.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:74:0) after 1m0s
[22:04:42.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:74:0)
[22:04:42.688] Timer tick, asking Buildbucket for the build status
[22:04:42.801] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:42.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:75:0) after 1m0s
[22:05:42.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:75:0)
[22:05:42.856] Timer tick, asking Buildbucket for the build status
[22:05:42.992] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:42.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:76:0) after 1m0s
[22:06:43.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:76:0)
[22:06:43.090] Timer tick, asking Buildbucket for the build status
[22:06:44.189] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:44.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:77:0) after 1m0s
[22:07:44.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:77:0)
[22:07:44.372] Timer tick, asking Buildbucket for the build status
[22:07:44.462] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:44.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:78:0) after 1m0s
[22:08:44.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:78:0)
[22:08:44.473] Timer tick, asking Buildbucket for the build status
[22:08:44.801] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:44.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:79:0) after 1m0s
[22:09:44.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:79:0)
[22:09:44.779] Timer tick, asking Buildbucket for the build status
[22:09:44.987] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:44.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:80:0) after 1m0s
[22:10:44.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:80:0)
[22:10:44.970] Timer tick, asking Buildbucket for the build status
[22:10:46.497] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:46.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:81:0) after 1m0s
[22:11:46.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:81:0)
[22:11:46.697] Timer tick, asking Buildbucket for the build status
[22:11:46.946] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:46.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:82:0) after 1m0s
[22:12:47.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:82:0)
[22:12:47.039] Timer tick, asking Buildbucket for the build status
[22:12:47.146] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:47.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:83:0) after 1m0s
[22:13:47.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:83:0)
[22:13:47.195] Timer tick, asking Buildbucket for the build status
[22:13:47.339] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:47.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:84:0) after 1m0s
[22:14:47.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:84:0)
[22:14:47.360] Timer tick, asking Buildbucket for the build status
[22:14:47.471] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:47.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:85:0) after 1m0s
[22:15:47.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:85:0)
[22:15:47.513] Timer tick, asking Buildbucket for the build status
[22:15:47.940] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:47.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:86:0) after 1m0s
[22:16:47.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:86:0)
[22:16:47.954] Timer tick, asking Buildbucket for the build status
[22:16:48.068] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:48.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:87:0) after 1m0s
[22:17:48.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:87:0)
[22:17:48.091] Timer tick, asking Buildbucket for the build status
[22:17:48.291] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:48.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:88:0) after 1m0s
[22:18:48.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:88:0)
[22:18:48.361] Timer tick, asking Buildbucket for the build status
[22:18:48.483] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:48.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:89:0) after 1m0s
[22:19:48.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:89:0)
[22:19:48.568] Timer tick, asking Buildbucket for the build status
[22:19:48.888] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:48.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:90:0) after 1m0s
[22:20:48.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:90:0)
[22:20:48.901] Timer tick, asking Buildbucket for the build status
[22:20:49.153] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:49.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:91:0) after 1m0s
[22:21:49.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:91:0)
[22:21:49.343] Timer tick, asking Buildbucket for the build status
[22:21:49.466] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:49.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:92:0) after 1m0s
[22:22:49.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:92:0)
[22:22:49.738] Timer tick, asking Buildbucket for the build status
[22:22:49.885] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:49.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:93:0) after 1m0s
[22:23:49.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:93:0)
[22:23:49.993] Timer tick, asking Buildbucket for the build status
[22:23:50.253] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:50.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:94:0) after 1m0s
[22:24:50.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:94:0)
[22:24:50.442] Timer tick, asking Buildbucket for the build status
[22:24:50.536] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:50.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:95:0) after 1m0s
[22:25:50.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:95:0)
[22:25:50.568] Timer tick, asking Buildbucket for the build status
[22:25:50.766] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:50.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:96:0) after 1m0s
[22:26:50.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:96:0)
[22:26:50.775] Timer tick, asking Buildbucket for the build status
[22:26:50.879] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:50.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:97:0) after 1m0s
[22:27:51.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:97:0)
[22:27:51.368] Timer tick, asking Buildbucket for the build status
[22:27:51.760] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:51.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:98:0) after 1m0s
[22:28:51.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:98:0)
[22:28:51.819] Timer tick, asking Buildbucket for the build status
[22:28:51.937] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:51.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:99:0) after 1m0s
[22:29:51.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:99:0)
[22:29:51.981] Timer tick, asking Buildbucket for the build status
[22:29:52.184] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:52.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:100:0) after 1m0s
[22:30:52.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:100:0)
[22:30:52.345] Timer tick, asking Buildbucket for the build status
[22:30:52.438] Build 8852661068441905984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:52.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018091130401855632:101:0) after 1m0s
[22:31:41.711] Received PubSub notification, asking Buildbucket for the build status
[22:31:42.246] Build 8852661068441905984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:31:42.246] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615847500985836",
"created_by": "project:chromium",
"created_ts": "1615841529385925",
"id": "8852661068441905984",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c466d9136d049b8f448507315d7c6c0149594a11\"}}",
"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\": \"c466d9136d049b8f448507315d7c6c0149594a11\", \"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-12-gp6v\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22996, \"got_angle_revision\": \"a11d65a172f885042cf4fdab5bfd124d174f5190\", \"got_dawn_revision\": \"8c40cad1c92d7e85154bbae4cb92539e2200d139\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c466d9136d049b8f448507315d7c6c0149594a11\", \"got_revision_cp\": \"refs/heads/master@{#862949}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"69b79eec6533f113920a5dd863ee2dea7d0c64e7\", \"got_v8_revision\": \"d7ff8abb545ad8160e189a7e8352c13c7b0e30b8\", \"got_v8_revision_cp\": \"refs/heads/9.1.126@{#1}\", \"got_webrtc_revision\": \"6097b0fac0946a29d59a9266ea656c39b3fd7336\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33456}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c466d9136d049b8f448507315d7c6c0149594a11\", \"swarm_hashes_refs/heads/master(at){#862949}_without_patch\": {\"absl_hardening_tests\": \"bf657a3ba430dd2094a9ecc41c363378d34c744f\", \"accessibility_unittests\": \"81b2b07e39753519b9100d48059cdecefee37008\", \"angle_unittests\": \"74a03bed60f278d9af3eca3df981d37d1c07c180\", \"app_list_unittests\": \"69d0a130445b2e859b9d75ee5361d3b0421063ed\", \"app_shell_unittests\": \"8c21a3e80d0b27716437962112c472840eb42dcc\", \"ash_unittests\": \"0c8140b5ec8e5c4322a09d871b6ee7f35385c968\", \"aura_unittests\": \"8bc9d55b8198f3fb77717d6cbaf83fa7abe7d4eb\", \"base_unittests\": \"6e3d04c81e5be1b679d7b99f441ac37b855ccb27\", \"base_util_unittests\": \"86eac15707c2103335923f958a6d983ffe77fba9\", \"blink_common_unittests\": \"c133fd77d6c289d8a5cde61eae6e9baeae5eef10\", \"blink_fuzzer_unittests\": \"10577922dc553e548f6049224b3f944952a09f31\", \"blink_heap_unittests\": \"cd47a691e443d88b6cc081ae093bf7debb49ffb0\", \"blink_platform_unittests\": \"95b23d1076b2b771ea2dcf87abd18fd2facc58d4\", \"blink_unittests\": \"eb2df3745190b56f1ceb7c3b8581a245b18621d3\", \"boringssl_crypto_tests\": \"b7208a4e8286688cd6c7136d0052a8c9d9b75a56\", \"boringssl_ssl_tests\": \"fa73d05fa2226b3ce012c900344b50a4304ab008\", \"browser_tests\": \"5f73ead82f948f9439b1a810994ef870d2fe6992\", \"capture_unittests\": \"f219dd5f5ced499e50fbf897b723634544787e32\", \"cast_unittests\": \"53ad4a11827893463d2befdfb4763f9965d8c8f7\", \"cc_unittests\": \"89e5dc77cfb37dab2c357620240b966df788b4a3\", \"chrome_app_unittests\": \"8d2e3a199225d0bc9e2cea5ba5bd746b9bc3c2e0\", \"chromedriver_unittests\": \"0fca20b1eea75d7722d5d144353a78b0626a484c\", \"chromeos_components_unittests\": \"d664b290eea664a54c3998a109124269983f36a8\", \"chromeos_unittests\": \"edfb48b53988f289ef644d80395f73d6c417f3bd\", \"color_unittests\": \"5a72e069e240f4244deaabaa68fb040549c1b991\", \"components_browsertests\": \"7147ff3866f158f2a8727fa7c3c99881d65d365f\", \"components_unittests\": \"4954842a46142a999fe3a4341bf83cd4813a17dd\", \"compositor_unittests\": \"4eb9ee86022c6210e5befabd5eb66b8d6bd5a528\", \"content_browsertests\": \"6cf8ff48372d21ee2f29f835062f9c31512a3e59\", \"content_unittests\": \"9fc88eff5108e265ee4cc0e332e694380d292a17\", \"crashpad_tests\": \"d9637d3f24b2088e5962fc995cb58f91986ea362\", \"crypto_unittests\": \"5a85d2c524e69137cf18087906efa2a5f7ab881e\", \"dbus_unittests\": \"1943e1c1c1908d358bdbc3d3ee639f1c2fa869e6\", \"device_unittests\": \"3f9eeac55891b48df6631d0cad39dd1582f4b92e\", \"display_unittests\": \"03ae43a6bc07ac8d0dc16339e5dbfefe51e0d90d\", \"events_unittests\": \"dbea65ba3e97afe106b3563d66478b836bd1a6ce\", \"exo_unittests\": \"88f0cadbd3b0833c5fdb6b53a53439cf53f96f0d\", \"extensions_browsertests\": \"08b7a680e83b2385d18cf8ce8537ef628dfe5119\", \"extensions_unittests\": \"f65781580ff9b37f22cfd877596ffdd373f9366d\", \"filesystem_service_unittests\": \"e68cccd75f9aba2c78a740696ff1fdb5d7691cc4\", \"gcm_unit_tests\": \"3c8c69d45e6f6fa1a8e8772ffc6b2f75b76e7b96\", \"gfx_unittests\": \"a41fe4aff775abf2f8706f8481b5400bb1dcd52d\", \"gin_unittests\": \"9cbe086f70535cc82b4702d07362a814a0211c17\", \"gl_unittests_ozone\": \"669c65738a0a18b7426150be5fb6aac282536ddc\", \"google_apis_unittests\": \"dd740ee0cde7927e8630d795d6f440658bd8882a\", \"gpu_unittests\": \"ad8fde318c1f402e85d36622ecad7c683ae9311d\", \"gwp_asan_unittests\": \"aa21ac52144c7f76fdb477cc3164d881c80cb89b\", \"interactive_ui_tests\": \"fc03d2db04b85523294431ae0204e81ec227e172\", \"ipc_tests\": \"77d8b1190225b310e60fcee96aff7cca42e1de43\", \"jingle_unittests\": \"e22fcf21dd8fdc25d08262f2907f45af6eea1126\", \"keyboard_unittests\": \"229a3706c9f1ef8452758810f3c36407c60e8518\", \"latency_unittests\": \"cf613414f5f90496d4c0cb081ee056734d6435a4\", \"libjingle_xmpp_unittests\": \"9dfec0855edd8e91276a59291775c947a90aa451\", \"liburlpattern_unittests\": \"57474c21249a9d42ae4b792ecd31577d9c91599e\", \"media_blink_unittests\": \"f1c2b999ddcb8419eca7f82393192f67d44a7b98\", \"media_unittests\": \"a0ca02afb36c1fe7287c1b5516799c6202e8b2b5\", \"message_center_unittests\": \"53b964e03b3dc344152a4dfe4fdcf3221ae71ca6\", \"midi_unittests\": \"80931b8816cee973efb401b0457af53446354f21\", \"mojo_core_unittests\": \"5402edc7213dad83af8532b6843495c58a75a755\", \"mojo_unittests\": \"e444415726956d6e70c0aac29be247b42dbe70a5\", \"nacl_helper_nonsfi_unittests\": \"cc0a70817a05dc04277737ba46a9ec44487c14ac\", \"nacl_loader_unittests\": \"6b82162964c645ea4314dfc3b894cae2c9fcbdd2\", \"native_theme_unittests\": \"db468bfdc1247119186b8058a2b4e1d859a7b8ab\", \"net_unittests\": \"092751aec67cad50aeaa24135b09a9aff4a3dc08\", \"ozone_gl_unittests\": \"655f528fe09c217faa68e8b49ca6ca269e44e00e\", \"ozone_unittests\": \"c80c68459dd684aaf4fcd85400dd9a0368e0af87\", \"ozone_x11_unittests\": \"bb4f4bf8713ef8028e0c6e40acec9563f18a24f6\", \"pdf_unittests\": \"bbacaf7bba548e02375994a529c0b778898ce8a9\", \"perfetto_unittests\": \"2f86d2a855fc8f8effa8b06ae8dc98288c438f86\", \"ppapi_unittests\": \"f41a5d135acb05937ee374b45d95f117378e1568\", \"printing_unittests\": \"212e450ebe2fbe13348458a28f7f1061f66d4681\", \"remoting_unittests\": \"b850a3b0b07f95de23eb6e54bc55a885f2a91700\", \"sandbox_linux_unittests\": \"2228ad71ccbab690b3425ddacedcf6dbe982fc75\", \"service_manager_unittests\": \"33ce95affc655d6c35e7da4fdfa7688f7572dc74\", \"services_unittests\": \"953632baea3f642f199b7b9d6535929dee20ea49\", \"shell_dialogs_unittests\": \"63dbbf7b8fb7a23199f1cc2848713b3bbb4a1b53\", \"shell_encryption_unittests\": \"8dc035634236e8a5404f7378d15a6ed435f5bc17\", \"skia_unittests\": \"f79a52b1e36f0964c612a7b15b63a824b8122964\", \"snapshot_unittests\": \"27b448e186c373b30e58febdf0e768516df88867\", \"sql_unittests\": \"6d1d434c94eb57b2dde0517765769e7fd13b7d80\", \"storage_unittests\": \"3e0abbee4ca70f1e61d9f2099ba19b9a0d1e9864\", \"sync_integration_tests\": \"7a16f2db20639ad966c2dd74f7c9c6a74ca58010\", \"traffic_annotation_auditor_unittests\": \"35a7d55baf0ed22a27dbc6eedf2da00786f4e361\", \"ui_base_unittests\": \"627e4070b6742788ce967215da6a3f3d7a69dd67\", \"ui_chromeos_unittests\": \"e402e9cad0d9f4eeb02b7741c0000c21ad414295\", \"ui_touch_selection_unittests\": \"f1287b33b044b761420c7822817f589680163ae3\", \"unit_tests\": \"1f39b26544cf5c62d5b182e204eb2306ac559931\", \"url_unittests\": \"8c12ecbefc281442db130b931d09958eb0011e50\", \"usage_time_limit_unittests\": \"b6546f53bfc6b5954bb938c814cc99943980e43e\", \"views_unittests\": \"9d499a3dd593c79c5b569e6d456f5eb35f4db0a8\", \"viz_unittests\": \"7e9f5cb22daadc93f2c60543852bcc532f3fda2f\", \"wayland_client_tests\": \"39c457f5d580d0d30a79eb2dbccce5b6a98cf622\", \"wm_unittests\": \"378cc8eab9a778d74b430b3015c1827d8e3d58e3\", \"wtf_unittests\": \"1a72396f8f31d24032f03c0540a30e8a0c2645b5\", \"zlib_unittests\": \"549f11b1729f0885d31b0feca53921075e5658df\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0e4559ffd6169ab721e778dfe83867ca08424e9b4d480f5c0e6f91286240fc3f_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_52b3455bc016485ac846758ed32679b3eb96461dff570695d0073fe962116473_v2\", \"builder_a3b3a06131dfa9924971b27d0acd4e18e80a2242b6d6ae41f94b770d7c996d6f_v2\", \"builder_be6033c31ad7fe993e51aceefec32c9781d9cb2aa7f3fe71df24045d7e98805a_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_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-12-gp6v\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615841694596244",
"status": "COMPLETED",
"status_changed_ts": "1615847501325797",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22996",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c466d9136d049b8f448507315d7c6c0149594a11",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c466d9136d049b8f448507315d7c6c0149594a11",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018091130401855632",
"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/8852661068441905984/+/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:52507a9eb183e910",
"user_agent:luci-scheduler"
],
"updated_ts": "1615847501330720",
"url": "https://ci.chromium.org/b/8852661068441905984",
"utcnow_ts": "1615847502214555"
}
}
[22:31:42.246] Invocation finished in 1h39m34.114295185s with status SUCCEEDED