Status: SUCCEEDED
Triggered by: -
Duration: 5 hours
Actions:

Definition (rev 87e0f3400b0aac78b81573f56efb8257c68089b2)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "ci"
  builder: "win"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/main",
  "repository": "https://r8.googlesource.com/r8",
  "revision": "3699bf31d196048f6d6e0725536bb3bfc31d6c39"
}

Incoming tags

  • buildset:commit/gitiles/r8.googlesource.com/r8/+/3699bf31d196048f6d6e0725536bb3bfc31d6c39
  • gitiles_ref:refs/heads/main

Debug log (UTC)

[15:40:57.037] New invocation is queued and will start shortly
[15:40:58.793] Starting the invocation (attempt 1)
[15:40:58.820] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/3699bf31d196048f6d6e0725536bb3bfc31d6c39"
[15:40:58.820] Popped gitiles commit info from properties and tags
[15:40:58.820] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:40:58.820] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:40:58.821] Buildbucket request:
{
  "requestId": "8906314051934517680",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8906314051934517680",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "9150d53320dee5b99799066b2d31ab945a46d868"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@9150d53320dee5b99799066b2d31ab945a46d868",
                        "title": "9150d53320dee5b99799066b2d31ab945a46d868",
                        "url": "https://r8.googlesource.com/r8/+/9150d53320dee5b99799066b2d31ab945a46d868"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "3699bf31d196048f6d6e0725536bb3bfc31d6c39"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@3699bf31d196048f6d6e0725536bb3bfc31d6c39",
                        "title": "3699bf31d196048f6d6e0725536bb3bfc31d6c39",
                        "url": "https://r8.googlesource.com/r8/+/3699bf31d196048f6d6e0725536bb3bfc31d6c39"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "3699bf31d196048f6d6e0725536bb3bfc31d6c39",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8906314051934517680"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/win"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[15:40:59.784] Scheduled build:
{
  "id": "8740883989235352817",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 101,
  "createdBy": "project:r8",
  "createTime": "2024-07-31T15:40:58.987037771Z",
  "updateTime": "2024-07-31T15:40:58.987037771Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "3699bf31d196048f6d6e0725536bb3bfc31d6c39",
      "ref": "refs/heads/main"
    }
  }
}
[15:40:59.784] Task URL: https://cr-buildbucket.appspot.com/build/8740883989235352817
[15:40:59.784] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:2:0) after 5m28s
[15:41:00.667] Received PubSub notification, asking Buildbucket for the build status
[15:41:00.740] Build status: SCHEDULED
[15:41:15.350] Received PubSub notification, asking Buildbucket for the build status
[15:41:15.449] Build status: STARTED
[15:46:27.796] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:2:0)
[15:46:27.819] Build status: STARTED
[15:46:27.819] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:5:0) after 5m20s
[15:51:47.845] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:5:0)
[15:51:47.869] Build status: STARTED
[15:51:47.869] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:6:0) after 5m44s
[15:57:32.044] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:6:0)
[15:57:32.064] Build status: STARTED
[15:57:32.064] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:7:0) after 2m35s
[16:00:07.099] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:7:0)
[16:00:07.127] Build status: STARTED
[16:00:07.127] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:8:0) after 3m1s
[16:03:08.142] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:8:0)
[16:03:08.173] Build status: STARTED
[16:03:08.174] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:9:0) after 8m10s
[16:11:18.238] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:9:0)
[16:11:18.263] Build status: STARTED
[16:11:18.263] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:10:0) after 2m50s
[16:14:08.278] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:10:0)
[16:14:08.311] Build status: STARTED
[16:14:08.311] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:11:0) after 4m19s
[16:18:27.327] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:11:0)
[16:18:27.356] Build status: STARTED
[16:18:27.356] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:12:0) after 7m56s
[16:26:23.384] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:12:0)
[16:26:23.398] Build status: STARTED
[16:26:23.398] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:13:0) after 3m59s
[16:30:22.606] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:13:0)
[16:30:22.637] Build status: STARTED
[16:30:22.637] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:14:0) after 7m21s
[16:37:43.706] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:14:0)
[16:37:43.792] Build status: STARTED
[16:37:43.792] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:15:0) after 6m29s
[16:44:12.816] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:15:0)
[16:44:12.851] Build status: STARTED
[16:44:12.851] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:16:0) after 9m27s
[16:53:39.907] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:16:0)
[16:53:39.926] Build status: STARTED
[16:53:39.926] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:17:0) after 7m36s
[17:01:16.017] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:17:0)
[17:01:16.061] Build status: STARTED
[17:01:16.061] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:18:0) after 6m33s
[17:07:49.095] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:18:0)
[17:07:49.115] Build status: STARTED
[17:07:49.115] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:19:0) after 7m53s
[17:15:42.234] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:19:0)
[17:15:42.332] Build status: STARTED
[17:15:42.333] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:20:0) after 6m4s
[17:21:46.444] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:20:0)
[17:21:46.472] Build status: STARTED
[17:21:46.472] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:21:0) after 4m51s
[17:26:37.486] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:21:0)
[17:26:39.484] Build status: STARTED
[17:26:39.484] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:22:0) after 2m58s
[17:29:37.541] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:22:0)
[17:29:37.559] Build status: STARTED
[17:29:37.559] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:23:0) after 4m29s
[17:34:06.585] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:23:0)
[17:34:06.704] Build status: STARTED
[17:34:06.704] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:24:0) after 1m37s
[17:35:43.782] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:24:0)
[17:35:43.803] Build status: STARTED
[17:35:43.803] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:25:0) after 3m10s
[17:38:53.823] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:25:0)
[17:38:53.843] Build status: STARTED
[17:38:53.843] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:26:0) after 8m40s
[17:47:33.862] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:26:0)
[17:47:33.881] Build status: STARTED
[17:47:33.881] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:27:0) after 7m55s
[17:55:28.943] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:27:0)
[17:55:29.004] Build status: STARTED
[17:55:29.005] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:28:0) after 1m59s
[17:57:28.105] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:28:0)
[17:57:28.127] Build status: STARTED
[17:57:28.127] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:29:0) after 9m35s
[18:07:03.193] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:29:0)
[18:07:03.220] Build status: STARTED
[18:07:03.220] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:30:0) after 7m12s
[18:14:15.217] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:30:0)
[18:14:15.247] Build status: STARTED
[18:14:15.247] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:31:0) after 2m36s
[18:16:51.274] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:31:0)
[18:16:51.333] Build status: STARTED
[18:16:51.333] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:32:0) after 1m17s
[18:18:08.469] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:32:0)
[18:18:08.521] Build status: STARTED
[18:18:08.521] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:33:0) after 1m53s
[18:20:01.594] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:33:0)
[18:20:01.618] Build status: STARTED
[18:20:01.618] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:34:0) after 7m10s
[18:27:11.655] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:34:0)
[18:27:11.687] Build status: STARTED
[18:27:11.687] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:35:0) after 6m36s
[18:33:47.859] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:35:0)
[18:33:47.881] Build status: STARTED
[18:33:47.881] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:36:0) after 7m3s
[18:40:50.986] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:36:0)
[18:40:51.006] Build status: STARTED
[18:40:51.007] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:37:0) after 7m54s
[18:48:45.068] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:37:0)
[18:48:45.100] Build status: STARTED
[18:48:45.100] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:38:0) after 5m50s
[18:54:35.116] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:38:0)
[18:54:35.144] Build status: STARTED
[18:54:35.144] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:39:0) after 1m36s
[18:56:11.159] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:39:0)
[18:56:11.181] Build status: STARTED
[18:56:11.181] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:40:0) after 1m46s
[18:57:57.437] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:40:0)
[18:57:57.481] Build status: STARTED
[18:57:57.481] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:41:0) after 9m34s
[19:07:31.612] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:41:0)
[19:07:31.643] Build status: STARTED
[19:07:31.643] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:42:0) after 2m10s
[19:09:41.708] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:42:0)
[19:09:41.725] Build status: STARTED
[19:09:41.725] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:43:0) after 1m31s
[19:11:12.740] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:43:0)
[19:11:12.818] Build status: STARTED
[19:11:12.818] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:44:0) after 9m5s
[19:20:17.893] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:44:0)
[19:20:17.912] Build status: STARTED
[19:20:17.912] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:45:0) after 1m10s
[19:21:27.929] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:45:0)
[19:21:27.959] Build status: STARTED
[19:21:27.960] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:46:0) after 9m58s
[19:31:26.104] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:46:0)
[19:31:26.145] Build status: STARTED
[19:31:26.145] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:47:0) after 3m41s
[19:35:07.162] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:47:0)
[19:35:07.316] Build status: STARTED
[19:35:07.317] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:48:0) after 8m27s
[19:43:34.364] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:48:0)
[19:43:34.386] Build status: STARTED
[19:43:34.387] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:49:0) after 2m7s
[19:45:41.520] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:49:0)
[19:45:41.551] Build status: STARTED
[19:45:41.551] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:50:0) after 3m21s
[19:49:02.570] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:50:0)
[19:49:02.593] Build status: STARTED
[19:49:02.593] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:51:0) after 7m24s
[19:56:26.617] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:51:0)
[19:56:26.684] Build status: STARTED
[19:56:26.684] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:52:0) after 5m48s
[20:02:14.718] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:52:0)
[20:02:14.788] Build status: STARTED
[20:02:14.788] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:53:0) after 5m26s
[20:07:40.805] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:53:0)
[20:07:40.831] Build status: STARTED
[20:07:40.831] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:54:0) after 3m1s
[20:10:41.949] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:54:0)
[20:10:41.971] Build status: STARTED
[20:10:41.971] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:55:0) after 4m15s
[20:14:57.082] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:55:0)
[20:14:57.099] Build status: STARTED
[20:14:57.099] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:56:0) after 6m0s
[20:20:57.127] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:56:0)
[20:20:57.146] Build status: STARTED
[20:20:57.146] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:57:0) after 2m53s
[20:23:50.263] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:57:0)
[20:23:50.305] Build status: STARTED
[20:23:50.305] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:58:0) after 1m34s
[20:25:24.407] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:58:0)
[20:25:24.440] Build status: STARTED
[20:25:24.440] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:59:0) after 7m28s
[20:32:52.513] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:59:0)
[20:32:52.530] Build status: STARTED
[20:32:52.531] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:60:0) after 7m45s
[20:40:37.535] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:60:0)
[20:40:37.552] Build status: STARTED
[20:40:37.552] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:61:0) after 8m57s
[20:49:34.574] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:61:0)
[20:49:34.591] Build status: STARTED
[20:49:34.591] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:62:0) after 7m2s
[20:56:36.608] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:62:0)
[20:56:36.699] Build status: STARTED
[20:56:36.699] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:63:0) after 5m59s
[21:02:35.717] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:63:0)
[21:02:35.765] Build status: STARTED
[21:02:35.765] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:64:0) after 9m14s
[21:11:49.795] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:64:0)
[21:11:49.819] Build status: STARTED
[21:11:49.819] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:65:0) after 1m31s
[21:13:20.846] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:65:0)
[21:13:20.870] Build status: STARTED
[21:13:20.870] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:66:0) after 1m36s
[21:14:56.891] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:66:0)
[21:14:56.912] Build status: STARTED
[21:14:56.912] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:67:0) after 1m33s
[21:16:29.983] Handling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:67:0)
[21:16:30.004] Build status: STARTED
[21:16:30.004] Scheduling timer "check-buildbucket-build-status" (r8/win:8906314051934517680:68:0) after 7m28s
[21:23:10.062] Received PubSub notification, asking Buildbucket for the build status
[21:23:10.093] Build:
{
  "id": "8740883989235352817",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 101,
  "createdBy": "project:r8",
  "createTime": "2024-07-31T15:40:58.987037771Z",
  "startTime": "2024-07-31T15:41:15.092976678Z",
  "endTime": "2024-07-31T21:23:09.433491008Z",
  "updateTime": "2024-07-31T21:23:09.433491008Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "3699bf31d196048f6d6e0725536bb3bfc31d6c39",
      "ref": "refs/heads/main"
    }
  }
}
[21:23:10.093] Invocation finished in 5h42m13.06453685s with status SUCCEEDED