[04:10:51.659] New invocation is queued and will start shortly
[04:10:52.728] Starting the invocation (attempt 1)
[04:10:52.759] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:10:52.763] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:10:52.763] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018788303928854032",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b344c194f2ba74766fd725c8b2ca48d4e5ff12a7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9018788303928854032",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/b344c194f2ba74766fd725c8b2ca48d4e5ff12a7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b344c194f2ba74766fd725c8b2ca48d4e5ff12a7",
"gitiles_ref:refs/heads/master"
]
}
[04:10:53.411] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1615176652867696",
"id": "8853358242001294224",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b344c194f2ba74766fd725c8b2ca48d4e5ff12a7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615176653301073",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8156",
"builder:android-bfcache-rel",
"buildset:commit/git/b344c194f2ba74766fd725c8b2ca48d4e5ff12a7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b344c194f2ba74766fd725c8b2ca48d4e5ff12a7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018788303928854032",
"scheduler_job_id:chromium/android-bfcache-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853358242001294224/+/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": "1615176653301189",
"url": "https://ci.chromium.org/b/8853358242001294224",
"utcnow_ts": "1615176653404815"
}
}
[04:10:53.411] Task URL: https://ci.chromium.org/b/8853358242001294224
[04:10:53.411] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:2:0) after 1m0s
[04:11:53.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:2:0)
[04:11:53.525] Timer tick, asking Buildbucket for the build status
[04:11:53.589] Build 8853358242001294224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:53.589] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:3:0) after 1m0s
[04:12:53.713] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:3:0)
[04:12:53.714] Timer tick, asking Buildbucket for the build status
[04:12:53.775] Build 8853358242001294224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:53.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:4:0) after 1m0s
[04:13:53.823] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:4:0)
[04:13:53.823] Timer tick, asking Buildbucket for the build status
[04:13:53.883] Build 8853358242001294224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:53.883] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:5:0) after 1m0s
[04:14:53.916] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:5:0)
[04:14:53.916] Timer tick, asking Buildbucket for the build status
[04:14:53.981] Build 8853358242001294224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:53.981] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:6:0) after 1m0s
[04:15:02.914] Received PubSub notification, asking Buildbucket for the build status
[04:15:03.006] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:53.995] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:6:0)
[04:15:53.995] Timer tick, asking Buildbucket for the build status
[04:15:54.102] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:54.102] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:8:0) after 1m0s
[04:16:54.120] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:8:0)
[04:16:54.120] Timer tick, asking Buildbucket for the build status
[04:16:54.200] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:54.200] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:9:0) after 1m0s
[04:17:54.305] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:9:0)
[04:17:54.305] Timer tick, asking Buildbucket for the build status
[04:17:54.377] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:54.377] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:10:0) after 1m0s
[04:18:54.383] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:10:0)
[04:18:54.383] Timer tick, asking Buildbucket for the build status
[04:18:54.452] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:54.452] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:11:0) after 1m0s
[04:19:54.470] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:11:0)
[04:19:54.470] Timer tick, asking Buildbucket for the build status
[04:19:54.549] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:54.549] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:12:0) after 1m0s
[04:21:01.904] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:12:0)
[04:21:01.904] Timer tick, asking Buildbucket for the build status
[04:21:01.973] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:01.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:13:0) after 1m0s
[04:22:02.721] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:13:0)
[04:22:02.721] Timer tick, asking Buildbucket for the build status
[04:22:02.834] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:02.834] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:14:0) after 1m0s
[04:23:03.502] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:14:0)
[04:23:03.502] Timer tick, asking Buildbucket for the build status
[04:23:03.566] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:03.566] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:15:0) after 1m0s
[04:24:03.741] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:15:0)
[04:24:03.741] Timer tick, asking Buildbucket for the build status
[04:24:03.835] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:03.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:16:0) after 1m0s
[04:25:03.861] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:16:0)
[04:25:03.861] Timer tick, asking Buildbucket for the build status
[04:25:04.154] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:04.154] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:17:0) after 1m0s
[04:26:04.134] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:17:0)
[04:26:04.134] Timer tick, asking Buildbucket for the build status
[04:26:04.238] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:04.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:18:0) after 1m0s
[04:27:04.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:18:0)
[04:27:04.294] Timer tick, asking Buildbucket for the build status
[04:27:04.436] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:04.436] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:19:0) after 1m0s
[04:28:04.504] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:19:0)
[04:28:04.504] Timer tick, asking Buildbucket for the build status
[04:28:04.583] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:04.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:20:0) after 1m0s
[04:29:04.615] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:20:0)
[04:29:04.615] Timer tick, asking Buildbucket for the build status
[04:29:04.667] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:04.667] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:21:0) after 1m0s
[04:30:04.727] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:21:0)
[04:30:04.727] Timer tick, asking Buildbucket for the build status
[04:30:04.805] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:04.805] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:22:0) after 1m0s
[04:31:05.292] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:22:0)
[04:31:05.292] Timer tick, asking Buildbucket for the build status
[04:31:05.367] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:05.367] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:23:0) after 1m0s
[04:32:05.364] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:23:0)
[04:32:05.364] Timer tick, asking Buildbucket for the build status
[04:32:05.431] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:05.431] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:24:0) after 1m0s
[04:33:05.636] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:24:0)
[04:33:05.636] Timer tick, asking Buildbucket for the build status
[04:33:05.776] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:05.776] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:25:0) after 1m0s
[04:34:05.744] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:25:0)
[04:34:05.744] Timer tick, asking Buildbucket for the build status
[04:34:05.815] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:05.815] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:26:0) after 1m0s
[04:35:05.841] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:26:0)
[04:35:05.841] Timer tick, asking Buildbucket for the build status
[04:35:05.912] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:05.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:27:0) after 1m0s
[04:36:05.909] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:27:0)
[04:36:05.909] Timer tick, asking Buildbucket for the build status
[04:36:06.055] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:06.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:28:0) after 1m0s
[04:37:06.082] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:28:0)
[04:37:06.083] Timer tick, asking Buildbucket for the build status
[04:37:06.222] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:06.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:29:0) after 1m0s
[04:38:06.277] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:29:0)
[04:38:06.277] Timer tick, asking Buildbucket for the build status
[04:38:06.354] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:06.354] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:30:0) after 1m0s
[04:39:06.750] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:30:0)
[04:39:06.750] Timer tick, asking Buildbucket for the build status
[04:39:06.811] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:06.811] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:31:0) after 1m0s
[04:40:06.875] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:31:0)
[04:40:06.875] Timer tick, asking Buildbucket for the build status
[04:40:06.951] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:06.951] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:32:0) after 1m0s
[04:41:06.973] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:32:0)
[04:41:06.973] Timer tick, asking Buildbucket for the build status
[04:41:07.208] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:07.208] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:33:0) after 1m0s
[04:42:07.225] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:33:0)
[04:42:07.225] Timer tick, asking Buildbucket for the build status
[04:42:07.303] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:07.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:34:0) after 1m0s
[04:43:07.432] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:34:0)
[04:43:07.432] Timer tick, asking Buildbucket for the build status
[04:43:07.497] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:07.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:35:0) after 1m0s
[04:44:07.531] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:35:0)
[04:44:07.531] Timer tick, asking Buildbucket for the build status
[04:44:07.621] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:07.621] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:36:0) after 1m0s
[04:45:07.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:36:0)
[04:45:07.638] Timer tick, asking Buildbucket for the build status
[04:45:07.845] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:07.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:37:0) after 1m0s
[04:46:07.931] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:37:0)
[04:46:07.931] Timer tick, asking Buildbucket for the build status
[04:46:08.006] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:08.006] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:38:0) after 1m0s
[04:47:08.219] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:38:0)
[04:47:08.219] Timer tick, asking Buildbucket for the build status
[04:47:08.289] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:08.289] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:39:0) after 1m0s
[04:48:08.319] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:39:0)
[04:48:08.319] Timer tick, asking Buildbucket for the build status
[04:48:08.506] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:08.506] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:40:0) after 1m0s
[04:49:08.601] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:40:0)
[04:49:08.601] Timer tick, asking Buildbucket for the build status
[04:49:08.790] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:08.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:41:0) after 1m0s
[04:50:08.809] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:41:0)
[04:50:08.809] Timer tick, asking Buildbucket for the build status
[04:50:08.884] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:08.884] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:42:0) after 1m0s
[04:51:09.131] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:42:0)
[04:51:09.131] Timer tick, asking Buildbucket for the build status
[04:51:09.207] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:09.207] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:43:0) after 1m0s
[04:52:09.239] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:43:0)
[04:52:09.239] Timer tick, asking Buildbucket for the build status
[04:52:09.319] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:09.319] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:44:0) after 1m0s
[04:53:09.366] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:44:0)
[04:53:09.366] Timer tick, asking Buildbucket for the build status
[04:53:09.429] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:09.429] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:45:0) after 1m0s
[04:54:09.489] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:45:0)
[04:54:09.489] Timer tick, asking Buildbucket for the build status
[04:54:09.813] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:09.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:46:0) after 1m0s
[04:55:10.031] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:46:0)
[04:55:10.031] Timer tick, asking Buildbucket for the build status
[04:55:10.096] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:10.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:47:0) after 1m0s
[04:56:10.582] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:47:0)
[04:56:10.582] Timer tick, asking Buildbucket for the build status
[04:56:10.684] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:10.684] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:48:0) after 1m0s
[04:57:10.739] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:48:0)
[04:57:10.739] Timer tick, asking Buildbucket for the build status
[04:57:10.809] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:10.809] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:49:0) after 1m0s
[04:58:10.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:49:0)
[04:58:10.832] Timer tick, asking Buildbucket for the build status
[04:58:10.895] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:10.895] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:50:0) after 1m0s
[04:59:10.942] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:50:0)
[04:59:10.942] Timer tick, asking Buildbucket for the build status
[04:59:11.044] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:11.044] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:51:0) after 1m0s
[05:00:11.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:51:0)
[05:00:11.049] Timer tick, asking Buildbucket for the build status
[05:00:11.117] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:11.117] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:52:0) after 1m0s
[05:01:11.140] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:52:0)
[05:01:11.140] Timer tick, asking Buildbucket for the build status
[05:01:11.710] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:11.710] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:53:0) after 1m0s
[05:02:11.759] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:53:0)
[05:02:11.760] Timer tick, asking Buildbucket for the build status
[05:02:11.931] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:11.931] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:54:0) after 1m0s
[05:03:11.962] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:54:0)
[05:03:11.962] Timer tick, asking Buildbucket for the build status
[05:03:12.048] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:12.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:55:0) after 1m0s
[05:04:12.065] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:55:0)
[05:04:12.065] Timer tick, asking Buildbucket for the build status
[05:04:12.217] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:12.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:56:0) after 1m0s
[05:05:12.244] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:56:0)
[05:05:12.244] Timer tick, asking Buildbucket for the build status
[05:05:12.431] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:12.431] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:57:0) after 1m0s
[05:06:12.485] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:57:0)
[05:06:12.485] Timer tick, asking Buildbucket for the build status
[05:06:12.720] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:12.720] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:58:0) after 1m0s
[05:07:12.783] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:58:0)
[05:07:12.783] Timer tick, asking Buildbucket for the build status
[05:07:12.846] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:12.846] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:59:0) after 1m0s
[05:08:12.953] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:59:0)
[05:08:12.953] Timer tick, asking Buildbucket for the build status
[05:08:13.124] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:13.124] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:60:0) after 1m0s
[05:09:13.142] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:60:0)
[05:09:13.142] Timer tick, asking Buildbucket for the build status
[05:09:13.821] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:13.821] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:61:0) after 1m0s
[05:10:13.825] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:61:0)
[05:10:13.825] Timer tick, asking Buildbucket for the build status
[05:10:14.138] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:14.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:62:0) after 1m0s
[05:11:14.213] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:62:0)
[05:11:14.213] Timer tick, asking Buildbucket for the build status
[05:11:14.344] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:14.344] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:63:0) after 1m0s
[05:12:14.416] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:63:0)
[05:12:14.416] Timer tick, asking Buildbucket for the build status
[05:12:14.484] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:14.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:64:0) after 1m0s
[05:13:14.538] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:64:0)
[05:13:14.539] Timer tick, asking Buildbucket for the build status
[05:13:14.618] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:14.618] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:65:0) after 1m0s
[05:14:14.633] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:65:0)
[05:14:14.633] Timer tick, asking Buildbucket for the build status
[05:14:14.699] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:14.699] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:66:0) after 1m0s
[05:15:14.725] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:66:0)
[05:15:14.725] Timer tick, asking Buildbucket for the build status
[05:15:14.933] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:14.933] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:67:0) after 1m0s
[05:16:14.966] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:67:0)
[05:16:14.966] Timer tick, asking Buildbucket for the build status
[05:16:15.403] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:15.403] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:68:0) after 1m0s
[05:17:15.423] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:68:0)
[05:17:15.423] Timer tick, asking Buildbucket for the build status
[05:17:15.505] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:15.505] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:69:0) after 1m0s
[05:18:15.527] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:69:0)
[05:18:15.527] Timer tick, asking Buildbucket for the build status
[05:18:15.592] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:15.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:70:0) after 1m0s
[05:19:15.608] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:70:0)
[05:19:15.608] Timer tick, asking Buildbucket for the build status
[05:19:15.730] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:15.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:71:0) after 1m0s
[05:20:15.800] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:71:0)
[05:20:15.800] Timer tick, asking Buildbucket for the build status
[05:20:15.865] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:15.865] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:72:0) after 1m0s
[05:21:15.910] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:72:0)
[05:21:15.910] Timer tick, asking Buildbucket for the build status
[05:21:16.062] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:16.062] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:73:0) after 1m0s
[05:22:16.072] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:73:0)
[05:22:16.072] Timer tick, asking Buildbucket for the build status
[05:22:16.182] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:16.182] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:74:0) after 1m0s
[05:23:16.236] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:74:0)
[05:23:16.236] Timer tick, asking Buildbucket for the build status
[05:23:16.308] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:16.308] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:75:0) after 1m0s
[05:24:16.327] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:75:0)
[05:24:16.327] Timer tick, asking Buildbucket for the build status
[05:24:16.453] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:16.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:76:0) after 1m0s
[05:25:16.526] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:76:0)
[05:25:16.526] Timer tick, asking Buildbucket for the build status
[05:25:16.584] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:16.584] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:77:0) after 1m0s
[05:26:16.635] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:77:0)
[05:26:16.635] Timer tick, asking Buildbucket for the build status
[05:26:16.950] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:16.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:78:0) after 1m0s
[05:27:17.013] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:78:0)
[05:27:17.013] Timer tick, asking Buildbucket for the build status
[05:27:17.083] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:17.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:79:0) after 1m0s
[05:28:17.100] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:79:0)
[05:28:17.100] Timer tick, asking Buildbucket for the build status
[05:28:17.168] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:17.168] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:80:0) after 1m0s
[05:29:17.189] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:80:0)
[05:29:17.189] Timer tick, asking Buildbucket for the build status
[05:29:17.276] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:17.276] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:81:0) after 1m0s
[05:30:17.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:81:0)
[05:30:17.294] Timer tick, asking Buildbucket for the build status
[05:30:17.737] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:17.737] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:82:0) after 1m0s
[05:31:17.843] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:82:0)
[05:31:17.843] Timer tick, asking Buildbucket for the build status
[05:31:18.033] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:18.033] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:83:0) after 1m0s
[05:32:18.160] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:83:0)
[05:32:18.160] Timer tick, asking Buildbucket for the build status
[05:32:18.254] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:18.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:84:0) after 1m0s
[05:33:18.329] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:84:0)
[05:33:18.329] Timer tick, asking Buildbucket for the build status
[05:33:18.386] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:18.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:85:0) after 1m0s
[05:34:21.411] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:85:0)
[05:34:21.411] Timer tick, asking Buildbucket for the build status
[05:34:21.549] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:21.549] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:86:0) after 1m0s
[05:35:21.549] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:86:0)
[05:35:21.549] Timer tick, asking Buildbucket for the build status
[05:35:21.746] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:21.746] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:87:0) after 1m0s
[05:36:21.764] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:87:0)
[05:36:21.764] Timer tick, asking Buildbucket for the build status
[05:36:21.848] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:21.848] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:88:0) after 1m0s
[05:37:21.866] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:88:0)
[05:37:21.866] Timer tick, asking Buildbucket for the build status
[05:37:21.950] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:21.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:89:0) after 1m0s
[05:38:21.968] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:89:0)
[05:38:21.968] Timer tick, asking Buildbucket for the build status
[05:38:22.042] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:22.042] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:90:0) after 1m0s
[05:39:22.068] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:90:0)
[05:39:22.068] Timer tick, asking Buildbucket for the build status
[05:39:22.147] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:22.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:91:0) after 1m0s
[05:40:22.168] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:91:0)
[05:40:22.168] Timer tick, asking Buildbucket for the build status
[05:40:22.233] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:22.233] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:92:0) after 1m0s
[05:41:22.642] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:92:0)
[05:41:22.642] Timer tick, asking Buildbucket for the build status
[05:41:22.736] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:22.736] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:93:0) after 1m0s
[05:42:23.076] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:93:0)
[05:42:23.076] Timer tick, asking Buildbucket for the build status
[05:42:23.171] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:23.171] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:94:0) after 1m0s
[05:43:23.241] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:94:0)
[05:43:23.241] Timer tick, asking Buildbucket for the build status
[05:43:23.332] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:23.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:95:0) after 1m0s
[05:44:23.353] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:95:0)
[05:44:23.353] Timer tick, asking Buildbucket for the build status
[05:44:23.433] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:23.433] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:96:0) after 1m0s
[05:45:23.464] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:96:0)
[05:45:23.464] Timer tick, asking Buildbucket for the build status
[05:45:23.579] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:23.579] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:97:0) after 1m0s
[05:46:23.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:97:0)
[05:46:23.638] Timer tick, asking Buildbucket for the build status
[05:46:23.719] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:23.719] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:98:0) after 1m0s
[05:47:23.741] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:98:0)
[05:47:23.741] Timer tick, asking Buildbucket for the build status
[05:47:23.814] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:23.814] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:99:0) after 1m0s
[05:48:23.837] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:99:0)
[05:48:23.837] Timer tick, asking Buildbucket for the build status
[05:48:23.937] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:23.937] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:100:0) after 1m0s
[05:49:24.043] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:100:0)
[05:49:24.043] Timer tick, asking Buildbucket for the build status
[05:49:24.143] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:24.143] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:101:0) after 1m0s
[05:50:28.000] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:101:0)
[05:50:28.000] Timer tick, asking Buildbucket for the build status
[05:50:28.150] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:28.150] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:102:0) after 1m0s
[05:51:28.180] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:102:0)
[05:51:28.180] Timer tick, asking Buildbucket for the build status
[05:51:28.342] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:28.342] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:103:0) after 1m0s
[05:52:28.394] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:103:0)
[05:52:28.394] Timer tick, asking Buildbucket for the build status
[05:52:28.509] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:28.509] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:104:0) after 1m0s
[05:53:28.619] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:104:0)
[05:53:28.619] Timer tick, asking Buildbucket for the build status
[05:53:28.685] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:28.686] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:105:0) after 1m0s
[05:54:28.840] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:105:0)
[05:54:28.840] Timer tick, asking Buildbucket for the build status
[05:54:28.909] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:28.909] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:106:0) after 1m0s
[05:55:29.074] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:106:0)
[05:55:29.074] Timer tick, asking Buildbucket for the build status
[05:55:29.159] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:29.159] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:107:0) after 1m0s
[05:56:29.194] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:107:0)
[05:56:29.194] Timer tick, asking Buildbucket for the build status
[05:56:29.284] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:29.284] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:108:0) after 1m0s
[05:57:29.405] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:108:0)
[05:57:29.405] Timer tick, asking Buildbucket for the build status
[05:57:29.530] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:29.530] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:109:0) after 1m0s
[05:58:29.581] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:109:0)
[05:58:29.581] Timer tick, asking Buildbucket for the build status
[05:58:29.646] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:29.646] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:110:0) after 1m0s
[05:59:29.800] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:110:0)
[05:59:29.800] Timer tick, asking Buildbucket for the build status
[05:59:29.948] Build 8853358242001294224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:29.948] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9018788303928854032:111:0) after 1m0s
[05:59:45.294] Received PubSub notification, asking Buildbucket for the build status
[05:59:45.605] Build 8853358242001294224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:59:45.605] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615183184034156",
"created_by": "project:chromium",
"created_ts": "1615176652867696",
"id": "8853358242001294224",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b344c194f2ba74766fd725c8b2ca48d4e5ff12a7\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"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\": \"b344c194f2ba74766fd725c8b2ca48d4e5ff12a7\", \"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-132-qsvp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 8156, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"b344c194f2ba74766fd725c8b2ca48d4e5ff12a7\", \"got_revision_cp\": \"refs/heads/master@{#860622}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f8b883fbba96b155409eb00da93826216bea9fc0\", \"got_v8_revision_cp\": \"refs/heads/9.1.60@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.android:android-bfcache-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b344c194f2ba74766fd725c8b2ca48d4e5ff12a7\", \"swarm_hashes_refs/heads/master(at){#860622}_without_patch\": {\"android_browsertests\": \"d9c705693fef3abcb7aae01fbdb80d488d9829b0\", \"chrome_public_test_apk\": \"2beabc0edad07579fb5e910300d7b92919e3c05c\", \"content_browsertests\": \"e58566f89bc5c7ba732f4a1bfeefac18f6ee8851\", \"content_shell_test_apk\": \"d171b9a5cc8266b994d19f4783c6ce5b768fa289\", \"content_unittests\": \"a8dc25eec12ef4d39627ae228d401bc308d57731\", \"unit_tests\": \"46161726523886dccab49b6d9ac33a3863e4cba6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1867ea95e01d3ef15634c6eb0637af698753fb1de91acba07f1b302e169858e3_v2\", \"builder_62c898de6588ca5d707c8045ecb6f8a7746948ea4311f8836fa952d6f41dbc73_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-132-qsvp\"], \"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\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615176902060210",
"status": "COMPLETED",
"status_changed_ts": "1615183184418912",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8156",
"builder:android-bfcache-rel",
"buildset:commit/git/b344c194f2ba74766fd725c8b2ca48d4e5ff12a7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b344c194f2ba74766fd725c8b2ca48d4e5ff12a7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018788303928854032",
"scheduler_job_id:chromium/android-bfcache-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853358242001294224/+/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:5228d962bb85a510",
"user_agent:luci-scheduler"
],
"updated_ts": "1615183184427423",
"url": "https://ci.chromium.org/b/8853358242001294224",
"utcnow_ts": "1615183185592995"
}
}
[05:59:45.605] Invocation finished in 1h48m53.960706524s with status SUCCEEDED