[18:02:47.315] New invocation is queued and will start shortly
[18:02:48.377] Starting the invocation (attempt 1)
[18:02:48.419] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:02:48.419] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:02:48.419] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031419538882281776",
"parameters_json": "{\"builder_name\":\"android-arm64-proguard-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"581ea988ec75ec13a40a62fbdedd4f61f44174dc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-arm64-proguard-rel",
"scheduler_invocation_id:9031419538882281776",
"scheduler_job_id:chromium/android-arm64-proguard-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/581ea988ec75ec13a40a62fbdedd4f61f44174dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/581ea988ec75ec13a40a62fbdedd4f61f44174dc",
"gitiles_ref:refs/heads/master"
]
}
[18:02:49.342] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603130568546914",
"id": "8865989476914908752",
"parameters_json": "{\"builder_name\": \"android-arm64-proguard-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"581ea988ec75ec13a40a62fbdedd4f61f44174dc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603130569003959",
"tags": [
"build_address:luci.chromium.ci/android-arm64-proguard-rel/2926",
"builder:android-arm64-proguard-rel",
"buildset:commit/git/581ea988ec75ec13a40a62fbdedd4f61f44174dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/581ea988ec75ec13a40a62fbdedd4f61f44174dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031419538882281776",
"scheduler_job_id:chromium/android-arm64-proguard-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865989476914908752/+/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": "1603130569004106",
"url": "https://ci.chromium.org/b/8865989476914908752",
"utcnow_ts": "1603130569327629"
}
}
[18:02:49.342] Task URL: https://ci.chromium.org/b/8865989476914908752
[18:02:49.342] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:2:0) after 1m0s
[18:03:49.421] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:2:0)
[18:03:49.421] Timer tick, asking Buildbucket for the build status
[18:03:49.597] Build 8865989476914908752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:49.597] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:3:0) after 1m0s
[18:04:49.648] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:3:0)
[18:04:49.648] Timer tick, asking Buildbucket for the build status
[18:04:50.413] Build 8865989476914908752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:50.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:4:0) after 1m0s
[18:05:02.617] Received PubSub notification, asking Buildbucket for the build status
[18:05:02.679] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:50.528] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:4:0)
[18:05:50.528] Timer tick, asking Buildbucket for the build status
[18:05:50.889] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:50.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:6:0) after 1m0s
[18:06:50.979] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:6:0)
[18:06:50.979] Timer tick, asking Buildbucket for the build status
[18:06:51.502] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:51.502] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:7:0) after 1m0s
[18:07:51.515] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:7:0)
[18:07:51.515] Timer tick, asking Buildbucket for the build status
[18:07:51.627] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:51.627] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:8:0) after 1m0s
[18:08:51.705] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:8:0)
[18:08:51.705] Timer tick, asking Buildbucket for the build status
[18:08:51.835] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:51.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:9:0) after 1m0s
[18:09:51.941] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:9:0)
[18:09:51.941] Timer tick, asking Buildbucket for the build status
[18:09:52.048] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:52.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:10:0) after 1m0s
[18:10:52.183] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:10:0)
[18:10:52.183] Timer tick, asking Buildbucket for the build status
[18:10:52.314] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:52.314] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:11:0) after 1m0s
[18:11:52.435] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:11:0)
[18:11:52.435] Timer tick, asking Buildbucket for the build status
[18:11:52.492] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:52.492] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:12:0) after 1m0s
[18:12:52.578] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:12:0)
[18:12:52.578] Timer tick, asking Buildbucket for the build status
[18:12:53.122] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:53.122] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:13:0) after 1m0s
[18:13:53.159] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:13:0)
[18:13:53.159] Timer tick, asking Buildbucket for the build status
[18:13:53.248] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:53.248] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:14:0) after 1m0s
[18:14:53.361] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:14:0)
[18:14:53.361] Timer tick, asking Buildbucket for the build status
[18:14:53.426] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:53.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:15:0) after 1m0s
[18:15:53.489] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:15:0)
[18:15:53.489] Timer tick, asking Buildbucket for the build status
[18:15:53.600] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:53.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:16:0) after 1m0s
[18:16:53.672] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:16:0)
[18:16:53.672] Timer tick, asking Buildbucket for the build status
[18:16:53.794] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:53.794] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:17:0) after 1m0s
[18:17:53.838] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:17:0)
[18:17:53.838] Timer tick, asking Buildbucket for the build status
[18:17:53.941] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:53.941] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:18:0) after 1m0s
[18:18:53.976] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:18:0)
[18:18:53.976] Timer tick, asking Buildbucket for the build status
[18:18:54.094] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:54.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:19:0) after 1m0s
[18:19:54.209] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:19:0)
[18:19:54.209] Timer tick, asking Buildbucket for the build status
[18:19:54.277] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:54.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:20:0) after 1m0s
[18:20:54.444] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:20:0)
[18:20:54.444] Timer tick, asking Buildbucket for the build status
[18:20:54.573] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:54.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:21:0) after 1m0s
[18:21:54.740] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:21:0)
[18:21:54.740] Timer tick, asking Buildbucket for the build status
[18:21:55.036] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:55.036] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:22:0) after 1m0s
[18:22:55.079] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:22:0)
[18:22:55.079] Timer tick, asking Buildbucket for the build status
[18:22:55.599] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:55.599] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:23:0) after 1m0s
[18:23:55.721] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:23:0)
[18:23:55.721] Timer tick, asking Buildbucket for the build status
[18:23:56.631] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:56.631] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:24:0) after 1m0s
[18:24:56.817] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:24:0)
[18:24:56.817] Timer tick, asking Buildbucket for the build status
[18:24:57.196] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:57.196] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:25:0) after 1m0s
[18:25:57.241] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:25:0)
[18:25:57.241] Timer tick, asking Buildbucket for the build status
[18:25:57.456] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:57.456] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:26:0) after 1m0s
[18:26:57.549] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:26:0)
[18:26:57.549] Timer tick, asking Buildbucket for the build status
[18:26:57.696] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:57.696] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:27:0) after 1m0s
[18:27:57.786] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:27:0)
[18:27:57.786] Timer tick, asking Buildbucket for the build status
[18:27:57.907] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:57.907] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:28:0) after 1m0s
[18:28:57.960] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:28:0)
[18:28:57.960] Timer tick, asking Buildbucket for the build status
[18:28:59.686] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:59.686] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:29:0) after 1m0s
[18:29:59.755] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:29:0)
[18:29:59.755] Timer tick, asking Buildbucket for the build status
[18:29:59.821] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:59.821] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:30:0) after 1m0s
[18:30:59.891] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:30:0)
[18:30:59.891] Timer tick, asking Buildbucket for the build status
[18:30:59.969] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:59.969] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:31:0) after 1m0s
[18:31:59.997] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:31:0)
[18:31:59.997] Timer tick, asking Buildbucket for the build status
[18:32:01.268] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:01.268] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:32:0) after 1m0s
[18:33:02.386] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:32:0)
[18:33:02.386] Timer tick, asking Buildbucket for the build status
[18:33:02.566] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:02.566] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:33:0) after 1m0s
[18:34:03.027] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:33:0)
[18:34:03.027] Timer tick, asking Buildbucket for the build status
[18:34:03.113] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:03.113] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:34:0) after 1m0s
[18:35:03.194] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:34:0)
[18:35:03.194] Timer tick, asking Buildbucket for the build status
[18:35:03.478] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:03.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:35:0) after 1m0s
[18:36:03.525] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:35:0)
[18:36:03.525] Timer tick, asking Buildbucket for the build status
[18:36:03.702] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:03.702] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:36:0) after 1m0s
[18:37:03.725] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:36:0)
[18:37:03.725] Timer tick, asking Buildbucket for the build status
[18:37:03.841] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:03.841] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:37:0) after 1m0s
[18:38:03.884] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:37:0)
[18:38:03.884] Timer tick, asking Buildbucket for the build status
[18:38:04.040] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:04.040] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:38:0) after 1m0s
[18:39:04.217] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:38:0)
[18:39:04.217] Timer tick, asking Buildbucket for the build status
[18:39:04.398] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:04.398] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:39:0) after 1m0s
[18:40:04.718] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:39:0)
[18:40:04.718] Timer tick, asking Buildbucket for the build status
[18:40:05.013] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:05.013] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:40:0) after 1m0s
[18:41:05.125] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:40:0)
[18:41:05.125] Timer tick, asking Buildbucket for the build status
[18:41:05.219] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:05.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:41:0) after 1m0s
[18:42:05.620] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:41:0)
[18:42:05.620] Timer tick, asking Buildbucket for the build status
[18:42:05.702] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:05.702] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:42:0) after 1m0s
[18:43:06.110] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:42:0)
[18:43:06.110] Timer tick, asking Buildbucket for the build status
[18:43:06.300] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:06.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:43:0) after 1m0s
[18:44:06.501] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:43:0)
[18:44:06.501] Timer tick, asking Buildbucket for the build status
[18:44:06.843] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:06.843] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:44:0) after 1m0s
[18:45:06.872] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:44:0)
[18:45:06.872] Timer tick, asking Buildbucket for the build status
[18:45:07.098] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:07.098] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:45:0) after 1m0s
[18:46:07.153] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:45:0)
[18:46:07.153] Timer tick, asking Buildbucket for the build status
[18:46:07.236] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:07.236] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:46:0) after 1m0s
[18:47:07.263] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:46:0)
[18:47:07.263] Timer tick, asking Buildbucket for the build status
[18:47:07.592] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:07.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:47:0) after 1m0s
[18:48:07.644] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:47:0)
[18:48:07.644] Timer tick, asking Buildbucket for the build status
[18:48:07.894] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:07.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:48:0) after 1m0s
[18:49:07.958] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:48:0)
[18:49:07.958] Timer tick, asking Buildbucket for the build status
[18:49:08.038] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:08.038] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:49:0) after 1m0s
[18:50:08.131] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:49:0)
[18:50:08.131] Timer tick, asking Buildbucket for the build status
[18:50:08.307] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:08.307] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:50:0) after 1m0s
[18:51:08.377] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:50:0)
[18:51:08.377] Timer tick, asking Buildbucket for the build status
[18:51:08.458] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:08.458] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:51:0) after 1m0s
[18:52:08.624] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:51:0)
[18:52:08.624] Timer tick, asking Buildbucket for the build status
[18:52:08.700] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:08.700] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:52:0) after 1m0s
[18:53:08.708] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:52:0)
[18:53:08.708] Timer tick, asking Buildbucket for the build status
[18:53:08.851] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:08.851] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:53:0) after 1m0s
[18:54:08.888] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:53:0)
[18:54:08.888] Timer tick, asking Buildbucket for the build status
[18:54:08.959] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:08.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:54:0) after 1m0s
[18:55:08.986] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:54:0)
[18:55:08.986] Timer tick, asking Buildbucket for the build status
[18:55:09.980] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:09.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:55:0) after 1m0s
[18:56:10.020] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:55:0)
[18:56:10.020] Timer tick, asking Buildbucket for the build status
[18:56:10.299] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:10.299] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:56:0) after 1m0s
[18:57:10.351] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:56:0)
[18:57:10.351] Timer tick, asking Buildbucket for the build status
[18:57:10.472] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:10.472] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:57:0) after 1m0s
[18:58:10.548] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:57:0)
[18:58:10.548] Timer tick, asking Buildbucket for the build status
[18:58:10.707] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:10.707] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:58:0) after 1m0s
[18:59:10.731] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:58:0)
[18:59:10.731] Timer tick, asking Buildbucket for the build status
[18:59:10.813] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:10.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:59:0) after 1m0s
[19:00:10.896] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:59:0)
[19:00:10.897] Timer tick, asking Buildbucket for the build status
[19:00:10.971] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:10.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:60:0) after 1m0s
[19:01:11.250] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:60:0)
[19:01:11.250] Timer tick, asking Buildbucket for the build status
[19:01:11.534] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:11.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:61:0) after 1m0s
[19:02:11.629] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:61:0)
[19:02:11.629] Timer tick, asking Buildbucket for the build status
[19:02:12.117] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:12.117] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:62:0) after 1m0s
[19:03:12.328] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:62:0)
[19:03:12.328] Timer tick, asking Buildbucket for the build status
[19:03:13.332] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:13.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:63:0) after 1m0s
[19:04:13.415] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:63:0)
[19:04:13.415] Timer tick, asking Buildbucket for the build status
[19:04:13.837] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:13.837] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:64:0) after 1m0s
[19:05:13.949] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:64:0)
[19:05:13.949] Timer tick, asking Buildbucket for the build status
[19:05:14.043] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:65:0) after 1m0s
[19:06:14.095] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:65:0)
[19:06:14.095] Timer tick, asking Buildbucket for the build status
[19:06:14.298] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:14.298] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:66:0) after 1m0s
[19:07:14.468] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:66:0)
[19:07:14.468] Timer tick, asking Buildbucket for the build status
[19:07:14.629] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:14.629] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:67:0) after 1m0s
[19:08:14.897] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:67:0)
[19:08:14.897] Timer tick, asking Buildbucket for the build status
[19:08:15.099] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:15.099] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:68:0) after 1m0s
[19:09:15.308] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:68:0)
[19:09:15.308] Timer tick, asking Buildbucket for the build status
[19:09:15.383] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:15.383] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:69:0) after 1m0s
[19:10:15.514] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:69:0)
[19:10:15.514] Timer tick, asking Buildbucket for the build status
[19:10:15.575] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:15.575] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:70:0) after 1m0s
[19:11:15.754] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:70:0)
[19:11:15.754] Timer tick, asking Buildbucket for the build status
[19:11:16.094] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:16.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:71:0) after 1m0s
[19:12:16.213] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:71:0)
[19:12:16.213] Timer tick, asking Buildbucket for the build status
[19:12:16.293] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:16.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:72:0) after 1m0s
[19:13:16.719] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:72:0)
[19:13:16.719] Timer tick, asking Buildbucket for the build status
[19:13:17.072] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:17.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:73:0) after 1m0s
[19:14:17.422] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:73:0)
[19:14:17.422] Timer tick, asking Buildbucket for the build status
[19:14:17.484] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:17.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:74:0) after 1m0s
[19:15:17.638] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:74:0)
[19:15:17.638] Timer tick, asking Buildbucket for the build status
[19:15:17.912] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:17.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:75:0) after 1m0s
[19:16:17.982] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:75:0)
[19:16:17.982] Timer tick, asking Buildbucket for the build status
[19:16:18.471] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:18.471] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:76:0) after 1m0s
[19:17:18.522] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:76:0)
[19:17:18.522] Timer tick, asking Buildbucket for the build status
[19:17:18.601] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:18.601] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:77:0) after 1m0s
[19:18:18.672] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:77:0)
[19:18:18.672] Timer tick, asking Buildbucket for the build status
[19:18:18.790] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:18.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:78:0) after 1m0s
[19:19:18.924] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:78:0)
[19:19:18.924] Timer tick, asking Buildbucket for the build status
[19:19:19.012] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:19.012] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:79:0) after 1m0s
[19:20:19.137] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:79:0)
[19:20:19.137] Timer tick, asking Buildbucket for the build status
[19:20:19.410] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:19.410] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:80:0) after 1m0s
[19:21:19.515] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:80:0)
[19:21:19.515] Timer tick, asking Buildbucket for the build status
[19:21:19.952] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:19.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:81:0) after 1m0s
[19:22:20.016] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:81:0)
[19:22:20.016] Timer tick, asking Buildbucket for the build status
[19:22:20.116] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:20.116] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:82:0) after 1m0s
[19:23:20.197] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:82:0)
[19:23:20.197] Timer tick, asking Buildbucket for the build status
[19:23:20.328] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:20.328] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:83:0) after 1m0s
[19:24:20.345] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:83:0)
[19:24:20.345] Timer tick, asking Buildbucket for the build status
[19:24:20.420] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:84:0) after 1m0s
[19:25:20.454] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:84:0)
[19:25:20.454] Timer tick, asking Buildbucket for the build status
[19:25:20.660] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:20.660] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:85:0) after 1m0s
[19:26:20.799] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:85:0)
[19:26:20.799] Timer tick, asking Buildbucket for the build status
[19:26:21.009] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:21.009] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:86:0) after 1m0s
[19:27:21.084] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:86:0)
[19:27:21.084] Timer tick, asking Buildbucket for the build status
[19:27:21.272] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:21.272] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:87:0) after 1m0s
[19:28:21.342] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:87:0)
[19:28:21.342] Timer tick, asking Buildbucket for the build status
[19:28:21.463] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:21.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:88:0) after 1m0s
[19:29:21.499] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:88:0)
[19:29:21.499] Timer tick, asking Buildbucket for the build status
[19:29:21.577] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:21.577] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:89:0) after 1m0s
[19:30:21.940] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:89:0)
[19:30:21.940] Timer tick, asking Buildbucket for the build status
[19:30:22.085] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:22.085] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:90:0) after 1m0s
[19:31:22.335] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:90:0)
[19:31:22.335] Timer tick, asking Buildbucket for the build status
[19:31:22.876] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:22.876] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:91:0) after 1m0s
[19:32:22.980] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:91:0)
[19:32:22.980] Timer tick, asking Buildbucket for the build status
[19:32:23.382] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:23.382] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:92:0) after 1m0s
[19:33:23.460] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:92:0)
[19:33:23.460] Timer tick, asking Buildbucket for the build status
[19:33:23.678] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:23.678] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:93:0) after 1m0s
[19:34:23.682] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:93:0)
[19:34:23.682] Timer tick, asking Buildbucket for the build status
[19:34:24.738] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:24.738] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:94:0) after 1m0s
[19:35:24.874] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:94:0)
[19:35:24.874] Timer tick, asking Buildbucket for the build status
[19:35:25.292] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:25.292] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:95:0) after 1m0s
[19:36:25.325] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:95:0)
[19:36:25.325] Timer tick, asking Buildbucket for the build status
[19:36:25.409] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:25.409] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:96:0) after 1m0s
[19:37:25.432] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:96:0)
[19:37:25.432] Timer tick, asking Buildbucket for the build status
[19:37:25.693] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:25.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:97:0) after 1m0s
[19:38:25.771] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:97:0)
[19:38:25.771] Timer tick, asking Buildbucket for the build status
[19:38:26.115] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:26.115] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:98:0) after 1m0s
[19:39:26.198] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:98:0)
[19:39:26.198] Timer tick, asking Buildbucket for the build status
[19:39:26.261] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:26.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:99:0) after 1m0s
[19:40:26.373] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:99:0)
[19:40:26.373] Timer tick, asking Buildbucket for the build status
[19:40:26.497] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:26.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:100:0) after 1m0s
[19:41:26.541] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:100:0)
[19:41:26.541] Timer tick, asking Buildbucket for the build status
[19:41:27.029] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:27.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:101:0) after 1m0s
[19:42:27.097] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:101:0)
[19:42:27.097] Timer tick, asking Buildbucket for the build status
[19:42:27.176] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:27.176] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:102:0) after 1m0s
[19:43:27.268] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:102:0)
[19:43:27.268] Timer tick, asking Buildbucket for the build status
[19:43:27.446] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:27.446] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:103:0) after 1m0s
[19:44:27.441] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:103:0)
[19:44:27.441] Timer tick, asking Buildbucket for the build status
[19:44:27.574] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:27.574] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:104:0) after 1m0s
[19:45:27.596] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:104:0)
[19:45:27.596] Timer tick, asking Buildbucket for the build status
[19:45:27.659] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:27.659] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:105:0) after 1m0s
[19:46:27.700] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:105:0)
[19:46:27.700] Timer tick, asking Buildbucket for the build status
[19:46:27.759] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:27.760] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:106:0) after 1m0s
[19:47:27.821] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:106:0)
[19:47:27.821] Timer tick, asking Buildbucket for the build status
[19:47:27.893] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:27.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:107:0) after 1m0s
[19:48:27.968] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:107:0)
[19:48:27.968] Timer tick, asking Buildbucket for the build status
[19:48:28.291] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:28.291] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:108:0) after 1m0s
[19:49:28.342] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:108:0)
[19:49:28.342] Timer tick, asking Buildbucket for the build status
[19:49:28.409] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:28.409] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:109:0) after 1m0s
[19:50:28.481] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:109:0)
[19:50:28.481] Timer tick, asking Buildbucket for the build status
[19:50:28.550] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:28.550] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:110:0) after 1m0s
[19:51:28.619] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:110:0)
[19:51:28.619] Timer tick, asking Buildbucket for the build status
[19:51:28.712] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:28.712] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:111:0) after 1m0s
[19:52:28.711] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:111:0)
[19:52:28.711] Timer tick, asking Buildbucket for the build status
[19:52:29.015] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:29.015] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:112:0) after 1m0s
[19:53:29.050] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:112:0)
[19:53:29.050] Timer tick, asking Buildbucket for the build status
[19:53:29.312] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:29.312] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:113:0) after 1m0s
[19:54:29.383] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:113:0)
[19:54:29.383] Timer tick, asking Buildbucket for the build status
[19:54:29.478] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:29.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:114:0) after 1m0s
[19:55:29.544] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:114:0)
[19:55:29.545] Timer tick, asking Buildbucket for the build status
[19:55:29.726] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:29.726] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:115:0) after 1m0s
[19:56:29.712] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:115:0)
[19:56:29.712] Timer tick, asking Buildbucket for the build status
[19:56:29.767] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:29.767] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:116:0) after 1m0s
[19:57:29.804] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:116:0)
[19:57:29.804] Timer tick, asking Buildbucket for the build status
[19:57:29.898] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:29.898] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:117:0) after 1m0s
[19:58:29.976] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:117:0)
[19:58:29.976] Timer tick, asking Buildbucket for the build status
[19:58:30.826] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:30.826] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:118:0) after 1m0s
[19:59:30.846] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:118:0)
[19:59:30.846] Timer tick, asking Buildbucket for the build status
[19:59:30.983] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:30.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:119:0) after 1m0s
[20:00:31.036] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:119:0)
[20:00:31.036] Timer tick, asking Buildbucket for the build status
[20:00:31.227] Build 8865989476914908752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:31.227] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:9031419538882281776:120:0) after 1m0s
[20:00:35.865] Received PubSub notification, asking Buildbucket for the build status
[20:00:35.944] Build 8865989476914908752: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[20:00:35.944] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603137635147922",
"created_by": "project:chromium",
"created_ts": "1603130568546914",
"failure_reason": "INFRA_FAILURE",
"id": "8865989476914908752",
"parameters_json": "{\"builder_name\": \"android-arm64-proguard-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"581ea988ec75ec13a40a62fbdedd4f61f44174dc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"recipe infra failure: Uncaught Exception: UnboundLocalError(\\\"local variable 'step_result' referenced before assignment\\\",)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.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\": \"581ea988ec75ec13a40a62fbdedd4f61f44174dc\", \"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-33-umg0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-arm64-proguard-rel\", \"buildnumber\": 2926, \"got_angle_revision\": \"6883db53569fd219b1591177370a01b4e12a46eb\", \"got_dawn_revision\": \"875091308b04ba87e29c929ed707f27889c660ea\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"581ea988ec75ec13a40a62fbdedd4f61f44174dc\", \"got_revision_cp\": \"refs/heads/master@{#818521}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"7bce5fed937f0fce6998e9f8025fba6368a257a7\", \"got_v8_revision_cp\": \"refs/heads/8.8.128@{#1}\", \"got_webrtc_revision\": \"af704183574c9b6540bd7dee27ba779950509f31\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32439}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"581ea988ec75ec13a40a62fbdedd4f61f44174dc\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_21a338e382a0dbd787bea981107dd7bac336a437920c3cc1b87ea8999b8bcb15_v2\", \"builder_35eb637f1fb45784e3e7b0fdadaf4e6bdaed8eb308e110aa0cb80327f3b54188_v2\", \"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_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-33-umg0\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"recipe infra failure: Uncaught Exception: UnboundLocalError(\\\"local variable 'step_result' referenced before assignment\\\",)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603130698526553",
"status": "COMPLETED",
"status_changed_ts": "1603130702418220",
"tags": [
"build_address:luci.chromium.ci/android-arm64-proguard-rel/2926",
"builder:android-arm64-proguard-rel",
"buildset:commit/git/581ea988ec75ec13a40a62fbdedd4f61f44174dc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/581ea988ec75ec13a40a62fbdedd4f61f44174dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031419538882281776",
"scheduler_job_id:chromium/android-arm64-proguard-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865989476914908752/+/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:4f5ad8bb849c1410",
"user_agent:luci-scheduler"
],
"updated_ts": "1603137635373588",
"url": "https://ci.chromium.org/b/8865989476914908752",
"utcnow_ts": "1603137635932328"
}
}
[20:00:35.944] Invocation finished in 1h57m48.657548386s with status FAILED