Status: FAILED
Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
Duration: 6 hours
Actions:

Definition (rev 8e315401116bbc5f80ed0063020a73aea2b1cacc)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "cron"
  builder: "Build From Tarball"
>

Incoming triggers

  • publish_tarball/0 (2 years ago by chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com)

Incoming properties

{
  "version": "111.0.5484.0"
}

Incoming tags

  • parent_buildername:publish_tarball
  • user_agent:recipe

Debug log (UTC)

[10:04:47.801] New invocation is queued and will start shortly
[10:04:47.801] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:04:48.947] Starting the invocation (attempt 1)
[10:04:48.979] Ignoring gitiles_ref tag without the buildset tag
[10:04:48.979] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:04:48.979] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:04:48.979] Buildbucket request:
{
  "requestId": "8959878008054758592",
  "builder": {
    "project": "infra",
    "bucket": "cron",
    "builder": "Build From Tarball"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8959878008054758592",
            "job": "infra/Build From Tarball",
            "triggers": [
                  {
                        "buildbucket": {
                              "properties": {
                                    "version": "111.0.5484.0"
                                  },
                              "tags": [
                                    "parent_buildername:publish_tarball",
                                    "user_agent:recipe"
                                  ]
                            },
                        "id": "6c5cadf7-3751-439e-a5cc-bfd27911fd97",
                        "title": "publish_tarball/0"
                      }
                ]
          },
      "version": "111.0.5484.0"
    },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8959878008054758592"
    },
    {
      "key": "scheduler_job_id",
      "value": "infra/Build From Tarball"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    },
    {
      "key": "parent_buildername",
      "value": "publish_tarball"
    },
    {
      "key": "user_agent",
      "value": "recipe"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[10:04:49.341] Scheduled build:
{
  "id": "8794447946066161089",
  "builder": {
    "project": "infra",
    "bucket": "cron",
    "builder": "Build From Tarball"
  },
  "createdBy": "project:infra",
  "createTime": "2022-12-18T10:04:49.073512356Z",
  "updateTime": "2022-12-18T10:04:49.073512356Z",
  "status": "SCHEDULED",
  "input": {

  }
}
[10:04:49.342] Task URL: https://cr-buildbucket.appspot.com/build/8794447946066161089
[10:04:49.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:2:0) after 9m45s
[10:14:34.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:2:0)
[10:14:34.404] Build status: SCHEDULED
[10:14:34.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:3:0) after 5m16s
[10:19:50.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:3:0)
[10:19:50.586] Build status: SCHEDULED
[10:19:50.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:4:0) after 2m5s
[10:21:55.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:4:0)
[10:21:55.754] Build status: SCHEDULED
[10:21:55.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:5:0) after 1m1s
[10:22:56.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:5:0)
[10:22:56.943] Build status: SCHEDULED
[10:22:56.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:6:0) after 9m0s
[10:31:56.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:6:0)
[10:31:57.005] Build status: SCHEDULED
[10:31:57.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:7:0) after 3m38s
[10:35:35.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:7:0)
[10:35:35.097] Build status: SCHEDULED
[10:35:35.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:8:0) after 9m31s
[10:45:06.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:8:0)
[10:45:06.892] Build status: SCHEDULED
[10:45:06.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:9:0) after 1m21s
[10:46:28.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:9:0)
[10:46:28.739] Build status: SCHEDULED
[10:46:28.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:10:0) after 2m29s
[10:48:57.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:10:0)
[10:48:57.797] Build status: SCHEDULED
[10:48:57.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:11:0) after 3m48s
[10:52:45.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:11:0)
[10:52:45.840] Build status: SCHEDULED
[10:52:45.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:12:0) after 4m17s
[10:57:02.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:12:0)
[10:57:03.038] Build status: SCHEDULED
[10:57:03.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:13:0) after 1m4s
[10:58:07.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:13:0)
[10:58:07.132] Build status: SCHEDULED
[10:58:07.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:14:0) after 5m39s
[11:03:46.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:14:0)
[11:03:46.627] Build status: SCHEDULED
[11:03:46.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:15:0) after 5m34s
[11:09:20.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:15:0)
[11:09:20.706] Build status: SCHEDULED
[11:09:20.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:16:0) after 8m59s
[11:18:19.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:16:0)
[11:18:19.768] Build status: SCHEDULED
[11:18:19.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:17:0) after 6m22s
[11:24:41.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:17:0)
[11:24:41.839] Build status: SCHEDULED
[11:24:41.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:18:0) after 3m23s
[11:28:04.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:18:0)
[11:28:04.899] Build status: SCHEDULED
[11:28:04.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:19:0) after 7m32s
[11:35:36.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:19:0)
[11:35:36.951] Build status: SCHEDULED
[11:35:36.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:20:0) after 1m46s
[11:37:23.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:20:0)
[11:37:23.129] Build status: SCHEDULED
[11:37:23.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:21:0) after 2m14s
[11:39:37.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:21:0)
[11:39:37.200] Build status: SCHEDULED
[11:39:37.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:22:0) after 4m19s
[11:43:56.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:22:0)
[11:43:56.256] Build status: SCHEDULED
[11:43:56.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:23:0) after 6m21s
[11:50:17.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:23:0)
[11:50:17.372] Build status: SCHEDULED
[11:50:17.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:24:0) after 2m57s
[11:53:14.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:24:0)
[11:53:14.669] Build status: SCHEDULED
[11:53:14.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:25:0) after 6m41s
[11:59:55.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:25:0)
[11:59:55.738] Build status: SCHEDULED
[11:59:55.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:26:0) after 2m9s
[12:02:04.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:26:0)
[12:02:04.792] Build status: SCHEDULED
[12:02:04.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:27:0) after 3m36s
[12:05:40.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:27:0)
[12:05:41.028] Build status: SCHEDULED
[12:05:41.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:28:0) after 5m34s
[12:11:15.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:28:0)
[12:11:15.136] Build status: SCHEDULED
[12:11:15.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:29:0) after 2m44s
[12:13:59.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:29:0)
[12:13:59.509] Build status: SCHEDULED
[12:13:59.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:30:0) after 8m1s
[12:22:00.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:30:0)
[12:22:00.617] Build status: SCHEDULED
[12:22:00.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:31:0) after 3m18s
[12:25:18.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:31:0)
[12:25:18.669] Build status: SCHEDULED
[12:25:18.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:32:0) after 9m56s
[12:35:15.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:32:0)
[12:35:15.301] Build status: SCHEDULED
[12:35:15.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:33:0) after 3m54s
[12:36:38.024] Received PubSub notification, asking Buildbucket for the build status
[12:36:38.053] Build status: STARTED
[12:39:09.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:33:0)
[12:39:09.349] Build status: STARTED
[12:39:09.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:35:0) after 9m2s
[12:48:11.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:35:0)
[12:48:11.635] Build status: STARTED
[12:48:11.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:36:0) after 5m29s
[12:53:40.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:36:0)
[12:53:40.787] Build status: STARTED
[12:53:40.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:37:0) after 7m21s
[13:01:01.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:37:0)
[13:01:01.922] Build status: STARTED
[13:01:01.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:38:0) after 2m33s
[13:03:35.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:38:0)
[13:03:35.518] Build status: STARTED
[13:03:35.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:39:0) after 8m59s
[13:12:34.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:39:0)
[13:12:34.608] Build status: STARTED
[13:12:34.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:40:0) after 1m57s
[13:14:31.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:40:0)
[13:14:31.731] Build status: STARTED
[13:14:31.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:41:0) after 6m7s
[13:20:38.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:41:0)
[13:20:38.790] Build status: STARTED
[13:20:38.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:42:0) after 6m17s
[13:26:55.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:42:0)
[13:26:55.981] Build status: STARTED
[13:26:55.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:43:0) after 5m40s
[13:32:36.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:43:0)
[13:32:36.174] Build status: STARTED
[13:32:36.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:44:0) after 4m10s
[13:36:46.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:44:0)
[13:36:46.235] Build status: STARTED
[13:36:46.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:45:0) after 1m22s
[13:38:08.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:45:0)
[13:38:08.474] Build status: STARTED
[13:38:08.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:46:0) after 2m37s
[13:40:45.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:46:0)
[13:40:45.626] Build status: STARTED
[13:40:45.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:47:0) after 6m20s
[13:47:05.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:47:0)
[13:47:05.718] Build status: STARTED
[13:47:05.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:48:0) after 4m18s
[13:51:23.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:48:0)
[13:51:23.773] Build status: STARTED
[13:51:23.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:49:0) after 5m35s
[13:56:58.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:49:0)
[13:56:58.911] Build status: STARTED
[13:56:58.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:50:0) after 4m29s
[14:01:28.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:50:0)
[14:01:28.228] Build status: STARTED
[14:01:28.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:51:0) after 6m35s
[14:08:03.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:51:0)
[14:08:03.336] Build status: STARTED
[14:08:03.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:52:0) after 7m46s
[14:15:49.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:52:0)
[14:15:49.449] Build status: STARTED
[14:15:49.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:53:0) after 1m32s
[14:17:21.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:53:0)
[14:17:21.799] Build status: STARTED
[14:17:21.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:54:0) after 4m27s
[14:21:48.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:54:0)
[14:21:48.889] Build status: STARTED
[14:21:48.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:55:0) after 3m51s
[14:25:39.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:55:0)
[14:25:40.091] Build status: STARTED
[14:25:40.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:56:0) after 9m24s
[14:35:04.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:56:0)
[14:35:04.232] Build status: STARTED
[14:35:04.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:57:0) after 2m58s
[14:38:02.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:57:0)
[14:38:02.301] Build status: STARTED
[14:38:02.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:58:0) after 5m14s
[14:43:16.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:58:0)
[14:43:16.357] Build status: STARTED
[14:43:16.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:59:0) after 6m39s
[14:49:55.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:59:0)
[14:49:55.396] Build status: STARTED
[14:49:55.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:60:0) after 7m45s
[14:57:40.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:60:0)
[14:57:40.437] Build status: STARTED
[14:57:40.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:61:0) after 5m18s
[15:02:59.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:61:0)
[15:02:59.277] Build status: STARTED
[15:02:59.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:62:0) after 9m49s
[15:12:48.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:62:0)
[15:12:48.364] Build status: STARTED
[15:12:48.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:63:0) after 1m19s
[15:14:07.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:63:0)
[15:14:07.436] Build status: STARTED
[15:14:07.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:64:0) after 1m31s
[15:15:38.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:64:0)
[15:15:38.722] Build status: STARTED
[15:15:38.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:65:0) after 1m6s
[15:16:44.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:65:0)
[15:16:44.959] Build status: STARTED
[15:16:44.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:66:0) after 2m48s
[15:19:33.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:66:0)
[15:19:33.396] Build status: STARTED
[15:19:33.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:67:0) after 8m17s
[15:27:50.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:67:0)
[15:27:50.476] Build status: STARTED
[15:27:50.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:68:0) after 1m42s
[15:29:32.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:68:0)
[15:29:32.628] Build status: STARTED
[15:29:32.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:69:0) after 2m37s
[15:32:09.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:69:0)
[15:32:09.680] Build status: STARTED
[15:32:09.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:70:0) after 9m56s
[15:42:05.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:70:0)
[15:42:05.725] Build status: STARTED
[15:42:05.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:71:0) after 6m50s
[15:48:55.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:71:0)
[15:48:55.740] Build status: STARTED
[15:48:55.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:72:0) after 2m19s
[15:51:14.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:72:0)
[15:51:14.951] Build status: STARTED
[15:51:14.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:73:0) after 9m22s
[16:00:37.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:73:0)
[16:00:37.333] Build status: STARTED
[16:00:37.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:74:0) after 9m26s
[16:10:03.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:74:0)
[16:10:03.410] Build status: STARTED
[16:10:03.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8959878008054758592:75:0) after 6m27s
[16:13:09.016] Received PubSub notification, asking Buildbucket for the build status
[16:13:09.152] Build:
{
  "id": "8794447946066161089",
  "builder": {
    "project": "infra",
    "bucket": "cron",
    "builder": "Build From Tarball"
  },
  "createdBy": "project:infra",
  "createTime": "2022-12-18T10:04:49.073512356Z",
  "startTime": "2022-12-18T12:36:37.483266Z",
  "endTime": "2022-12-18T16:13:01.308078145Z",
  "updateTime": "2022-12-18T16:13:01.308078145Z",
  "status": "FAILURE",
  "input": {

  }
}
[16:13:09.152] Invocation finished in 6h8m21.360131945s with status FAILED