[14:27:14.546] New invocation is queued and will start shortly
[14:27:16.096] Starting the invocation (attempt 1)
[14:27:16.119] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/0b4ee3f00b153e122aa4ed36abeff6e0b0834636"
[14:27:16.119] Popped gitiles commit info from properties and tags
[14:27:16.119] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:27:16.119] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:27:16.119] Buildbucket request:
{
  "requestId": "8865821845282588496",
  "builder": {
    "project": "v8",
    "bucket": "ci",
    "builder": "V8 Linux64 - bazel - builder"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8865821845282588496",
            "job": "v8/ci-V8 Linux64 - bazel - builder",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://chromium.googlesource.com/v8/v8",
                              "revision": "bc2004363fb037696d298729b6ef8ac5c2e1bcc6"
                            },
                        "id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@bc2004363fb037696d298729b6ef8ac5c2e1bcc6",
                        "title": "bc2004363fb037696d298729b6ef8ac5c2e1bcc6",
                        "url": "https://chromium.googlesource.com/v8/v8/+/bc2004363fb037696d298729b6ef8ac5c2e1bcc6"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://chromium.googlesource.com/v8/v8",
                              "revision": "b1e0b254b3ce471ec13a766e4ea436f4c404c7d3"
                            },
                        "id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@b1e0b254b3ce471ec13a766e4ea436f4c404c7d3",
                        "title": "b1e0b254b3ce471ec13a766e4ea436f4c404c7d3",
                        "url": "https://chromium.googlesource.com/v8/v8/+/b1e0b254b3ce471ec13a766e4ea436f4c404c7d3"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://chromium.googlesource.com/v8/v8",
                              "revision": "0b4ee3f00b153e122aa4ed36abeff6e0b0834636"
                            },
                        "id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@0b4ee3f00b153e122aa4ed36abeff6e0b0834636",
                        "title": "0b4ee3f00b153e122aa4ed36abeff6e0b0834636",
                        "url": "https://chromium.googlesource.com/v8/v8/+/0b4ee3f00b153e122aa4ed36abeff6e0b0834636"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "v8/v8",
    "id": "0b4ee3f00b153e122aa4ed36abeff6e0b0834636",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8865821845282588496"
    },
    {
      "key": "scheduler_job_id",
      "value": "v8/ci-V8 Linux64 - bazel - builder"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[14:27:16.775] Scheduled build:
{
  "id": "8700391782908562897",
  "builder": {
    "project": "v8",
    "bucket": "ci",
    "builder": "V8 Linux64 - bazel - builder"
  },
  "number": 18491,
  "createdBy": "project:v8",
  "createTime": "2025-10-21T14:27:16.176436626Z",
  "updateTime": "2025-10-21T14:27:16.176436626Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "v8/v8",
      "id": "0b4ee3f00b153e122aa4ed36abeff6e0b0834636",
      "ref": "refs/heads/main"
    }
  }
}
[14:27:16.775] Task URL: https://cr-buildbucket.appspot.com/build/8700391782908562897
[14:27:16.775] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:2:0) after 7m15s
[14:27:17.557] Received PubSub notification, asking Buildbucket for the build status
[14:27:17.574] Build status: SCHEDULED
[14:27:20.530] Received PubSub notification, asking Buildbucket for the build status
[14:27:20.548] Build status: STARTED
[14:34:31.788] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:2:0)
[14:34:31.812] Build status: STARTED
[14:34:31.812] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:5:0) after 3m12s
[14:37:43.826] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:5:0)
[14:37:43.855] Build status: STARTED
[14:37:43.855] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:6:0) after 1m33s
[14:39:16.920] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:6:0)
[14:39:16.936] Build status: STARTED
[14:39:16.936] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:7:0) after 8m22s
[14:47:38.984] Handling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:7:0)
[14:47:39.002] Build status: STARTED
[14:47:39.002] Scheduling timer "check-buildbucket-build-status" (v8/ci-V8 Linux64 - bazel - builder:8865821845282588496:8:0) after 9m9s
[14:50:45.080] Received PubSub notification, asking Buildbucket for the build status
[14:50:45.096] Build:
{
  "id": "8700391782908562897",
  "builder": {
    "project": "v8",
    "bucket": "ci",
    "builder": "V8 Linux64 - bazel - builder"
  },
  "number": 18491,
  "createdBy": "project:v8",
  "createTime": "2025-10-21T14:27:16.176436626Z",
  "startTime": "2025-10-21T14:27:20.224083113Z",
  "endTime": "2025-10-21T14:50:44.765088877Z",
  "updateTime": "2025-10-21T14:50:44.765088877Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "v8/v8",
      "id": "0b4ee3f00b153e122aa4ed36abeff6e0b0834636",
      "ref": "refs/heads/main"
    }
  }
}
[14:50:45.096] Invocation finished in 23m30.568226182s with status SUCCEEDED