[00:23:49.372] New invocation is queued and will start shortly
[00:23:50.433] Starting the invocation (attempt 1)
[00:23:50.477] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:23:50.477] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:23:50.477] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022970048396547424",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"af6e7cadb00d01b27d4731a0c45be0220e6ef1c0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022970048396547424",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/af6e7cadb00d01b27d4731a0c45be0220e6ef1c0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6e7cadb00d01b27d4731a0c45be0220e6ef1c0",
"gitiles_ref:refs/heads/master"
]
}
[00:23:51.197] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611188630567135",
"id": "8857539986473274800",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6e7cadb00d01b27d4731a0c45be0220e6ef1c0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611188631034264",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44778",
"builder:linux-chromeos-rel",
"buildset:commit/git/af6e7cadb00d01b27d4731a0c45be0220e6ef1c0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6e7cadb00d01b27d4731a0c45be0220e6ef1c0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022970048396547424",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857539986473274800/+/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": "1611188631034443",
"url": "https://ci.chromium.org/b/8857539986473274800",
"utcnow_ts": "1611188631189868"
}
}
[00:23:51.197] Task URL: https://ci.chromium.org/b/8857539986473274800
[00:23:51.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:2:0) after 1m0s
[00:24:51.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:2:0)
[00:24:51.254] Timer tick, asking Buildbucket for the build status
[00:24:51.515] Build 8857539986473274800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:51.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:3:0) after 1m0s
[00:25:51.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:3:0)
[00:25:51.558] Timer tick, asking Buildbucket for the build status
[00:25:51.670] Build 8857539986473274800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:51.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:4:0) after 1m0s
[00:26:51.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:4:0)
[00:26:51.777] Timer tick, asking Buildbucket for the build status
[00:26:52.253] Build 8857539986473274800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:52.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:5:0) after 1m0s
[00:27:52.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:5:0)
[00:27:52.277] Timer tick, asking Buildbucket for the build status
[00:27:52.353] Build 8857539986473274800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:52.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:6:0) after 1m0s
[00:28:05.429] Received PubSub notification, asking Buildbucket for the build status
[00:28:05.627] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:52.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:6:0)
[00:28:52.459] Timer tick, asking Buildbucket for the build status
[00:28:52.692] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:52.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:8:0) after 1m0s
[00:29:52.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:8:0)
[00:29:52.710] Timer tick, asking Buildbucket for the build status
[00:29:52.788] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:52.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:9:0) after 1m0s
[00:30:52.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:9:0)
[00:30:52.904] Timer tick, asking Buildbucket for the build status
[00:30:53.043] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:53.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:10:0) after 1m0s
[00:31:53.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:10:0)
[00:31:53.115] Timer tick, asking Buildbucket for the build status
[00:31:53.246] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:53.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:11:0) after 1m0s
[00:32:53.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:11:0)
[00:32:53.351] Timer tick, asking Buildbucket for the build status
[00:32:53.470] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:53.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:12:0) after 1m0s
[00:33:53.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:12:0)
[00:33:53.568] Timer tick, asking Buildbucket for the build status
[00:33:53.653] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:53.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:13:0) after 1m0s
[00:34:53.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:13:0)
[00:34:53.757] Timer tick, asking Buildbucket for the build status
[00:34:53.861] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:53.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:14:0) after 1m0s
[00:35:54.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:14:0)
[00:35:54.272] Timer tick, asking Buildbucket for the build status
[00:35:54.357] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:54.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:15:0) after 1m0s
[00:36:54.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:15:0)
[00:36:54.371] Timer tick, asking Buildbucket for the build status
[00:36:54.446] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:54.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:16:0) after 1m0s
[00:37:54.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:16:0)
[00:37:54.677] Timer tick, asking Buildbucket for the build status
[00:37:55.621] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:55.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:17:0) after 1m0s
[00:38:55.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:17:0)
[00:38:55.654] Timer tick, asking Buildbucket for the build status
[00:38:55.813] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:55.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:18:0) after 1m0s
[00:39:55.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:18:0)
[00:39:55.895] Timer tick, asking Buildbucket for the build status
[00:39:55.975] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:55.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:19:0) after 1m0s
[00:40:56.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:19:0)
[00:40:56.128] Timer tick, asking Buildbucket for the build status
[00:40:56.186] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:56.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:20:0) after 1m0s
[00:41:56.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:20:0)
[00:41:56.318] Timer tick, asking Buildbucket for the build status
[00:41:56.384] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:21:0) after 1m0s
[00:42:56.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:21:0)
[00:42:56.562] Timer tick, asking Buildbucket for the build status
[00:42:56.726] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:56.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:22:0) after 1m0s
[00:43:56.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:22:0)
[00:43:56.786] Timer tick, asking Buildbucket for the build status
[00:43:56.882] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:56.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:23:0) after 1m0s
[00:44:56.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:23:0)
[00:44:56.938] Timer tick, asking Buildbucket for the build status
[00:44:57.272] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:57.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:24:0) after 1m0s
[00:45:57.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:24:0)
[00:45:57.321] Timer tick, asking Buildbucket for the build status
[00:45:57.582] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:57.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:25:0) after 1m0s
[00:46:57.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:25:0)
[00:46:57.665] Timer tick, asking Buildbucket for the build status
[00:46:57.790] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:57.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:26:0) after 1m0s
[00:47:57.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:26:0)
[00:47:57.789] Timer tick, asking Buildbucket for the build status
[00:47:57.890] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:57.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:27:0) after 1m0s
[00:48:57.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:27:0)
[00:48:57.922] Timer tick, asking Buildbucket for the build status
[00:48:58.129] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:58.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:28:0) after 1m0s
[00:49:58.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:28:0)
[00:49:58.177] Timer tick, asking Buildbucket for the build status
[00:49:58.398] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:58.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:29:0) after 1m0s
[00:50:58.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:29:0)
[00:50:58.451] Timer tick, asking Buildbucket for the build status
[00:50:58.548] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:58.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:30:0) after 1m0s
[00:51:58.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:30:0)
[00:51:58.537] Timer tick, asking Buildbucket for the build status
[00:51:58.598] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:31:0) after 1m0s
[00:52:58.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:31:0)
[00:52:58.900] Timer tick, asking Buildbucket for the build status
[00:52:59.202] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:59.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:32:0) after 1m0s
[00:53:59.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:32:0)
[00:53:59.346] Timer tick, asking Buildbucket for the build status
[00:53:59.431] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:59.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:33:0) after 1m0s
[00:54:59.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:33:0)
[00:54:59.616] Timer tick, asking Buildbucket for the build status
[00:54:59.678] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:59.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:34:0) after 1m0s
[00:55:59.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:34:0)
[00:55:59.905] Timer tick, asking Buildbucket for the build status
[00:56:00.139] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:00.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:35:0) after 1m0s
[00:57:00.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:35:0)
[00:57:00.147] Timer tick, asking Buildbucket for the build status
[00:57:00.290] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:00.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:36:0) after 1m0s
[00:58:00.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:36:0)
[00:58:00.652] Timer tick, asking Buildbucket for the build status
[00:58:00.875] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:00.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:37:0) after 1m0s
[00:59:00.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:37:0)
[00:59:00.968] Timer tick, asking Buildbucket for the build status
[00:59:01.227] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:01.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:38:0) after 1m0s
[01:00:01.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:38:0)
[01:00:01.628] Timer tick, asking Buildbucket for the build status
[01:00:01.726] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:01.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:39:0) after 1m0s
[01:01:01.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:39:0)
[01:01:01.751] Timer tick, asking Buildbucket for the build status
[01:01:01.826] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:01.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:40:0) after 1m0s
[01:02:02.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:40:0)
[01:02:02.221] Timer tick, asking Buildbucket for the build status
[01:02:02.311] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:02.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:41:0) after 1m0s
[01:03:02.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:41:0)
[01:03:02.697] Timer tick, asking Buildbucket for the build status
[01:03:02.965] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:02.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:42:0) after 1m0s
[01:04:03.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:42:0)
[01:04:03.114] Timer tick, asking Buildbucket for the build status
[01:04:03.227] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:03.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:43:0) after 1m0s
[01:05:03.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:43:0)
[01:05:03.353] Timer tick, asking Buildbucket for the build status
[01:05:04.189] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:04.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:44:0) after 1m0s
[01:06:04.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:44:0)
[01:06:04.310] Timer tick, asking Buildbucket for the build status
[01:06:04.399] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:04.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:45:0) after 1m0s
[01:07:04.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:45:0)
[01:07:04.473] Timer tick, asking Buildbucket for the build status
[01:07:04.573] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:04.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:46:0) after 1m0s
[01:08:04.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:46:0)
[01:08:04.572] Timer tick, asking Buildbucket for the build status
[01:08:04.695] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:04.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:47:0) after 1m0s
[01:09:04.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:47:0)
[01:09:04.731] Timer tick, asking Buildbucket for the build status
[01:09:05.029] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:05.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:48:0) after 1m0s
[01:10:05.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:48:0)
[01:10:05.055] Timer tick, asking Buildbucket for the build status
[01:10:05.297] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:05.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:49:0) after 1m0s
[01:11:05.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:49:0)
[01:11:05.371] Timer tick, asking Buildbucket for the build status
[01:11:05.644] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:05.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:50:0) after 1m0s
[01:12:05.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:50:0)
[01:12:05.715] Timer tick, asking Buildbucket for the build status
[01:12:05.895] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:05.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:51:0) after 1m0s
[01:13:06.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:51:0)
[01:13:06.069] Timer tick, asking Buildbucket for the build status
[01:13:06.136] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:06.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:52:0) after 1m0s
[01:14:06.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:52:0)
[01:14:06.207] Timer tick, asking Buildbucket for the build status
[01:14:06.379] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:53:0) after 1m0s
[01:15:06.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:53:0)
[01:15:06.540] Timer tick, asking Buildbucket for the build status
[01:15:06.718] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:54:0) after 1m0s
[01:16:06.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:54:0)
[01:16:06.799] Timer tick, asking Buildbucket for the build status
[01:16:06.902] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:55:0) after 1m0s
[01:17:07.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:55:0)
[01:17:07.003] Timer tick, asking Buildbucket for the build status
[01:17:07.088] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:07.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:56:0) after 1m0s
[01:18:07.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:56:0)
[01:18:07.223] Timer tick, asking Buildbucket for the build status
[01:18:07.819] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:57:0) after 1m0s
[01:19:07.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:57:0)
[01:19:07.980] Timer tick, asking Buildbucket for the build status
[01:19:08.129] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:08.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:58:0) after 1m0s
[01:20:08.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:58:0)
[01:20:08.174] Timer tick, asking Buildbucket for the build status
[01:20:08.513] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:08.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:59:0) after 1m0s
[01:21:08.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:59:0)
[01:21:08.614] Timer tick, asking Buildbucket for the build status
[01:21:08.681] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:60:0) after 1m0s
[01:22:08.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:60:0)
[01:22:08.775] Timer tick, asking Buildbucket for the build status
[01:22:08.845] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:61:0) after 1m0s
[01:23:08.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:61:0)
[01:23:08.935] Timer tick, asking Buildbucket for the build status
[01:23:09.180] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:09.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:62:0) after 1m0s
[01:24:09.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:62:0)
[01:24:09.289] Timer tick, asking Buildbucket for the build status
[01:24:09.401] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:09.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:63:0) after 1m0s
[01:25:09.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:63:0)
[01:25:09.558] Timer tick, asking Buildbucket for the build status
[01:25:09.627] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:09.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:64:0) after 1m0s
[01:26:09.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:64:0)
[01:26:09.777] Timer tick, asking Buildbucket for the build status
[01:26:09.855] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:09.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:65:0) after 1m0s
[01:27:09.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:65:0)
[01:27:09.969] Timer tick, asking Buildbucket for the build status
[01:27:10.035] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:66:0) after 1m0s
[01:28:10.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:66:0)
[01:28:10.105] Timer tick, asking Buildbucket for the build status
[01:28:10.229] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:10.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:67:0) after 1m0s
[01:29:10.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:67:0)
[01:29:10.314] Timer tick, asking Buildbucket for the build status
[01:29:10.664] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:10.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:68:0) after 1m0s
[01:30:10.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:68:0)
[01:30:10.792] Timer tick, asking Buildbucket for the build status
[01:30:10.870] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:10.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:69:0) after 1m0s
[01:31:10.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:69:0)
[01:31:10.887] Timer tick, asking Buildbucket for the build status
[01:31:10.966] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:10.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:70:0) after 1m0s
[01:32:11.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:70:0)
[01:32:11.043] Timer tick, asking Buildbucket for the build status
[01:32:11.113] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:11.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:71:0) after 1m0s
[01:33:11.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:71:0)
[01:33:11.155] Timer tick, asking Buildbucket for the build status
[01:33:11.382] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:72:0) after 1m0s
[01:34:11.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:72:0)
[01:34:11.478] Timer tick, asking Buildbucket for the build status
[01:34:11.682] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:11.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:73:0) after 1m0s
[01:35:11.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:73:0)
[01:35:11.690] Timer tick, asking Buildbucket for the build status
[01:35:11.906] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:11.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:74:0) after 1m0s
[01:36:11.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:74:0)
[01:36:11.920] Timer tick, asking Buildbucket for the build status
[01:36:11.989] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:11.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:75:0) after 1m0s
[01:37:12.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:75:0)
[01:37:12.015] Timer tick, asking Buildbucket for the build status
[01:37:12.086] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:12.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:76:0) after 1m0s
[01:38:12.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:76:0)
[01:38:12.162] Timer tick, asking Buildbucket for the build status
[01:38:12.285] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:12.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:77:0) after 1m0s
[01:39:12.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:77:0)
[01:39:12.361] Timer tick, asking Buildbucket for the build status
[01:39:12.732] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:12.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:78:0) after 1m0s
[01:40:12.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:78:0)
[01:40:12.772] Timer tick, asking Buildbucket for the build status
[01:40:12.895] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:12.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:79:0) after 1m0s
[01:41:12.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:79:0)
[01:41:12.952] Timer tick, asking Buildbucket for the build status
[01:41:13.037] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:13.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:80:0) after 1m0s
[01:42:13.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:80:0)
[01:42:13.077] Timer tick, asking Buildbucket for the build status
[01:42:13.232] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:13.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:81:0) after 1m0s
[01:43:13.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:81:0)
[01:43:13.276] Timer tick, asking Buildbucket for the build status
[01:43:13.558] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:13.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:82:0) after 1m0s
[01:44:13.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:82:0)
[01:44:13.543] Timer tick, asking Buildbucket for the build status
[01:44:14.095] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:14.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:83:0) after 1m0s
[01:45:14.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:83:0)
[01:45:14.149] Timer tick, asking Buildbucket for the build status
[01:45:14.273] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:14.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:84:0) after 1m0s
[01:46:14.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:84:0)
[01:46:14.337] Timer tick, asking Buildbucket for the build status
[01:46:14.449] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:14.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:85:0) after 1m0s
[01:47:14.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:85:0)
[01:47:14.484] Timer tick, asking Buildbucket for the build status
[01:47:14.631] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:14.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:86:0) after 1m0s
[01:48:14.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:86:0)
[01:48:14.744] Timer tick, asking Buildbucket for the build status
[01:48:14.817] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:14.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:87:0) after 1m0s
[01:49:14.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:87:0)
[01:49:14.863] Timer tick, asking Buildbucket for the build status
[01:49:15.251] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:15.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:88:0) after 1m0s
[01:50:15.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:88:0)
[01:50:15.287] Timer tick, asking Buildbucket for the build status
[01:50:15.836] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:15.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:89:0) after 1m0s
[01:51:15.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:89:0)
[01:51:15.954] Timer tick, asking Buildbucket for the build status
[01:51:16.206] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:16.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:90:0) after 1m0s
[01:52:16.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:90:0)
[01:52:16.228] Timer tick, asking Buildbucket for the build status
[01:52:16.618] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:16.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:91:0) after 1m0s
[01:53:16.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:91:0)
[01:53:16.646] Timer tick, asking Buildbucket for the build status
[01:53:16.815] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:16.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:92:0) after 1m0s
[01:54:16.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:92:0)
[01:54:16.828] Timer tick, asking Buildbucket for the build status
[01:54:16.958] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:16.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:93:0) after 1m0s
[01:55:17.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:93:0)
[01:55:17.156] Timer tick, asking Buildbucket for the build status
[01:55:17.358] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:17.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:94:0) after 1m0s
[01:56:17.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:94:0)
[01:56:17.391] Timer tick, asking Buildbucket for the build status
[01:56:17.510] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:17.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:95:0) after 1m0s
[01:57:17.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:95:0)
[01:57:17.617] Timer tick, asking Buildbucket for the build status
[01:57:17.729] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:17.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:96:0) after 1m0s
[01:58:17.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:96:0)
[01:58:17.806] Timer tick, asking Buildbucket for the build status
[01:58:17.981] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:17.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:97:0) after 1m0s
[01:59:18.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:97:0)
[01:59:18.103] Timer tick, asking Buildbucket for the build status
[01:59:18.333] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:18.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:98:0) after 1m0s
[02:00:18.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:98:0)
[02:00:18.375] Timer tick, asking Buildbucket for the build status
[02:00:19.043] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:19.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:99:0) after 1m0s
[02:01:19.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:99:0)
[02:01:19.116] Timer tick, asking Buildbucket for the build status
[02:01:19.230] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:19.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:100:0) after 1m0s
[02:02:19.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:100:0)
[02:02:19.330] Timer tick, asking Buildbucket for the build status
[02:02:20.078] Build 8857539986473274800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:20.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022970048396547424:101:0) after 1m0s
[02:02:31.767] Received PubSub notification, asking Buildbucket for the build status
[02:02:31.834] Build 8857539986473274800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:02:31.834] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611194544801577",
"created_by": "project:chromium",
"created_ts": "1611188630567135",
"id": "8857539986473274800",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6e7cadb00d01b27d4731a0c45be0220e6ef1c0\"}}",
"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\": \"af6e7cadb00d01b27d4731a0c45be0220e6ef1c0\", \"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-19-97nl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44778, \"got_angle_revision\": \"ea71c6b63417af438afaf26a886b03621d85f14f\", \"got_dawn_revision\": \"064f33e4416ed498c91137f518fedb56c325b99b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"af6e7cadb00d01b27d4731a0c45be0220e6ef1c0\", \"got_revision_cp\": \"refs/heads/master@{#845425}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"1d681a1a9f5b66ce7c18d756f80e1c3afab911d5\", \"got_v8_revision_cp\": \"refs/heads/9.0.28@{#1}\", \"got_webrtc_revision\": \"0be1846477949c472a7a2bf42134a7bb08570ac4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33046}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6e7cadb00d01b27d4731a0c45be0220e6ef1c0\", \"swarm_hashes_refs/heads/master(at){#845425}_without_patch\": {\"absl_hardening_tests\": \"39a9ad978d1ee8583c55041a581691ed9e6b7a48\", \"accessibility_unittests\": \"c13796c790f767ecc74e4510f42bd551be142956\", \"angle_unittests\": \"6a8d7868e63c77f591222b80ac39d416dbbf86dc\", \"app_list_unittests\": \"2071d892bdcd8da3271179665b619204e2876c3e\", \"app_shell_unittests\": \"07dfca16f3896e53609c91e2fd30914c85c02c45\", \"ash_unittests\": \"e2aa14a9d7f951d13211d451cb07294e85933f94\", \"aura_unittests\": \"8d81fe450b181e6478ee3d04b3b5434eb99a292c\", \"base_unittests\": \"e5e7317f4b6850abaa7bc4a38e6ddfe03609d724\", \"base_util_unittests\": \"244330cf4f0460d70ebd4a5c17139987b8018a1d\", \"blink_common_unittests\": \"3db726e3d8e314ba792becf4a17f04d0c020f6ac\", \"blink_fuzzer_unittests\": \"07a08b3b31ae1cf57c742b7e5a87eb76e66f2bed\", \"blink_heap_unittests\": \"a8c36ca729120d0cbdaad4ed5e2df1769741be24\", \"blink_platform_unittests\": \"ea06a0694ea4843151f34f7ddcdbc33d2aebf6cc\", \"blink_unittests\": \"c148c5cae437839a9629c773caaa2c6c8567dfe8\", \"boringssl_crypto_tests\": \"23e71fe9df9b8501f2752a0243736db6fb60deb9\", \"boringssl_ssl_tests\": \"051e74b38d79dbb5b2f659552773ee24864f0dd5\", \"browser_tests\": \"9cf8c9e3b7be6b70104af8d740e01330a98aa5e7\", \"capture_unittests\": \"55e2e34d84e5d019799870623e28dee41f57f7c1\", \"cast_unittests\": \"3171c8a73d3fc431b874adc8e68b7ca6ea07482a\", \"cc_unittests\": \"a2a4269ed024ac3ed5481e3dd04b1d1e6bfcc7f1\", \"chrome_app_unittests\": \"895644bf9265f5b42e26ffbf046fe6bc6a78cca1\", \"chromedriver_unittests\": \"32cbc8b6879399ae139fb4d029da529f2e7ed0a9\", \"chromeos_components_unittests\": \"baa6349b5a5b6ad3e0f780b98576a344427c5216\", \"chromeos_unittests\": \"944bc70f75de4c332a113141b6b6d7628a2e5262\", \"components_browsertests\": \"fda4706e4b90e9a6d69720e08db5780c1719d8b0\", \"components_unittests\": \"d1274dd28f128b40ecbfe7b49f95d94590ac915c\", \"compositor_unittests\": \"7f84aa19f84ae0d7aff3c5e2043e3b2558e7e2e3\", \"content_browsertests\": \"171207b021b7aed790ad3ccebb2d6ca2907daf6d\", \"content_unittests\": \"922926de455d1d25634088679765cf65dd3d09f5\", \"crashpad_tests\": \"f243ea2e851509b852e45c81695dd8ba7da53b56\", \"crypto_unittests\": \"728a70a8e91f911cdda7361f067b8e3aa4678986\", \"dbus_unittests\": \"d9235e0c1bb5bd6e96a6668fc886c69f5530674e\", \"device_unittests\": \"d4ff4ce2b7fdce04bf8e842971fd426298c2386f\", \"display_unittests\": \"a8be936df1f9b75b79008301c76b3d1a4ebef3e6\", \"events_unittests\": \"8ec33e9ba7f988031b6f1c212ba5ffd389836a3f\", \"exo_unittests\": \"0afac9b923f6658157a8bf60c1cf49002713ccf7\", \"extensions_browsertests\": \"4ce0f085ddb04519e41d1390ded1773ce16f81a0\", \"extensions_unittests\": \"363dd4b0cfc39e3a8022c36c852da53d76d37f8c\", \"filesystem_service_unittests\": \"98b7ac2be6606684f98cb829094c5f1c7a434768\", \"gcm_unit_tests\": \"ae882885c4b683879d3898325c9aa4af9652a547\", \"gfx_unittests\": \"cc8ad6a1d052daac736bd262d591ba9bf5498176\", \"gin_unittests\": \"555ada4edba78533d0da242e6101cdd26dfd8f93\", \"gl_unittests_ozone\": \"687da295d2bff66f23da95dd94439d79b2cfa5d0\", \"google_apis_unittests\": \"388dc533902c88624ec4b0239dacba98cb674179\", \"gpu_unittests\": \"2fccd606759009efb14d496c944ea51c0142529c\", \"gwp_asan_unittests\": \"822cc5a7d1e79601c087333ac76bcdf37029a2b0\", \"interactive_ui_tests\": \"a2efcd0d07090cadf67047641531c14592b47ccd\", \"ipc_tests\": \"0bcf942c383a4d41d2040159c95b329426a582bd\", \"jingle_unittests\": \"2c888063760c3d7cee275f1464d63039e0a4f3fe\", \"keyboard_unittests\": \"c10064dfe87402a28ec62c2ad95638d4dec879db\", \"latency_unittests\": \"d9eb48b4ce01414c789313da9aff211725656655\", \"libjingle_xmpp_unittests\": \"1ce110ed923a0b9f064317b60950dee215509f09\", \"liburlpattern_unittests\": \"8c58b74104dc019917bde000cd40310954a87629\", \"media_blink_unittests\": \"c5d4d5bd88462129fdedffe261a929e89f2790d0\", \"media_unittests\": \"d0db0aafbb597694b6c2d885ac8c7430f8d35a38\", \"message_center_unittests\": \"e2a7576cfcd08fb0ceb938e9923d2831e4a431b0\", \"midi_unittests\": \"044586b2e0549e56e0fbdcf791d099db578a9aec\", \"mojo_core_unittests\": \"5699b902e3eaaa310a0cfcabecc35f545de76c9f\", \"mojo_unittests\": \"5daff2c1ea4fe1b5fc177ffb3d27d6f4a08798ad\", \"nacl_helper_nonsfi_unittests\": \"193e237b4987101df9864480ff82fb6daf77dd28\", \"nacl_loader_unittests\": \"9d8ba1d853348ec85513b400e98f111ad48d7b98\", \"native_theme_unittests\": \"4e9ee7fa24f4074f838d8f4691d177b3d095d234\", \"net_unittests\": \"4a43e100a2333412d1ca68699452df5a56a18a39\", \"ozone_gl_unittests\": \"400111766e8a1c70c18ea91f586db037631534d9\", \"ozone_unittests\": \"811ecb95e218bcf119aafb5eb3437b8ca3fea4b9\", \"ozone_x11_unittests\": \"dc0433e0df0051b985783d096cc58bf6d764f0e1\", \"pdf_unittests\": \"0f6ab850d0243a01ea812d872e95d18dd7391fe0\", \"perfetto_unittests\": \"a775cf6e89377a58e304b2ff6b4b8c3f0e3db803\", \"ppapi_unittests\": \"1359b9eb3926aa1298985837f86a0e175b666367\", \"printing_unittests\": \"217df217516c87c016d5169a892d9c182c9c6f49\", \"remoting_unittests\": \"421d7bba38d71979f41179547a203ae830dcb87d\", \"sandbox_linux_unittests\": \"f01291b519d1f5788356ecbc160e702bb84a8e37\", \"service_manager_unittests\": \"914be5f61a2bf4de1077a0a8fb6cd1329744d67f\", \"services_unittests\": \"29eeaca8eadad59329e27a35627a109dc7818218\", \"shell_dialogs_unittests\": \"43c62e58353ee4cbffb9d794605a87d4b2e1db11\", \"shell_encryption_unittests\": \"98692c9ce9dc40aa8fb40b6a1ee65dd6650b6043\", \"skia_unittests\": \"fb9ab6450352ff426d766405e89a60c821d5d0b8\", \"snapshot_unittests\": \"a6e77f321d263eaeffe02e15d1002de80cd2a966\", \"sql_unittests\": \"324ab32efdd7a7e5a0d1a8c78ea5e2acb6d953b9\", \"storage_unittests\": \"dc1a9538faf49425371f18ade7e539181b873aaf\", \"sync_integration_tests\": \"965692fb70cf1e662a39e3867a2ad04b9e5ff2c3\", \"traffic_annotation_auditor_unittests\": \"ffeb8528d6e97007399bc89b2d1de0e623b60233\", \"ui_base_unittests\": \"8edc3af8c28daac0a5bb4162eeca3b0d51394ed7\", \"ui_chromeos_unittests\": \"2d41104cc469b7090e8801bd0df8cbadb0dfcbe3\", \"ui_touch_selection_unittests\": \"d0226a88c35e0ac277464220750b0e3a65220e5f\", \"unit_tests\": \"7daea94920e02a90f2250233c81e5d9b38c7d598\", \"url_unittests\": \"16290403628a89894149515ff8b0c2067bb81cdd\", \"usage_time_limit_unittests\": \"e1bbeea932b58839ef9eb7c7a60088bd42c92678\", \"views_unittests\": \"5248a83cd088babf88783383c8f6bc99f1aa0347\", \"viz_unittests\": \"aceef5b2c456afa6e5e72dac2bead43c9230f8d4\", \"wayland_client_perftests\": \"734487fc9b888245edb1e1af4062e4f47276bea0\", \"wm_unittests\": \"883a86fe53ec0e7ab326fd3c5a2165270dc7a5fc\", \"wtf_unittests\": \"a1e7aa85b99342b2ed87407eada4702ad089331b\", \"zlib_unittests\": \"544d6db82a6d267d44744c6e8780ea8cf3f760d6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_13c9e4757ca6a1772742c665222564667630a6453df92e57dfb1ace791cbcc32_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_de6b7a4556553e5c716563e6aa155a105cc4f0b63061ff921cc2886efab12e23_v2\", \"builder_f182280557a3f6192de87a46aec9fb10feda9518a8c19d9f2a315c031f4a8a52_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-19-97nl\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611188884412078",
"status": "COMPLETED",
"status_changed_ts": "1611194545329555",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44778",
"builder:linux-chromeos-rel",
"buildset:commit/git/af6e7cadb00d01b27d4731a0c45be0220e6ef1c0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6e7cadb00d01b27d4731a0c45be0220e6ef1c0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022970048396547424",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857539986473274800/+/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:513b24ffd03be110",
"user_agent:luci-scheduler"
],
"updated_ts": "1611194545334576",
"url": "https://ci.chromium.org/b/8857539986473274800",
"utcnow_ts": "1611194551825641"
}
}
[02:02:31.834] Invocation finished in 1h38m42.48504575s with status SUCCEEDED