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": "3e39199d137e1450a60aad3b80fdd1d226c355f9"
}

Incoming tags

  • buildset:commit/gitiles/r8.googlesource.com/r8/+/3e39199d137e1450a60aad3b80fdd1d226c355f9
  • gitiles_ref:refs/heads/main

Debug log (UTC)

[08:00:20.901] New invocation is queued and will start shortly
[08:00:22.002] Starting the invocation (attempt 1)
[08:00:22.047] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/3e39199d137e1450a60aad3b80fdd1d226c355f9"
[08:00:22.048] Popped gitiles commit info from properties and tags
[08:00:22.049] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:00:22.049] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:00:22.049] Buildbucket request:
{
  "requestId": "8904531091194524544",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8904531091194524544",
            "job": "r8/win",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "3e39199d137e1450a60aad3b80fdd1d226c355f9"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@3e39199d137e1450a60aad3b80fdd1d226c355f9",
                        "title": "3e39199d137e1450a60aad3b80fdd1d226c355f9",
                        "url": "https://r8.googlesource.com/r8/+/3e39199d137e1450a60aad3b80fdd1d226c355f9"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "3e39199d137e1450a60aad3b80fdd1d226c355f9",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8904531091194524544"
    },
    {
      "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"
  }
}
[08:00:22.629] Scheduled build:
{
  "id": "8739101029244735889",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 146,
  "createdBy": "project:r8",
  "createTime": "2024-08-20T08:00:22.137641269Z",
  "updateTime": "2024-08-20T08:00:22.137641269Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "3e39199d137e1450a60aad3b80fdd1d226c355f9",
      "ref": "refs/heads/main"
    }
  }
}
[08:00:22.629] Task URL: https://cr-buildbucket.appspot.com/build/8739101029244735889
[08:00:22.629] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:2:0) after 4m32s
[08:00:23.467] Received PubSub notification, asking Buildbucket for the build status
[08:00:23.493] Build status: SCHEDULED
[08:00:36.013] Received PubSub notification, asking Buildbucket for the build status
[08:00:36.032] Build status: STARTED
[08:04:54.696] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:2:0)
[08:04:54.720] Build status: STARTED
[08:04:54.720] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:5:0) after 5m54s
[08:10:48.743] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:5:0)
[08:10:48.773] Build status: STARTED
[08:10:48.773] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:6:0) after 2m23s
[08:13:11.775] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:6:0)
[08:13:11.821] Build status: STARTED
[08:13:11.821] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:7:0) after 7m21s
[08:20:32.982] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:7:0)
[08:20:33.018] Build status: STARTED
[08:20:33.018] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:8:0) after 5m27s
[08:26:00.083] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:8:0)
[08:26:00.234] Build status: STARTED
[08:26:00.234] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:9:0) after 2m44s
[08:28:44.320] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:9:0)
[08:28:44.338] Build status: STARTED
[08:28:44.338] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:10:0) after 5m0s
[08:33:44.353] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:10:0)
[08:33:44.546] Build status: STARTED
[08:33:44.546] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:11:0) after 3m41s
[08:37:25.663] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:11:0)
[08:37:25.686] Build status: STARTED
[08:37:25.686] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:12:0) after 9m13s
[08:46:38.700] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:12:0)
[08:46:38.726] Build status: STARTED
[08:46:38.726] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:13:0) after 6m12s
[08:52:50.911] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:13:0)
[08:52:50.932] Build status: STARTED
[08:52:50.932] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:14:0) after 8m13s
[09:01:04.010] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:14:0)
[09:01:04.027] Build status: STARTED
[09:01:04.027] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:15:0) after 7m27s
[09:08:31.140] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:15:0)
[09:08:31.160] Build status: STARTED
[09:08:31.160] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:16:0) after 1m40s
[09:10:11.216] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:16:0)
[09:10:11.252] Build status: STARTED
[09:10:11.252] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:17:0) after 1m0s
[09:11:11.280] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:17:0)
[09:11:11.296] Build status: STARTED
[09:11:11.296] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:18:0) after 5m43s
[09:16:54.315] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:18:0)
[09:16:54.338] Build status: STARTED
[09:16:54.338] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:19:0) after 4m23s
[09:21:17.402] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:19:0)
[09:21:17.430] Build status: STARTED
[09:21:17.430] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:20:0) after 6m40s
[09:27:57.770] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:20:0)
[09:27:57.789] Build status: STARTED
[09:27:57.789] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:21:0) after 2m51s
[09:30:48.861] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:21:0)
[09:30:48.880] Build status: STARTED
[09:30:48.880] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:22:0) after 6m8s
[09:36:56.955] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:22:0)
[09:36:56.973] Build status: STARTED
[09:36:56.973] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:23:0) after 9m37s
[09:46:34.264] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:23:0)
[09:46:34.288] Build status: STARTED
[09:46:34.288] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:24:0) after 9m43s
[09:56:17.376] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:24:0)
[09:56:17.419] Build status: STARTED
[09:56:17.419] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:25:0) after 9m44s
[10:06:01.447] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:25:0)
[10:06:01.544] Build status: STARTED
[10:06:01.544] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:26:0) after 6m8s
[10:12:09.560] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:26:0)
[10:12:09.584] Build status: STARTED
[10:12:09.584] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:27:0) after 1m9s
[10:13:18.597] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:27:0)
[10:13:18.630] Build status: STARTED
[10:13:18.630] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:28:0) after 3m54s
[10:17:12.650] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:28:0)
[10:17:12.682] Build status: STARTED
[10:17:12.682] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:29:0) after 4m14s
[10:21:26.737] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:29:0)
[10:21:26.794] Build status: STARTED
[10:21:26.794] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:30:0) after 4m42s
[10:26:09.043] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:30:0)
[10:26:09.144] Build status: STARTED
[10:26:09.144] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:31:0) after 6m40s
[10:32:49.439] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:31:0)
[10:32:49.462] Build status: STARTED
[10:32:49.462] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:32:0) after 7m50s
[10:40:39.496] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:32:0)
[10:40:39.523] Build status: STARTED
[10:40:39.523] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:33:0) after 4m11s
[10:44:50.591] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:33:0)
[10:44:50.618] Build status: STARTED
[10:44:50.618] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:34:0) after 3m46s
[10:48:36.683] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:34:0)
[10:48:36.777] Build status: STARTED
[10:48:36.777] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:35:0) after 4m41s
[10:53:17.812] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:35:0)
[10:53:17.834] Build status: STARTED
[10:53:17.834] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:36:0) after 3m29s
[10:56:46.885] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:36:0)
[10:56:46.905] Build status: STARTED
[10:56:46.905] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:37:0) after 1m47s
[10:58:33.919] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:37:0)
[10:58:33.936] Build status: STARTED
[10:58:33.936] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:38:0) after 9m46s
[11:08:19.953] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:38:0)
[11:08:19.987] Build status: STARTED
[11:08:19.987] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:39:0) after 9m54s
[11:18:14.043] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:39:0)
[11:18:14.063] Build status: STARTED
[11:18:14.063] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:40:0) after 4m58s
[11:23:12.079] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:40:0)
[11:23:12.096] Build status: STARTED
[11:23:12.096] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:41:0) after 7m54s
[11:31:06.132] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:41:0)
[11:31:06.152] Build status: STARTED
[11:31:06.152] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:42:0) after 4m8s
[11:35:14.398] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:42:0)
[11:35:14.420] Build status: STARTED
[11:35:14.420] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:43:0) after 7m32s
[11:42:46.474] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:43:0)
[11:42:46.509] Build status: STARTED
[11:42:46.509] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:44:0) after 4m35s
[11:47:21.911] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:44:0)
[11:47:21.940] Build status: STARTED
[11:47:21.940] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:45:0) after 2m49s
[11:50:10.963] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:45:0)
[11:50:10.983] Build status: STARTED
[11:50:10.983] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:46:0) after 4m54s
[11:55:05.148] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:46:0)
[11:55:05.168] Build status: STARTED
[11:55:05.168] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:47:0) after 7m48s
[12:02:53.815] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:47:0)
[12:02:53.867] Build status: STARTED
[12:02:53.867] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:48:0) after 1m19s
[12:04:13.287] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:48:0)
[12:04:13.305] Build status: STARTED
[12:04:13.305] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:49:0) after 7m31s
[12:11:44.295] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:49:0)
[12:11:44.312] Build status: STARTED
[12:11:44.312] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:50:0) after 7m11s
[12:18:55.327] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:50:0)
[12:18:55.413] Build status: STARTED
[12:18:55.413] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:51:0) after 2m48s
[12:21:43.469] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:51:0)
[12:21:43.492] Build status: STARTED
[12:21:43.492] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:52:0) after 2m25s
[12:24:08.540] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:52:0)
[12:24:08.559] Build status: STARTED
[12:24:08.559] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:53:0) after 5m26s
[12:29:34.575] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:53:0)
[12:29:34.597] Build status: STARTED
[12:29:34.597] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:54:0) after 7m36s
[12:37:10.612] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:54:0)
[12:37:10.633] Build status: STARTED
[12:37:10.633] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:55:0) after 4m13s
[12:41:23.767] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:55:0)
[12:41:23.848] Build status: STARTED
[12:41:23.848] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:56:0) after 1m52s
[12:43:16.211] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:56:0)
[12:43:16.232] Build status: STARTED
[12:43:16.232] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:57:0) after 5m17s
[12:48:33.258] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:57:0)
[12:48:33.279] Build status: STARTED
[12:48:33.279] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:58:0) after 7m54s
[12:56:27.296] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:58:0)
[12:56:27.360] Build status: STARTED
[12:56:27.360] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:59:0) after 8m52s
[13:05:19.409] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:59:0)
[13:05:19.476] Build status: STARTED
[13:05:19.477] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:60:0) after 3m35s
[13:08:54.545] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:60:0)
[13:08:54.564] Build status: STARTED
[13:08:54.564] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:61:0) after 3m7s
[13:12:01.546] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:61:0)
[13:12:01.600] Build status: STARTED
[13:12:01.600] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:62:0) after 2m23s
[13:14:24.644] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:62:0)
[13:14:24.663] Build status: STARTED
[13:14:24.663] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:63:0) after 1m15s
[13:15:39.638] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:63:0)
[13:15:39.668] Build status: STARTED
[13:15:39.668] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:64:0) after 8m22s
[13:24:01.692] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:64:0)
[13:24:01.710] Build status: STARTED
[13:24:01.710] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:65:0) after 3m57s
[13:27:58.764] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:65:0)
[13:27:58.794] Build status: STARTED
[13:27:58.794] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:66:0) after 4m10s
[13:32:08.863] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:66:0)
[13:32:08.926] Build status: STARTED
[13:32:08.926] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:67:0) after 2m5s
[13:34:13.992] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:67:0)
[13:34:14.013] Build status: STARTED
[13:34:14.013] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:68:0) after 7m8s
[13:41:22.080] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:68:0)
[13:41:22.100] Build status: STARTED
[13:41:22.100] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:69:0) after 4m41s
[13:46:03.125] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:69:0)
[13:46:03.159] Build status: STARTED
[13:46:03.159] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:70:0) after 6m47s
[13:52:50.239] Handling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:70:0)
[13:52:50.266] Build status: STARTED
[13:52:50.266] Scheduling timer "check-buildbucket-build-status" (r8/win:8904531091194524544:71:0) after 5m49s
[13:53:30.302] Received PubSub notification, asking Buildbucket for the build status
[13:53:30.324] Build:
{
  "id": "8739101029244735889",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "win"
  },
  "number": 146,
  "createdBy": "project:r8",
  "createTime": "2024-08-20T08:00:22.137641269Z",
  "startTime": "2024-08-20T08:00:35.768747699Z",
  "endTime": "2024-08-20T13:53:30.112539307Z",
  "updateTime": "2024-08-20T13:53:30.112539307Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "3e39199d137e1450a60aad3b80fdd1d226c355f9",
      "ref": "refs/heads/main"
    }
  }
}
[13:53:30.324] Invocation finished in 5h53m9.429425863s with status SUCCEEDED