[01:42:28.258] New invocation is queued and will start shortly
[01:42:30.089] Starting the invocation (attempt 1)
[01:42:30.132] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:42:30.132] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:42:30.132] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027494948601918160",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a777ee30240a7af346a1175ed40503185970772c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027494948601918160",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a777ee30240a7af346a1175ed40503185970772c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a777ee30240a7af346a1175ed40503185970772c",
"gitiles_ref:refs/heads/master"
]
}
[01:42:31.481] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1606873350229364",
"id": "8862064885868739312",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a777ee30240a7af346a1175ed40503185970772c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606873350961259",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21564",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a777ee30240a7af346a1175ed40503185970772c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a777ee30240a7af346a1175ed40503185970772c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027494948601918160",
"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/8862064885868739312/+/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": "1606873350965742",
"url": "https://ci.chromium.org/b/8862064885868739312",
"utcnow_ts": "1606873351422315"
}
}
[01:42:31.481] Task URL: https://ci.chromium.org/b/8862064885868739312
[01:42:31.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:2:0) after 1m0s
[01:42:36.875] Received PubSub notification, asking Buildbucket for the build status
[01:42:37.132] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:31.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:2:0)
[01:43:31.568] Timer tick, asking Buildbucket for the build status
[01:43:31.680] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:31.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:4:0) after 1m0s
[01:44:31.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:4:0)
[01:44:31.727] Timer tick, asking Buildbucket for the build status
[01:44:31.885] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:5:0) after 1m0s
[01:45:31.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:5:0)
[01:45:31.909] Timer tick, asking Buildbucket for the build status
[01:45:32.016] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:32.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:6:0) after 1m0s
[01:46:32.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:6:0)
[01:46:32.135] Timer tick, asking Buildbucket for the build status
[01:46:32.280] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:32.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:7:0) after 1m0s
[01:47:32.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:7:0)
[01:47:32.415] Timer tick, asking Buildbucket for the build status
[01:47:32.825] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:32.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:8:0) after 1m0s
[01:48:32.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:8:0)
[01:48:32.907] Timer tick, asking Buildbucket for the build status
[01:48:33.135] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:33.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:9:0) after 1m0s
[01:49:33.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:9:0)
[01:49:33.367] Timer tick, asking Buildbucket for the build status
[01:49:33.641] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:33.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:10:0) after 1m0s
[01:50:33.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:10:0)
[01:50:33.677] Timer tick, asking Buildbucket for the build status
[01:50:33.780] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:33.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:11:0) after 1m0s
[01:51:33.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:11:0)
[01:51:33.942] Timer tick, asking Buildbucket for the build status
[01:51:34.571] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:34.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:12:0) after 1m0s
[01:52:34.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:12:0)
[01:52:34.755] Timer tick, asking Buildbucket for the build status
[01:52:34.963] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:34.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:13:0) after 1m0s
[01:53:35.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:13:0)
[01:53:35.066] Timer tick, asking Buildbucket for the build status
[01:53:35.155] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:14:0) after 1m0s
[01:54:35.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:14:0)
[01:54:35.240] Timer tick, asking Buildbucket for the build status
[01:54:35.336] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:35.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:15:0) after 1m0s
[01:55:35.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:15:0)
[01:55:35.405] Timer tick, asking Buildbucket for the build status
[01:55:35.477] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:35.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:16:0) after 1m0s
[01:56:35.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:16:0)
[01:56:35.545] Timer tick, asking Buildbucket for the build status
[01:56:35.628] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:35.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:17:0) after 1m0s
[01:57:35.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:17:0)
[01:57:35.747] Timer tick, asking Buildbucket for the build status
[01:57:35.891] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:35.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:18:0) after 1m0s
[01:58:36.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:18:0)
[01:58:36.042] Timer tick, asking Buildbucket for the build status
[01:58:36.163] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:36.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:19:0) after 1m0s
[01:59:36.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:19:0)
[01:59:36.525] Timer tick, asking Buildbucket for the build status
[01:59:36.629] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:36.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:20:0) after 1m0s
[02:00:36.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:20:0)
[02:00:36.784] Timer tick, asking Buildbucket for the build status
[02:00:36.854] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:36.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:21:0) after 1m0s
[02:01:36.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:21:0)
[02:01:36.940] Timer tick, asking Buildbucket for the build status
[02:01:37.004] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:22:0) after 1m0s
[02:02:37.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:22:0)
[02:02:37.054] Timer tick, asking Buildbucket for the build status
[02:02:37.329] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:37.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:23:0) after 1m0s
[02:03:37.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:23:0)
[02:03:37.548] Timer tick, asking Buildbucket for the build status
[02:03:37.607] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:37.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:24:0) after 1m0s
[02:04:37.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:24:0)
[02:04:37.657] Timer tick, asking Buildbucket for the build status
[02:04:37.949] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:37.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:25:0) after 1m0s
[02:05:37.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:25:0)
[02:05:37.950] Timer tick, asking Buildbucket for the build status
[02:05:38.015] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:38.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:26:0) after 1m0s
[02:06:38.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:26:0)
[02:06:38.027] Timer tick, asking Buildbucket for the build status
[02:06:38.103] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:27:0) after 1m0s
[02:07:38.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:27:0)
[02:07:38.174] Timer tick, asking Buildbucket for the build status
[02:07:38.385] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:38.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:28:0) after 1m0s
[02:08:38.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:28:0)
[02:08:38.620] Timer tick, asking Buildbucket for the build status
[02:08:38.710] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:29:0) after 1m0s
[02:09:38.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:29:0)
[02:09:38.780] Timer tick, asking Buildbucket for the build status
[02:09:38.847] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:38.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:30:0) after 1m0s
[02:10:39.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:30:0)
[02:10:39.112] Timer tick, asking Buildbucket for the build status
[02:10:39.876] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:39.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:31:0) after 1m0s
[02:11:39.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:31:0)
[02:11:39.933] Timer tick, asking Buildbucket for the build status
[02:11:40.032] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:40.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:32:0) after 1m0s
[02:12:40.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:32:0)
[02:12:40.136] Timer tick, asking Buildbucket for the build status
[02:12:40.266] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:40.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:33:0) after 1m0s
[02:13:40.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:33:0)
[02:13:40.365] Timer tick, asking Buildbucket for the build status
[02:13:40.482] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:40.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:34:0) after 1m0s
[02:14:40.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:34:0)
[02:14:40.519] Timer tick, asking Buildbucket for the build status
[02:14:40.650] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:40.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:35:0) after 1m0s
[02:15:40.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:35:0)
[02:15:40.713] Timer tick, asking Buildbucket for the build status
[02:15:40.793] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:40.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:36:0) after 1m0s
[02:16:40.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:36:0)
[02:16:40.835] Timer tick, asking Buildbucket for the build status
[02:16:40.892] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:40.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:37:0) after 1m0s
[02:17:40.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:37:0)
[02:17:40.939] Timer tick, asking Buildbucket for the build status
[02:17:41.074] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:41.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:38:0) after 1m0s
[02:18:41.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:38:0)
[02:18:41.114] Timer tick, asking Buildbucket for the build status
[02:18:41.353] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:41.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:39:0) after 1m0s
[02:19:41.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:39:0)
[02:19:41.376] Timer tick, asking Buildbucket for the build status
[02:19:41.509] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:41.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:40:0) after 1m0s
[02:20:41.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:40:0)
[02:20:41.597] Timer tick, asking Buildbucket for the build status
[02:20:41.820] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:41.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:41:0) after 1m0s
[02:21:41.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:41:0)
[02:21:41.934] Timer tick, asking Buildbucket for the build status
[02:21:42.775] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:42.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:42:0) after 1m0s
[02:22:42.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:42:0)
[02:22:42.811] Timer tick, asking Buildbucket for the build status
[02:22:42.946] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:42.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:43:0) after 1m0s
[02:23:42.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:43:0)
[02:23:42.989] Timer tick, asking Buildbucket for the build status
[02:23:43.144] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:43.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:44:0) after 1m0s
[02:24:43.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:44:0)
[02:24:43.258] Timer tick, asking Buildbucket for the build status
[02:24:43.649] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:43.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:45:0) after 1m0s
[02:25:43.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:45:0)
[02:25:43.653] Timer tick, asking Buildbucket for the build status
[02:25:44.809] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:44.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:46:0) after 1m0s
[02:26:44.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:46:0)
[02:26:44.863] Timer tick, asking Buildbucket for the build status
[02:26:44.994] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:47:0) after 1m0s
[02:27:45.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:47:0)
[02:27:45.013] Timer tick, asking Buildbucket for the build status
[02:27:45.147] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:45.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:48:0) after 1m0s
[02:28:45.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:48:0)
[02:28:45.231] Timer tick, asking Buildbucket for the build status
[02:28:45.328] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:45.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:49:0) after 1m0s
[02:29:45.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:49:0)
[02:29:45.355] Timer tick, asking Buildbucket for the build status
[02:29:45.526] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:45.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:50:0) after 1m0s
[02:30:45.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:50:0)
[02:30:45.536] Timer tick, asking Buildbucket for the build status
[02:30:45.658] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:45.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:51:0) after 1m0s
[02:31:45.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:51:0)
[02:31:45.690] Timer tick, asking Buildbucket for the build status
[02:31:45.820] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:45.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:52:0) after 1m0s
[02:32:45.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:52:0)
[02:32:45.854] Timer tick, asking Buildbucket for the build status
[02:32:45.979] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:45.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:53:0) after 1m0s
[02:33:46.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:53:0)
[02:33:46.062] Timer tick, asking Buildbucket for the build status
[02:33:46.224] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:46.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:54:0) after 1m0s
[02:34:46.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:54:0)
[02:34:46.386] Timer tick, asking Buildbucket for the build status
[02:34:46.489] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:46.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:55:0) after 1m0s
[02:35:46.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:55:0)
[02:35:46.641] Timer tick, asking Buildbucket for the build status
[02:35:46.812] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:46.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:56:0) after 1m0s
[02:36:47.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:56:0)
[02:36:47.024] Timer tick, asking Buildbucket for the build status
[02:36:47.201] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:47.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:57:0) after 1m0s
[02:37:47.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:57:0)
[02:37:47.228] Timer tick, asking Buildbucket for the build status
[02:37:47.408] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:47.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:58:0) after 1m0s
[02:38:47.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:58:0)
[02:38:47.525] Timer tick, asking Buildbucket for the build status
[02:38:47.609] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:47.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:59:0) after 1m0s
[02:39:47.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:59:0)
[02:39:47.702] Timer tick, asking Buildbucket for the build status
[02:39:47.874] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:47.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:60:0) after 1m0s
[02:40:47.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:60:0)
[02:40:47.918] Timer tick, asking Buildbucket for the build status
[02:40:48.565] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:48.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:61:0) after 1m0s
[02:41:48.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:61:0)
[02:41:48.642] Timer tick, asking Buildbucket for the build status
[02:41:48.864] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:48.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:62:0) after 1m0s
[02:42:48.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:62:0)
[02:42:48.917] Timer tick, asking Buildbucket for the build status
[02:42:49.041] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:49.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:63:0) after 1m0s
[02:43:49.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:63:0)
[02:43:49.145] Timer tick, asking Buildbucket for the build status
[02:43:49.268] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:49.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:64:0) after 1m0s
[02:44:49.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:64:0)
[02:44:49.252] Timer tick, asking Buildbucket for the build status
[02:44:49.353] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:49.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:65:0) after 1m0s
[02:45:49.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:65:0)
[02:45:49.454] Timer tick, asking Buildbucket for the build status
[02:45:49.534] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:49.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:66:0) after 1m0s
[02:46:49.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:66:0)
[02:46:49.588] Timer tick, asking Buildbucket for the build status
[02:46:49.654] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:49.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:67:0) after 1m0s
[02:47:49.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:67:0)
[02:47:49.660] Timer tick, asking Buildbucket for the build status
[02:47:49.848] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:49.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:68:0) after 1m0s
[02:48:49.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:68:0)
[02:48:49.897] Timer tick, asking Buildbucket for the build status
[02:48:49.997] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:49.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:69:0) after 1m0s
[02:49:50.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:69:0)
[02:49:50.075] Timer tick, asking Buildbucket for the build status
[02:49:50.159] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:50.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:70:0) after 1m0s
[02:50:50.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:70:0)
[02:50:50.186] Timer tick, asking Buildbucket for the build status
[02:50:50.451] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:50.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:71:0) after 1m0s
[02:51:50.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:71:0)
[02:51:50.480] Timer tick, asking Buildbucket for the build status
[02:51:50.611] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:50.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:72:0) after 1m0s
[02:52:50.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:72:0)
[02:52:50.666] Timer tick, asking Buildbucket for the build status
[02:52:50.781] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:50.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:73:0) after 1m0s
[02:53:50.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:73:0)
[02:53:50.799] Timer tick, asking Buildbucket for the build status
[02:53:50.897] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:50.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:74:0) after 1m0s
[02:54:50.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:74:0)
[02:54:50.922] Timer tick, asking Buildbucket for the build status
[02:54:51.043] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:51.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:75:0) after 1m0s
[02:55:51.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:75:0)
[02:55:51.071] Timer tick, asking Buildbucket for the build status
[02:55:51.176] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:51.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:76:0) after 1m0s
[02:56:51.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:76:0)
[02:56:51.315] Timer tick, asking Buildbucket for the build status
[02:56:51.392] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:77:0) after 1m0s
[02:57:51.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:77:0)
[02:57:51.644] Timer tick, asking Buildbucket for the build status
[02:57:51.765] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:51.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:78:0) after 1m0s
[02:58:52.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:78:0)
[02:58:52.353] Timer tick, asking Buildbucket for the build status
[02:58:52.445] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:52.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:79:0) after 1m0s
[02:59:52.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:79:0)
[02:59:52.642] Timer tick, asking Buildbucket for the build status
[02:59:52.744] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:52.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:80:0) after 1m0s
[03:00:52.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:80:0)
[03:00:52.958] Timer tick, asking Buildbucket for the build status
[03:00:53.278] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:53.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:81:0) after 1m0s
[03:01:53.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:81:0)
[03:01:53.324] Timer tick, asking Buildbucket for the build status
[03:01:53.690] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:53.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:82:0) after 1m0s
[03:02:53.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:82:0)
[03:02:53.729] Timer tick, asking Buildbucket for the build status
[03:02:53.926] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:53.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:83:0) after 1m0s
[03:03:53.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:83:0)
[03:03:53.989] Timer tick, asking Buildbucket for the build status
[03:03:54.407] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:54.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:84:0) after 1m0s
[03:04:54.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:84:0)
[03:04:54.537] Timer tick, asking Buildbucket for the build status
[03:04:54.707] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:54.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:85:0) after 1m0s
[03:05:54.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:85:0)
[03:05:54.915] Timer tick, asking Buildbucket for the build status
[03:05:55.094] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:55.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:86:0) after 1m0s
[03:06:55.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:86:0)
[03:06:55.159] Timer tick, asking Buildbucket for the build status
[03:06:55.680] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:55.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:87:0) after 1m0s
[03:07:56.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:87:0)
[03:07:56.167] Timer tick, asking Buildbucket for the build status
[03:07:56.425] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:56.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:88:0) after 1m0s
[03:08:56.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:88:0)
[03:08:56.711] Timer tick, asking Buildbucket for the build status
[03:08:57.102] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:89:0) after 1m0s
[03:09:57.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:89:0)
[03:09:57.201] Timer tick, asking Buildbucket for the build status
[03:09:57.442] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:57.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:90:0) after 1m0s
[03:10:57.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:90:0)
[03:10:57.531] Timer tick, asking Buildbucket for the build status
[03:10:57.598] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:57.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:91:0) after 1m0s
[03:11:57.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:91:0)
[03:11:57.758] Timer tick, asking Buildbucket for the build status
[03:11:57.949] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:57.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:92:0) after 1m0s
[03:12:58.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:92:0)
[03:12:58.192] Timer tick, asking Buildbucket for the build status
[03:12:58.299] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:58.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:93:0) after 1m0s
[03:13:58.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:93:0)
[03:13:58.407] Timer tick, asking Buildbucket for the build status
[03:13:58.502] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:58.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:94:0) after 1m0s
[03:14:58.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:94:0)
[03:14:58.657] Timer tick, asking Buildbucket for the build status
[03:14:58.804] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:58.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:95:0) after 1m0s
[03:15:58.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:95:0)
[03:15:58.857] Timer tick, asking Buildbucket for the build status
[03:15:59.000] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:59.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:96:0) after 1m0s
[03:16:59.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:96:0)
[03:16:59.116] Timer tick, asking Buildbucket for the build status
[03:16:59.426] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:59.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:97:0) after 1m0s
[03:17:59.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:97:0)
[03:17:59.459] Timer tick, asking Buildbucket for the build status
[03:17:59.586] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:59.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:98:0) after 1m0s
[03:18:59.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:98:0)
[03:18:59.670] Timer tick, asking Buildbucket for the build status
[03:18:59.799] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:59.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:99:0) after 1m0s
[03:19:59.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:99:0)
[03:19:59.827] Timer tick, asking Buildbucket for the build status
[03:20:00.194] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:00.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:100:0) after 1m0s
[03:21:00.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:100:0)
[03:21:00.236] Timer tick, asking Buildbucket for the build status
[03:21:00.338] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:101:0) after 1m0s
[03:22:00.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:101:0)
[03:22:00.534] Timer tick, asking Buildbucket for the build status
[03:22:00.623] Build 8862064885868739312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:00.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027494948601918160:102:0) after 1m0s
[03:22:12.831] Received PubSub notification, asking Buildbucket for the build status
[03:22:12.921] Build 8862064885868739312: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:22:12.921] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1606879331540690",
"created_by": "project:chromium",
"created_ts": "1606873350229364",
"id": "8862064885868739312",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a777ee30240a7af346a1175ed40503185970772c\"}}",
"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\": \"a777ee30240a7af346a1175ed40503185970772c\", \"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-50-n15r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21564, \"got_angle_revision\": \"0c47015b57a03230e0cab10532c3deed80604512\", \"got_dawn_revision\": \"6f5151f6572bf22c88d0b3152bebeaa460ac4723\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"a777ee30240a7af346a1175ed40503185970772c\", \"got_revision_cp\": \"refs/heads/master@{#832614}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bfb211914759cc5deffbe9419cd1c2cae0573488\", \"got_v8_revision\": \"ac41b8da5f1de6f65eea381b67341c7c32acb05f\", \"got_v8_revision_cp\": \"refs/heads/8.9.73@{#1}\", \"got_webrtc_revision\": \"449a78b1e20ea85b11f967cf3a184ee610ce21c3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32734}\", \"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\": \"a777ee30240a7af346a1175ed40503185970772c\", \"swarm_hashes_refs/heads/master(at){#832614}_without_patch\": {\"absl_hardening_tests\": \"2e968fb3f87c44baf8e0b4c04a914871c3e2fc8b\", \"accessibility_unittests\": \"26ab38d89defa55bb566f3fd6fd86320660f12b8\", \"angle_unittests\": \"3e599203fe1527725f9cf58e0b8d496635d33940\", \"app_list_unittests\": \"fc067c53e32b8e9edcc09ff7000b6f94a1b81abd\", \"app_shell_unittests\": \"ef786916d1685032cd9fa90e2360c8f4c74b10de\", \"ash_unittests\": \"4bf94f4b7a5a3752ebf38c5206711723e17b510f\", \"aura_unittests\": \"0f94a6ab11c4137fb9081f371aa70bac423b3ac0\", \"base_unittests\": \"8144e05597a326a3da34bcad5a0e6b0d9141b86e\", \"base_util_unittests\": \"f1367417b0b705fd5e05c8f5ba27075eea6e8ec3\", \"blink_common_unittests\": \"a7675ee9f9f469e49ccf0d1a2e05689d8c0dbfa5\", \"blink_fuzzer_unittests\": \"9f493b075b7142a8a6ef85d89e404af264c0734c\", \"blink_heap_unittests\": \"cc8fe00052f384fd05d5e3b82f31a9f506aabc16\", \"blink_platform_unittests\": \"7229c8d99f3c5ce75a2cf903fb3b6fb07982f7f5\", \"blink_unittests\": \"dc9b3dbc1decc87937cb64a907dceda7b221c7b9\", \"boringssl_crypto_tests\": \"c6cdac190745699ce808c5209de343b74499cdc9\", \"boringssl_ssl_tests\": \"c73d4f5405bbef6d415f869eacb7cc29de2326a6\", \"browser_tests\": \"3ce51a9fce904594ebf0ae9afef92a1750f57f6d\", \"capture_unittests\": \"eb38ccb34063122b01f0e0bb4a2cb308fa394877\", \"cast_unittests\": \"7da262d2890674334f6ab08764031369a52f1c9c\", \"cc_unittests\": \"27c226e8addefc38fbdaf87c8768f375050909cb\", \"chrome_app_unittests\": \"57238c4aa559ae915d18bfe68e441b3d445bb364\", \"chromedriver_unittests\": \"5445c069a4d61558175230619b0622e3072ac145\", \"chromeos_components_unittests\": \"641d298774812da7ff8a60e0d5173aa85565dc69\", \"chromeos_unittests\": \"59218aa3a833bd3245cfd63823a39c286f2edc62\", \"components_browsertests\": \"5bd1306405482d9cfc69c13b0f283bf21d6b044a\", \"components_unittests\": \"b4f9e3793b999614f132301a7cced7adf3388eb4\", \"compositor_unittests\": \"d0f6baab9a381f5b7112532a341356b647d7cd79\", \"content_browsertests\": \"47e0d79541300a0f9703130a58f568b95dcf676d\", \"content_unittests\": \"e2f0b8dd699a69bb7ae9f29aefbb35fb8b74ddad\", \"crashpad_tests\": \"116686c4a803609ed89af7788aeaa2ad1f809392\", \"crypto_unittests\": \"7f2d2469a9ca7a9b536db7a04622f7d2f5d3cf3f\", \"dbus_unittests\": \"e3ccca9492248c3977e7401f3e004046d8a0fa08\", \"device_unittests\": \"48869629c925c0eac134f195630bccf018174ffb\", \"display_unittests\": \"90467cc52604f6744cd6116147247df147b191a4\", \"events_unittests\": \"f907c8f78e94cfd01b09d142ac058268b1117058\", \"exo_unittests\": \"b767417b8e84dd0476fb79bd3ff1ee3bbc1f5b8f\", \"extensions_browsertests\": \"3150ba8c757cf0d56950996f08dc01f623a53c19\", \"extensions_unittests\": \"f5ba629f23d2838bd614863009f899ee2c6c664c\", \"filesystem_service_unittests\": \"6581fc1787b956ab9364501cfe3c75939f70ba7b\", \"gcm_unit_tests\": \"55e58f1f98b5217559a51cb0ff8fcd487164e90c\", \"gfx_unittests\": \"467dfddfc48e7e93e5c60f1b0850a34b01b257cb\", \"gin_unittests\": \"83380fb19d94ecafd1706cb4152cd253b93f7dbf\", \"gl_unittests_ozone\": \"573fb71641bcea831177c14e0aa416fd33b2a2a2\", \"google_apis_unittests\": \"3412197b0c46675ea7f3aaa61772706532ad26be\", \"gpu_unittests\": \"1b3ce7cd46d244eef8f3648fd999b81d51986e82\", \"gwp_asan_unittests\": \"c9f6db35c057b1af5c5aa8ffe196880dcf322d1b\", \"interactive_ui_tests\": \"7c0969e36203de439116d2d82bea275e0df2b6dc\", \"ipc_tests\": \"02757718341a3113185bfb75888ddf36e390440e\", \"jingle_unittests\": \"30d04c03b3dbd7646ae0ea8cc3d602696a6c0646\", \"keyboard_unittests\": \"987f5097c69b25411a2f72b601f36de16515d892\", \"latency_unittests\": \"6f85641190df47af72c0b863c0c46a04be357ff0\", \"libjingle_xmpp_unittests\": \"23994e3c3ec22aa0713774721e6d9a4f6b30af71\", \"liburlpattern_unittests\": \"24beb53c379b1854a6c6aad37584b03c23ff9626\", \"media_blink_unittests\": \"796e9a34a2f0ce22f95a96ba3b85193ff54031d6\", \"media_unittests\": \"b43a2e419a1f4396ffc75266c19b787a990071eb\", \"message_center_unittests\": \"4a10b3bedbd971fa887e1648a13b6df050854fc4\", \"midi_unittests\": \"2e67e445239fa128c5e016a1a2ce650af69fdbbb\", \"mojo_core_unittests\": \"ff8b49b8cf0b72f1c11164c2e9d3ea7c751f2fec\", \"mojo_unittests\": \"335e9f445ae82400f8974beccb4fbf19a073773c\", \"nacl_helper_nonsfi_unittests\": \"69349c526b6e672d092ec9b8da37d9bf867f3f34\", \"nacl_loader_unittests\": \"095c6dfb347552089c718e9dc61e675ade853ce6\", \"native_theme_unittests\": \"238e028334889e3d88a66b04da2d1222a8b0d729\", \"net_unittests\": \"4d279c02b89ad00cd02ff4838a362d76a783cebe\", \"ozone_gl_unittests\": \"03bbc70ff24a54d49debecafca3a11f0bbcfcd44\", \"ozone_unittests\": \"376befd48941e5c0aa5b37b7f50054c07fc1e4c6\", \"ozone_x11_unittests\": \"ac078774150a42a7d38be63ed32debe3249a9df6\", \"pdf_unittests\": \"e5e9f91da671561269d3f6206dffadbca87e7f26\", \"perfetto_unittests\": \"4120a2481196e312274377e5456398eb1570ce0a\", \"ppapi_unittests\": \"535327e7d4b9af59ee139fede6cb6ae6edf90a91\", \"printing_unittests\": \"1bbbd5870b3ec4d08538a024d713d734f851f5c4\", \"remoting_unittests\": \"9dfd621086b1d88e4c284a612f522bdb145e3282\", \"sandbox_linux_unittests\": \"32be1a7a17c1a37e542765b41b50dd737e98c72b\", \"service_manager_unittests\": \"0703c69fbd1b3c306e1dd5f46a1ff3177bd6e008\", \"services_unittests\": \"f24b2deb713650997a9fd1e6d9bde97ff4758f93\", \"shell_dialogs_unittests\": \"3c37a19f187497001c5d3fad67ba736abcea841b\", \"shell_encryption_unittests\": \"c4853c59081a31226911c1bd510b37eae6cc7d60\", \"skia_unittests\": \"af7d84730015b356885c72913fac95e6dc168bb8\", \"snapshot_unittests\": \"88ed6a0d2acde7505a1ef89370cf30d371b7d535\", \"sql_unittests\": \"f8e69efd1341b94d789be376fcd01d0798a5e771\", \"storage_unittests\": \"07a4b570b8c725ca8d981df4cc67fe44bc717315\", \"sync_integration_tests\": \"2cfa66152e27a554fdfb9ad1ec79cb234d93d608\", \"traffic_annotation_auditor_unittests\": \"ea62b1ca27a433accb74c2f1b4d57d192d032563\", \"ui_base_unittests\": \"6b5c73c0471cca40a27da14d9270ba4a042b7e78\", \"ui_chromeos_unittests\": \"6a78fad3c34a56158a6ccfe1aaf0f4ea68e117f9\", \"ui_touch_selection_unittests\": \"dc5b95055ed41a3958f8a7b432fd07da378af5db\", \"unit_tests\": \"fc79ad9c6c5b7acf56273f7469348a426ce6aea0\", \"url_unittests\": \"1c9afb25ac3908e7f5fec369f79e9294d990fa52\", \"usage_time_limit_unittests\": \"3caa8ccee73185adfee8feda0e6bf628ef0ec901\", \"views_unittests\": \"c2b1edf805339b12132c93d43fb0c2a7e43607b7\", \"viz_unittests\": \"d7a5c412f92eedfa5ad765cd5cb9b7a802fa34cb\", \"wm_unittests\": \"2c989cae94a701fc2af6dd7c8ae29f16e829711e\", \"wtf_unittests\": \"f5f4624ccd778c59a593d04707d811e8ae8a695c\", \"zlib_unittests\": \"ecb697c2bcdf9d70d0c3a4518674f036700cb215\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-50-n15r\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606873355997047",
"status": "COMPLETED",
"status_changed_ts": "1606879331918655",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21564",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a777ee30240a7af346a1175ed40503185970772c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a777ee30240a7af346a1175ed40503185970772c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027494948601918160",
"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/8862064885868739312/+/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:5039ef0eb484d510",
"user_agent:luci-scheduler"
],
"updated_ts": "1606879331924240",
"url": "https://ci.chromium.org/b/8862064885868739312",
"utcnow_ts": "1606879332910429"
}
}
[03:22:12.921] Invocation finished in 1h39m44.68200504s with status SUCCEEDED