[17:16:40.366] New invocation is queued and will start shortly
[17:16:41.432] Starting the invocation (attempt 1)
[17:16:41.539] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:16:41.540] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:16:41.540] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020822595155220160",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"75699cf561512dfa8d849ea8dfc33266318e1dff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020822595155220160",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/75699cf561512dfa8d849ea8dfc33266318e1dff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/75699cf561512dfa8d849ea8dfc33266318e1dff",
"gitiles_ref:refs/heads/master"
]
}
[17:16:42.668] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613236601683687",
"id": "8855392533112017584",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"75699cf561512dfa8d849ea8dfc33266318e1dff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613236602478768",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22612",
"builder:linux-chromeos-dbg",
"buildset:commit/git/75699cf561512dfa8d849ea8dfc33266318e1dff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/75699cf561512dfa8d849ea8dfc33266318e1dff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020822595155220160",
"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/8855392533112017584/+/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": "1613236602478875",
"url": "https://ci.chromium.org/b/8855392533112017584",
"utcnow_ts": "1613236602660293"
}
}
[17:16:42.668] Task URL: https://ci.chromium.org/b/8855392533112017584
[17:16:42.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:2:0) after 1m0s
[17:17:42.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:2:0)
[17:17:42.680] Timer tick, asking Buildbucket for the build status
[17:17:43.006] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:17:43.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:3:0) after 1m0s
[17:18:44.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:3:0)
[17:18:44.349] Timer tick, asking Buildbucket for the build status
[17:18:44.451] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:44.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:4:0) after 1m0s
[17:19:44.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:4:0)
[17:19:44.640] Timer tick, asking Buildbucket for the build status
[17:19:44.816] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:44.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:5:0) after 1m0s
[17:20:44.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:5:0)
[17:20:44.935] Timer tick, asking Buildbucket for the build status
[17:20:45.058] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:20:45.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:6:0) after 1m0s
[17:21:45.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:6:0)
[17:21:45.288] Timer tick, asking Buildbucket for the build status
[17:21:45.386] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:21:45.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:7:0) after 1m0s
[17:22:45.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:7:0)
[17:22:45.412] Timer tick, asking Buildbucket for the build status
[17:22:45.637] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:22:45.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:8:0) after 1m0s
[17:23:45.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:8:0)
[17:23:45.888] Timer tick, asking Buildbucket for the build status
[17:23:45.971] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:23:45.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:9:0) after 1m0s
[17:24:46.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:9:0)
[17:24:46.584] Timer tick, asking Buildbucket for the build status
[17:24:46.742] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:24:46.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:10:0) after 1m0s
[17:25:46.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:10:0)
[17:25:46.918] Timer tick, asking Buildbucket for the build status
[17:25:46.987] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:25:46.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:11:0) after 1m0s
[17:26:47.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:11:0)
[17:26:47.196] Timer tick, asking Buildbucket for the build status
[17:26:47.292] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:26:47.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:12:0) after 1m0s
[17:27:47.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:12:0)
[17:27:47.464] Timer tick, asking Buildbucket for the build status
[17:27:47.551] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:27:47.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:13:0) after 1m0s
[17:28:47.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:13:0)
[17:28:47.525] Timer tick, asking Buildbucket for the build status
[17:28:47.590] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:28:47.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:14:0) after 1m0s
[17:29:47.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:14:0)
[17:29:47.643] Timer tick, asking Buildbucket for the build status
[17:29:47.708] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:47.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:15:0) after 1m0s
[17:30:47.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:15:0)
[17:30:47.771] Timer tick, asking Buildbucket for the build status
[17:30:47.846] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:47.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:16:0) after 1m0s
[17:31:47.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:16:0)
[17:31:47.951] Timer tick, asking Buildbucket for the build status
[17:31:48.068] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:31:48.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:17:0) after 1m0s
[17:32:48.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:17:0)
[17:32:48.131] Timer tick, asking Buildbucket for the build status
[17:32:48.199] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:32:48.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:18:0) after 1m0s
[17:33:48.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:18:0)
[17:33:48.390] Timer tick, asking Buildbucket for the build status
[17:33:48.452] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:48.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:19:0) after 1m0s
[17:34:48.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:19:0)
[17:34:48.629] Timer tick, asking Buildbucket for the build status
[17:34:48.745] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:48.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:20:0) after 1m0s
[17:35:48.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:20:0)
[17:35:48.990] Timer tick, asking Buildbucket for the build status
[17:35:49.059] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:49.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:21:0) after 1m0s
[17:36:49.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:21:0)
[17:36:49.132] Timer tick, asking Buildbucket for the build status
[17:36:49.416] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:22:0) after 1m0s
[17:37:49.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:22:0)
[17:37:49.628] Timer tick, asking Buildbucket for the build status
[17:37:49.691] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:49.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:23:0) after 1m0s
[17:38:49.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:23:0)
[17:38:49.713] Timer tick, asking Buildbucket for the build status
[17:38:49.807] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:49.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:24:0) after 1m0s
[17:39:49.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:24:0)
[17:39:49.810] Timer tick, asking Buildbucket for the build status
[17:39:49.877] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:49.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:25:0) after 1m0s
[17:40:49.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:25:0)
[17:40:49.895] Timer tick, asking Buildbucket for the build status
[17:40:50.027] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:50.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:26:0) after 1m0s
[17:41:50.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:26:0)
[17:41:50.076] Timer tick, asking Buildbucket for the build status
[17:41:50.159] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:50.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:27:0) after 1m0s
[17:42:50.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:27:0)
[17:42:50.181] Timer tick, asking Buildbucket for the build status
[17:42:50.283] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:50.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:28:0) after 1m0s
[17:43:50.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:28:0)
[17:43:50.355] Timer tick, asking Buildbucket for the build status
[17:43:50.435] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:50.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:29:0) after 1m0s
[17:44:50.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:29:0)
[17:44:50.439] Timer tick, asking Buildbucket for the build status
[17:44:50.528] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:50.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:30:0) after 1m0s
[17:45:50.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:30:0)
[17:45:50.555] Timer tick, asking Buildbucket for the build status
[17:45:50.689] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:50.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:31:0) after 1m0s
[17:46:50.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:31:0)
[17:46:50.774] Timer tick, asking Buildbucket for the build status
[17:46:50.934] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:50.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:32:0) after 1m0s
[17:47:50.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:32:0)
[17:47:50.911] Timer tick, asking Buildbucket for the build status
[17:47:50.983] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:50.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:33:0) after 1m0s
[17:48:51.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:33:0)
[17:48:51.068] Timer tick, asking Buildbucket for the build status
[17:48:51.296] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:51.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:34:0) after 1m0s
[17:49:51.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:34:0)
[17:49:51.292] Timer tick, asking Buildbucket for the build status
[17:49:51.354] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:51.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:35:0) after 1m0s
[17:50:51.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:35:0)
[17:50:51.445] Timer tick, asking Buildbucket for the build status
[17:50:51.529] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:51.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:36:0) after 1m0s
[17:51:51.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:36:0)
[17:51:51.549] Timer tick, asking Buildbucket for the build status
[17:51:51.740] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:37:0) after 1m0s
[17:52:51.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:37:0)
[17:52:51.792] Timer tick, asking Buildbucket for the build status
[17:52:51.861] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:51.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:38:0) after 1m0s
[17:53:51.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:38:0)
[17:53:51.886] Timer tick, asking Buildbucket for the build status
[17:53:51.966] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:51.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:39:0) after 1m0s
[17:54:51.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:39:0)
[17:54:51.993] Timer tick, asking Buildbucket for the build status
[17:54:52.058] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:52.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:40:0) after 1m0s
[17:55:52.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:40:0)
[17:55:52.114] Timer tick, asking Buildbucket for the build status
[17:55:52.185] Build 8855392533112017584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:52.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:41:0) after 1m0s
[17:56:09.015] Received PubSub notification, asking Buildbucket for the build status
[17:56:09.345] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:52.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:41:0)
[17:56:52.167] Timer tick, asking Buildbucket for the build status
[17:56:52.524] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:52.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:43:0) after 1m0s
[17:57:52.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:43:0)
[17:57:52.579] Timer tick, asking Buildbucket for the build status
[17:57:52.895] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:52.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:44:0) after 1m0s
[17:58:52.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:44:0)
[17:58:52.916] Timer tick, asking Buildbucket for the build status
[17:58:53.243] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:53.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:45:0) after 1m0s
[17:59:53.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:45:0)
[17:59:53.297] Timer tick, asking Buildbucket for the build status
[17:59:53.450] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:53.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:46:0) after 1m0s
[18:00:53.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:46:0)
[18:00:53.527] Timer tick, asking Buildbucket for the build status
[18:00:53.611] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:53.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:47:0) after 1m0s
[18:01:53.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:47:0)
[18:01:53.625] Timer tick, asking Buildbucket for the build status
[18:01:54.007] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:54.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:48:0) after 1m0s
[18:02:54.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:48:0)
[18:02:54.038] Timer tick, asking Buildbucket for the build status
[18:02:54.215] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:54.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:49:0) after 1m0s
[18:03:54.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:49:0)
[18:03:54.314] Timer tick, asking Buildbucket for the build status
[18:03:54.518] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:54.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:50:0) after 1m0s
[18:04:54.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:50:0)
[18:04:54.585] Timer tick, asking Buildbucket for the build status
[18:04:54.680] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:54.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:51:0) after 1m0s
[18:05:54.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:51:0)
[18:05:54.733] Timer tick, asking Buildbucket for the build status
[18:05:54.992] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:54.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:52:0) after 1m0s
[18:06:55.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:52:0)
[18:06:55.023] Timer tick, asking Buildbucket for the build status
[18:06:55.140] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:55.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:53:0) after 1m0s
[18:07:55.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:53:0)
[18:07:55.167] Timer tick, asking Buildbucket for the build status
[18:07:55.436] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:55.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:54:0) after 1m0s
[18:08:55.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:54:0)
[18:08:55.487] Timer tick, asking Buildbucket for the build status
[18:08:55.730] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:55.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:55:0) after 1m0s
[18:09:55.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:55:0)
[18:09:55.712] Timer tick, asking Buildbucket for the build status
[18:09:55.784] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:55.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:56:0) after 1m0s
[18:10:55.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:56:0)
[18:10:55.773] Timer tick, asking Buildbucket for the build status
[18:10:55.854] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:57:0) after 1m0s
[18:11:55.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:57:0)
[18:11:55.941] Timer tick, asking Buildbucket for the build status
[18:11:56.256] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:56.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:58:0) after 1m0s
[18:12:56.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:58:0)
[18:12:56.285] Timer tick, asking Buildbucket for the build status
[18:12:56.366] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:56.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:59:0) after 1m0s
[18:13:56.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:59:0)
[18:13:56.342] Timer tick, asking Buildbucket for the build status
[18:13:56.808] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:56.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:60:0) after 1m0s
[18:14:56.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:60:0)
[18:14:56.860] Timer tick, asking Buildbucket for the build status
[18:14:56.940] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:56.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:61:0) after 1m0s
[18:15:56.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:61:0)
[18:15:56.960] Timer tick, asking Buildbucket for the build status
[18:15:57.044] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:57.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:62:0) after 1m0s
[18:16:57.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:62:0)
[18:16:57.111] Timer tick, asking Buildbucket for the build status
[18:16:57.318] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:57.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:63:0) after 1m0s
[18:17:57.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:63:0)
[18:17:57.388] Timer tick, asking Buildbucket for the build status
[18:17:57.498] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:57.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:64:0) after 1m0s
[18:18:57.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:64:0)
[18:18:57.520] Timer tick, asking Buildbucket for the build status
[18:18:57.605] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:57.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:65:0) after 1m0s
[18:19:57.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:65:0)
[18:19:57.662] Timer tick, asking Buildbucket for the build status
[18:19:57.874] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:57.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:66:0) after 1m0s
[18:20:57.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:66:0)
[18:20:57.895] Timer tick, asking Buildbucket for the build status
[18:20:58.057] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:58.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:67:0) after 1m0s
[18:21:58.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:67:0)
[18:21:58.174] Timer tick, asking Buildbucket for the build status
[18:21:58.405] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:58.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:68:0) after 1m0s
[18:22:58.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:68:0)
[18:22:58.595] Timer tick, asking Buildbucket for the build status
[18:22:58.738] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:58.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:69:0) after 1m0s
[18:23:58.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:69:0)
[18:23:58.733] Timer tick, asking Buildbucket for the build status
[18:23:58.823] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:58.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:70:0) after 1m0s
[18:24:58.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:70:0)
[18:24:58.816] Timer tick, asking Buildbucket for the build status
[18:24:59.059] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:59.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:71:0) after 1m0s
[18:25:59.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:71:0)
[18:25:59.087] Timer tick, asking Buildbucket for the build status
[18:25:59.185] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:59.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:72:0) after 1m0s
[18:26:59.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:72:0)
[18:26:59.238] Timer tick, asking Buildbucket for the build status
[18:26:59.332] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:59.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:73:0) after 1m0s
[18:27:59.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:73:0)
[18:27:59.357] Timer tick, asking Buildbucket for the build status
[18:27:59.422] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:59.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:74:0) after 1m0s
[18:28:59.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:74:0)
[18:28:59.442] Timer tick, asking Buildbucket for the build status
[18:28:59.523] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:59.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:75:0) after 1m0s
[18:29:59.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:75:0)
[18:29:59.537] Timer tick, asking Buildbucket for the build status
[18:29:59.626] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:59.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:76:0) after 1m0s
[18:30:59.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:76:0)
[18:30:59.648] Timer tick, asking Buildbucket for the build status
[18:30:59.711] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:59.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:77:0) after 1m0s
[18:31:59.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:77:0)
[18:31:59.730] Timer tick, asking Buildbucket for the build status
[18:31:59.911] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:59.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:78:0) after 1m0s
[18:32:59.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:78:0)
[18:32:59.950] Timer tick, asking Buildbucket for the build status
[18:33:00.156] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:00.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:79:0) after 1m0s
[18:34:00.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:79:0)
[18:34:00.183] Timer tick, asking Buildbucket for the build status
[18:34:00.308] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:00.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:80:0) after 1m0s
[18:35:00.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:80:0)
[18:35:00.427] Timer tick, asking Buildbucket for the build status
[18:35:00.683] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:00.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:81:0) after 1m0s
[18:36:00.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:81:0)
[18:36:00.828] Timer tick, asking Buildbucket for the build status
[18:36:00.904] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:00.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:82:0) after 1m0s
[18:37:01.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:82:0)
[18:37:01.209] Timer tick, asking Buildbucket for the build status
[18:37:01.315] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:01.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:83:0) after 1m0s
[18:38:01.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:83:0)
[18:38:01.334] Timer tick, asking Buildbucket for the build status
[18:38:01.419] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:01.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:84:0) after 1m0s
[18:39:01.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:84:0)
[18:39:01.449] Timer tick, asking Buildbucket for the build status
[18:39:01.524] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:01.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:85:0) after 1m0s
[18:40:01.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:85:0)
[18:40:01.566] Timer tick, asking Buildbucket for the build status
[18:40:01.657] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:01.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:86:0) after 1m0s
[18:41:01.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:86:0)
[18:41:01.710] Timer tick, asking Buildbucket for the build status
[18:41:01.940] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:01.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:87:0) after 1m0s
[18:42:01.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:87:0)
[18:42:01.921] Timer tick, asking Buildbucket for the build status
[18:42:02.099] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:02.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:88:0) after 1m0s
[18:43:02.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:88:0)
[18:43:02.150] Timer tick, asking Buildbucket for the build status
[18:43:02.246] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:02.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:89:0) after 1m0s
[18:44:02.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:89:0)
[18:44:02.298] Timer tick, asking Buildbucket for the build status
[18:44:02.386] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:02.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:90:0) after 1m0s
[18:45:02.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:90:0)
[18:45:02.422] Timer tick, asking Buildbucket for the build status
[18:45:02.539] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:02.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:91:0) after 1m0s
[18:46:02.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:91:0)
[18:46:02.630] Timer tick, asking Buildbucket for the build status
[18:46:02.799] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:02.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:92:0) after 1m0s
[18:47:02.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:92:0)
[18:47:02.856] Timer tick, asking Buildbucket for the build status
[18:47:03.085] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:03.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:93:0) after 1m0s
[18:48:03.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:93:0)
[18:48:03.140] Timer tick, asking Buildbucket for the build status
[18:48:03.214] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:03.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:94:0) after 1m0s
[18:49:03.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:94:0)
[18:49:03.234] Timer tick, asking Buildbucket for the build status
[18:49:03.715] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:03.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:95:0) after 1m0s
[18:50:03.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:95:0)
[18:50:03.754] Timer tick, asking Buildbucket for the build status
[18:50:04.117] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:04.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:96:0) after 1m0s
[18:51:04.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:96:0)
[18:51:04.139] Timer tick, asking Buildbucket for the build status
[18:51:04.504] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:04.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:97:0) after 1m0s
[18:52:04.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:97:0)
[18:52:04.562] Timer tick, asking Buildbucket for the build status
[18:52:04.879] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:04.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:98:0) after 1m0s
[18:53:04.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:98:0)
[18:53:04.869] Timer tick, asking Buildbucket for the build status
[18:53:05.007] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:05.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:99:0) after 1m0s
[18:54:05.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:99:0)
[18:54:05.097] Timer tick, asking Buildbucket for the build status
[18:54:05.179] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:05.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:100:0) after 1m0s
[18:55:05.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:100:0)
[18:55:05.304] Timer tick, asking Buildbucket for the build status
[18:55:05.447] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:05.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:101:0) after 1m0s
[18:56:05.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:101:0)
[18:56:05.468] Timer tick, asking Buildbucket for the build status
[18:56:05.599] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:05.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:102:0) after 1m0s
[18:57:05.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:102:0)
[18:57:05.715] Timer tick, asking Buildbucket for the build status
[18:57:06.115] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:103:0) after 1m0s
[18:58:06.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:103:0)
[18:58:06.160] Timer tick, asking Buildbucket for the build status
[18:58:06.293] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:06.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:104:0) after 1m0s
[18:59:06.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:104:0)
[18:59:06.314] Timer tick, asking Buildbucket for the build status
[18:59:06.841] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:06.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:105:0) after 1m0s
[19:00:06.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:105:0)
[19:00:06.874] Timer tick, asking Buildbucket for the build status
[19:00:06.964] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:06.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:106:0) after 1m0s
[19:01:07.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:106:0)
[19:01:07.014] Timer tick, asking Buildbucket for the build status
[19:01:07.490] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:07.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:107:0) after 1m0s
[19:02:07.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:107:0)
[19:02:07.546] Timer tick, asking Buildbucket for the build status
[19:02:07.645] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:07.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:108:0) after 1m0s
[19:03:07.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:108:0)
[19:03:07.666] Timer tick, asking Buildbucket for the build status
[19:03:07.784] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:07.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:109:0) after 1m0s
[19:04:07.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:109:0)
[19:04:07.833] Timer tick, asking Buildbucket for the build status
[19:04:07.952] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:07.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:110:0) after 1m0s
[19:05:08.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:110:0)
[19:05:08.017] Timer tick, asking Buildbucket for the build status
[19:05:08.118] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:08.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:111:0) after 1m0s
[19:06:08.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:111:0)
[19:06:08.154] Timer tick, asking Buildbucket for the build status
[19:06:08.330] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:08.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:112:0) after 1m0s
[19:07:08.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:112:0)
[19:07:08.371] Timer tick, asking Buildbucket for the build status
[19:07:08.622] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:08.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:113:0) after 1m0s
[19:08:08.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:113:0)
[19:08:08.671] Timer tick, asking Buildbucket for the build status
[19:08:08.758] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:08.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:114:0) after 1m0s
[19:09:08.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:114:0)
[19:09:08.815] Timer tick, asking Buildbucket for the build status
[19:09:08.928] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:08.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:115:0) after 1m0s
[19:10:08.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:115:0)
[19:10:08.995] Timer tick, asking Buildbucket for the build status
[19:10:09.233] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:09.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:116:0) after 1m0s
[19:11:09.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:116:0)
[19:11:09.279] Timer tick, asking Buildbucket for the build status
[19:11:09.425] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:09.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:117:0) after 1m0s
[19:12:09.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:117:0)
[19:12:09.446] Timer tick, asking Buildbucket for the build status
[19:12:09.550] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:09.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:118:0) after 1m0s
[19:13:09.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:118:0)
[19:13:09.571] Timer tick, asking Buildbucket for the build status
[19:13:09.821] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:09.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:119:0) after 1m0s
[19:14:09.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:119:0)
[19:14:09.939] Timer tick, asking Buildbucket for the build status
[19:14:10.180] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:10.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:120:0) after 1m0s
[19:15:10.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:120:0)
[19:15:10.204] Timer tick, asking Buildbucket for the build status
[19:15:10.431] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:10.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:121:0) after 1m0s
[19:16:10.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:121:0)
[19:16:10.525] Timer tick, asking Buildbucket for the build status
[19:16:10.654] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:10.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:122:0) after 1m0s
[19:17:10.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:122:0)
[19:17:10.692] Timer tick, asking Buildbucket for the build status
[19:17:10.804] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:10.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:123:0) after 1m0s
[19:18:10.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:123:0)
[19:18:10.867] Timer tick, asking Buildbucket for the build status
[19:18:10.950] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:10.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:124:0) after 1m0s
[19:19:11.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:124:0)
[19:19:11.014] Timer tick, asking Buildbucket for the build status
[19:19:11.148] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:11.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:125:0) after 1m0s
[19:20:11.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:125:0)
[19:20:11.203] Timer tick, asking Buildbucket for the build status
[19:20:11.283] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:11.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:126:0) after 1m0s
[19:21:11.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:126:0)
[19:21:11.303] Timer tick, asking Buildbucket for the build status
[19:21:11.582] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:11.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:127:0) after 1m0s
[19:22:11.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:127:0)
[19:22:11.672] Timer tick, asking Buildbucket for the build status
[19:22:11.805] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:11.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:128:0) after 1m0s
[19:23:11.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:128:0)
[19:23:11.890] Timer tick, asking Buildbucket for the build status
[19:23:12.099] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:12.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:129:0) after 1m0s
[19:24:12.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:129:0)
[19:24:12.236] Timer tick, asking Buildbucket for the build status
[19:24:12.402] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:12.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:130:0) after 1m0s
[19:25:12.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:130:0)
[19:25:12.492] Timer tick, asking Buildbucket for the build status
[19:25:12.702] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:12.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:131:0) after 1m0s
[19:26:12.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:131:0)
[19:26:12.843] Timer tick, asking Buildbucket for the build status
[19:26:13.062] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:13.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:132:0) after 1m0s
[19:27:13.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:132:0)
[19:27:13.121] Timer tick, asking Buildbucket for the build status
[19:27:13.240] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:13.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:133:0) after 1m0s
[19:28:13.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:133:0)
[19:28:13.368] Timer tick, asking Buildbucket for the build status
[19:28:13.448] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:13.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:134:0) after 1m0s
[19:29:13.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:134:0)
[19:29:13.718] Timer tick, asking Buildbucket for the build status
[19:29:13.908] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:13.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:135:0) after 1m0s
[19:30:13.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:135:0)
[19:30:13.968] Timer tick, asking Buildbucket for the build status
[19:30:14.063] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:14.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:136:0) after 1m0s
[19:31:14.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:136:0)
[19:31:14.266] Timer tick, asking Buildbucket for the build status
[19:31:14.347] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:14.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:137:0) after 1m0s
[19:32:14.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:137:0)
[19:32:14.401] Timer tick, asking Buildbucket for the build status
[19:32:14.521] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:14.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:138:0) after 1m0s
[19:33:14.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:138:0)
[19:33:14.643] Timer tick, asking Buildbucket for the build status
[19:33:14.722] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:14.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:139:0) after 1m0s
[19:34:14.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:139:0)
[19:34:14.890] Timer tick, asking Buildbucket for the build status
[19:34:15.060] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:15.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:140:0) after 1m0s
[19:35:15.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:140:0)
[19:35:15.147] Timer tick, asking Buildbucket for the build status
[19:35:15.243] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:15.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:141:0) after 1m0s
[19:36:15.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:141:0)
[19:36:15.343] Timer tick, asking Buildbucket for the build status
[19:36:15.627] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:15.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:142:0) after 1m0s
[19:37:15.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:142:0)
[19:37:15.675] Timer tick, asking Buildbucket for the build status
[19:37:15.807] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:15.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:143:0) after 1m0s
[19:38:15.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:143:0)
[19:38:15.932] Timer tick, asking Buildbucket for the build status
[19:38:16.013] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:16.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:144:0) after 1m0s
[19:39:16.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:144:0)
[19:39:16.094] Timer tick, asking Buildbucket for the build status
[19:39:16.176] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:16.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:145:0) after 1m0s
[19:40:16.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:145:0)
[19:40:16.234] Timer tick, asking Buildbucket for the build status
[19:40:16.322] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:16.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:146:0) after 1m0s
[19:41:16.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:146:0)
[19:41:16.424] Timer tick, asking Buildbucket for the build status
[19:41:16.570] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:16.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:147:0) after 1m0s
[19:42:16.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:147:0)
[19:42:16.647] Timer tick, asking Buildbucket for the build status
[19:42:16.875] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:16.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:148:0) after 1m0s
[19:43:16.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:148:0)
[19:43:16.904] Timer tick, asking Buildbucket for the build status
[19:43:17.046] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:17.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:149:0) after 1m0s
[19:44:17.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:149:0)
[19:44:17.073] Timer tick, asking Buildbucket for the build status
[19:44:17.150] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:17.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:150:0) after 1m0s
[19:45:17.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:150:0)
[19:45:17.505] Timer tick, asking Buildbucket for the build status
[19:45:17.589] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:17.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:151:0) after 1m0s
[19:46:17.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:151:0)
[19:46:17.859] Timer tick, asking Buildbucket for the build status
[19:46:17.948] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:17.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:152:0) after 1m0s
[19:47:18.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:152:0)
[19:47:18.066] Timer tick, asking Buildbucket for the build status
[19:47:18.166] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:18.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:153:0) after 1m0s
[19:48:18.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:153:0)
[19:48:18.391] Timer tick, asking Buildbucket for the build status
[19:48:18.607] Build 8855392533112017584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:18.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020822595155220160:154:0) after 1m0s
[19:48:52.564] Received PubSub notification, asking Buildbucket for the build status
[19:48:52.651] Build 8855392533112017584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:48:52.651] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613245730843142",
"created_by": "project:chromium",
"created_ts": "1613236601683687",
"id": "8855392533112017584",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"75699cf561512dfa8d849ea8dfc33266318e1dff\"}}",
"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\": \"75699cf561512dfa8d849ea8dfc33266318e1dff\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-52-jqp1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22612, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"75699cf561512dfa8d849ea8dfc33266318e1dff\", \"got_revision_cp\": \"refs/heads/master@{#853841}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"75699cf561512dfa8d849ea8dfc33266318e1dff\", \"swarm_hashes_refs/heads/master(at){#853841}_without_patch\": {\"absl_hardening_tests\": \"026e6183817ca4632d83adc3102f4f9a750a8cfe\", \"accessibility_unittests\": \"28af2e310e76ed91a261410ce3817d19450d842c\", \"angle_unittests\": \"bfe35bd2e6ed3bae774c8b2a52abced0e3bd375d\", \"app_list_unittests\": \"70ff1951d5b472d17d8e0f91f168483ecb6fc82d\", \"app_shell_unittests\": \"c3d23d5d33acc40273e81a2e740ce1d36fc9d721\", \"ash_unittests\": \"deda568eeb756a3e9181a5814669823f054998c1\", \"aura_unittests\": \"a43f3d143560e4e12b53e835dc9d65cce54a8b16\", \"base_unittests\": \"321bbb26b6bd8b70900558e488769432ac2b266a\", \"base_util_unittests\": \"f2f0eb79c163e38ac9a0e0d92edd9e5f832598f1\", \"blink_common_unittests\": \"fa0f20e1853447348f4f65da83673ddd77f56f3e\", \"blink_fuzzer_unittests\": \"06e14b7eadf8240c37af33ab075289aa950306e3\", \"blink_heap_unittests\": \"7d4369333985b80e6e7ba4d241e1e6769087b95f\", \"blink_platform_unittests\": \"5bd90de95167c90c0b6130d9af6da21436c62e32\", \"blink_unittests\": \"6e52b0607a22117d27934f4761070d0211958174\", \"boringssl_crypto_tests\": \"0291c9a3f0b4bedf89b4088aa386fe302d83fbdd\", \"boringssl_ssl_tests\": \"84ce7724276b66c90672e89392078f47780cc58a\", \"browser_tests\": \"5e30dc057ae2a73ff2e14ab5bc593482ea453c7c\", \"capture_unittests\": \"b2e4325aeef99ff4d2980b9962bb1002faf80d91\", \"cast_unittests\": \"13f22a818164bb8845da22075898f3efd25a5135\", \"cc_unittests\": \"783667de4cdfe4cc8d90fcace2e5d14798749d5c\", \"chrome_app_unittests\": \"53ee1e02084a2da9c1f5edc6241b57fbf50301f3\", \"chromedriver_unittests\": \"228f606c83b1566c71e8a1cb02029b010de1f876\", \"chromeos_components_unittests\": \"69b7f05443489a843994abcf289229e9f4ad2816\", \"chromeos_unittests\": \"9824c39961d37aace9fb5eca4bf5794fbea7e762\", \"components_browsertests\": \"2e00457a35598cd8bdb203c3471866d108e288ba\", \"components_unittests\": \"d12858aa70706b9182c1384c5162f9f3fa76966c\", \"compositor_unittests\": \"9aa83b88611ec0ecae3f39500e2c15c370843af9\", \"content_browsertests\": \"64c8bfd8e77863a5f52c722350028771d7fe2d71\", \"content_unittests\": \"f470ecc89eef8cb47ceb2364b9ef8bbf46ff390b\", \"crashpad_tests\": \"86ce68324b08d9501bc027bf2ab401ba27d13025\", \"crypto_unittests\": \"50108c8adb669a4b5a50c98e1d7decb96441fac0\", \"dbus_unittests\": \"757cb87188d82db9f0de8e6e7a62add72f7ac2f9\", \"device_unittests\": \"1c5b47e19ff400db5923c529b18052e8b202fafc\", \"display_unittests\": \"e72b175cf1f97e9a0c44b6d2a41201b8c7b4fb5e\", \"events_unittests\": \"a91e282f20aa73bf09407ddb975430b3009c816e\", \"exo_unittests\": \"72da29091bcfdb324baa7eff7e82c7d2345f2184\", \"extensions_browsertests\": \"9a874713990574349bae77334ce2c253a6ccd3b8\", \"extensions_unittests\": \"6ff4feba456d876d931bb250eb51420453997bb2\", \"filesystem_service_unittests\": \"0b3c50cb66050ea2408842822bff1566e595087b\", \"gcm_unit_tests\": \"77754db94ed8d3270a15ffca2206fd6d028f8cd7\", \"gfx_unittests\": \"3b28197afefcf37834d2002437aba8fe3746d2c1\", \"gin_unittests\": \"df90cf1f6cf8375b775a06ee0b5ffc639b1d333f\", \"gl_unittests_ozone\": \"aa65a065125fd36c168bd8dc5a94c435bb079044\", \"google_apis_unittests\": \"a5bc07f59caed7e78d7d6e825a83dbf89129cd41\", \"gpu_unittests\": \"778a8cc0c32f459e0e57ac4cc59675370b061d63\", \"gwp_asan_unittests\": \"83e7b74d69c2b4f3d49fad729fc28adff532cce5\", \"interactive_ui_tests\": \"6526aa10fc5291643f9d44acaac3380dacd1627d\", \"ipc_tests\": \"aee7f1e86b734404f69a107696c05459e98ba927\", \"jingle_unittests\": \"d751bd3121ce876835574f8362b964a8dbb7385c\", \"keyboard_unittests\": \"ff4abd090c2e440d1eca7213400e7b3d5932c414\", \"latency_unittests\": \"b6ad9babbb451345e11e7e5687000c0682b4e750\", \"libjingle_xmpp_unittests\": \"b925c63e38bc4ffa13a056aeeb898fe085e57a72\", \"liburlpattern_unittests\": \"1af6460ff1f50e60b9784170bbaf9831ae82a690\", \"media_blink_unittests\": \"63805698c4feeb6e97aaa6259808991f1d4fb0f7\", \"media_unittests\": \"52128374c857758f8758a65e499830bc16a063d2\", \"message_center_unittests\": \"788b26fba23de68fb31a0875fdcbf3ad6ca8faf4\", \"midi_unittests\": \"58a975fc92aa6e0dc8baf5a33384edda18b8cc0a\", \"mojo_core_unittests\": \"23b465fc1a5c0d0bcfc84909a5ab692f5c002e0f\", \"mojo_unittests\": \"7d6342d4b3f7e9893c81cdcb08e3695322470315\", \"nacl_helper_nonsfi_unittests\": \"991153afdcd4a5e1c79f2ae545d125a4b83d57a9\", \"nacl_loader_unittests\": \"b78138cdfade9cf41782c793e10a7db7cb9b37f2\", \"native_theme_unittests\": \"8e48922f27833aa735a47d979a067881c98c5cec\", \"net_unittests\": \"f831b8f364ae436272ea1a65d48f1cb151d2c4a2\", \"ozone_gl_unittests\": \"c837d10dc418a0c0bd683e5a3eff56aa0c3e4fff\", \"ozone_unittests\": \"6daec4f218bd847efb69cfe699740b50c482fb5d\", \"ozone_x11_unittests\": \"eb02e13fec6d186056336ebe1d6c95a3eb057cef\", \"pdf_unittests\": \"92ca128ce1344b5f5a38f91a893196f931d04a8b\", \"perfetto_unittests\": \"77e82aee8a53bf32de800bf3b507c4a2bf00e3bc\", \"ppapi_unittests\": \"bb2406707d4fe794413bdac3b182d36c6c1668ee\", \"printing_unittests\": \"ecdbfbe777b349edff075c409aa30ddabc8b4358\", \"remoting_unittests\": \"489efef66a91db1800b931aca222b4d53af72cb8\", \"sandbox_linux_unittests\": \"701941bf8427c5c25a720254cc24c65d5a88fd05\", \"service_manager_unittests\": \"0de1822feb53d392d0fb5cc020bee053d099436c\", \"services_unittests\": \"a297a6e8bba08fcaaea6ea8ae4c8805efe336640\", \"shell_dialogs_unittests\": \"17e18916607a9e117201f17e2395bacb52625430\", \"shell_encryption_unittests\": \"2acf5534c98dd3bcf992fc0042c5f385c1eb2aac\", \"skia_unittests\": \"5806cb5007a5c9251abc7da485cac849ab4eeaf7\", \"snapshot_unittests\": \"599450a0819a274dd21e5d5a2e3bc6fb5fc07fe9\", \"sql_unittests\": \"5f0ebf5052ce7e499e9efc0644b6eafe2002d826\", \"storage_unittests\": \"5440812f0ea72bf54783635006af6b3161015c83\", \"sync_integration_tests\": \"38a6c626bbdf79480b701a7f3cff4aa0ef2b67e5\", \"traffic_annotation_auditor_unittests\": \"cee54b021ac63bfb779312b4b328d39f4f299ee8\", \"ui_base_unittests\": \"b68a3df38efa6b6cabd3a56bfbc4d61816d9dce5\", \"ui_chromeos_unittests\": \"ef8f8e84f6a56076dac3daa4651e2ea701da46ea\", \"ui_touch_selection_unittests\": \"c11c3e03809d5f68a4fc0811ff9bf1e09b3647e4\", \"unit_tests\": \"642cd0ab9aa43a0a4b904723a22914031dd8eced\", \"url_unittests\": \"979748d6c26c11abc106fd355cb0b9d7ea00a6a8\", \"usage_time_limit_unittests\": \"f8de09bd69fadc86b1c5c6e059b0ff0a0653d9f9\", \"views_unittests\": \"207d6838bcc023e30a8e9a08881fa63babd2c92c\", \"viz_unittests\": \"ffc40e80f436ddade568a53baeaf3e493a163855\", \"wm_unittests\": \"9fa5306bc6d1c49eaf796ba1e49a32730deea4de\", \"wtf_unittests\": \"5d7cc991266aa5166cf48c5074406b6528d566fd\", \"zlib_unittests\": \"4aa7b6ea083214bde03f024ba687ca8ed95476df\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_8f1f1a811acb8ac7cee91f001f34cb98db55e889611ed2a31914ce7c854c1541_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_dcef017f754690f3e0b2809d85023c2a50e42950d4504e0de4071c06ccf1a2cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-52-jqp1\"], \"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\": [\"5690-40331dd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613238967385991",
"status": "COMPLETED",
"status_changed_ts": "1613245731199621",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22612",
"builder:linux-chromeos-dbg",
"buildset:commit/git/75699cf561512dfa8d849ea8dfc33266318e1dff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/75699cf561512dfa8d849ea8dfc33266318e1dff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020822595155220160",
"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/8855392533112017584/+/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:51b5368fb9a29910",
"user_agent:luci-scheduler"
],
"updated_ts": "1613245731225390",
"url": "https://ci.chromium.org/b/8855392533112017584",
"utcnow_ts": "1613245732642873"
}
}
[19:48:52.651] Invocation finished in 2h32m12.300278445s with status SUCCEEDED