[21:47:36.263] New invocation is queued and will start shortly
[21:47:37.381] Starting the invocation (attempt 1)
[21:47:37.407] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f"
[21:47:37.407] Popped gitiles commit info from properties and tags
[21:47:37.407] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:47:37.407] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:47:37.407] Buildbucket request:
{
  "requestId": "8867787273354337728",
  "builder": {
    "project": "fuchsia",
    "bucket": "global.ci",
    "builder": "bringup.riscv64-lto"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8867787273354337728",
            "job": "fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "912f4db110f7b39aecf0ac6d4bd5e2f2c4feff1a"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@912f4db110f7b39aecf0ac6d4bd5e2f2c4feff1a",
                        "title": "912f4db110f7b39aecf0ac6d4bd5e2f2c4feff1a",
                        "url": "https://fuchsia.googlesource.com/integration/+/912f4db110f7b39aecf0ac6d4bd5e2f2c4feff1a"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "9b8561df2de5e62ae01080585870d31df1204811"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9b8561df2de5e62ae01080585870d31df1204811",
                        "title": "9b8561df2de5e62ae01080585870d31df1204811",
                        "url": "https://fuchsia.googlesource.com/integration/+/9b8561df2de5e62ae01080585870d31df1204811"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "965718304914c8d53e0baeeed8cc3db7612e1940"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@965718304914c8d53e0baeeed8cc3db7612e1940",
                        "title": "965718304914c8d53e0baeeed8cc3db7612e1940",
                        "url": "https://fuchsia.googlesource.com/integration/+/965718304914c8d53e0baeeed8cc3db7612e1940"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "04b2b50aebdeae2347f7b8c1eafab2919caafe73"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@04b2b50aebdeae2347f7b8c1eafab2919caafe73",
                        "title": "04b2b50aebdeae2347f7b8c1eafab2919caafe73",
                        "url": "https://fuchsia.googlesource.com/integration/+/04b2b50aebdeae2347f7b8c1eafab2919caafe73"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "5e8335d65b31be844d9e5007c14117c1cc9a1152"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5e8335d65b31be844d9e5007c14117c1cc9a1152",
                        "title": "5e8335d65b31be844d9e5007c14117c1cc9a1152",
                        "url": "https://fuchsia.googlesource.com/integration/+/5e8335d65b31be844d9e5007c14117c1cc9a1152"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "76364c4164900a2498e0db32971b016ba2952ab1"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@76364c4164900a2498e0db32971b016ba2952ab1",
                        "title": "76364c4164900a2498e0db32971b016ba2952ab1",
                        "url": "https://fuchsia.googlesource.com/integration/+/76364c4164900a2498e0db32971b016ba2952ab1"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "c59cdabc5da71f01942f997beacf80719c69faef"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c59cdabc5da71f01942f997beacf80719c69faef",
                        "title": "c59cdabc5da71f01942f997beacf80719c69faef",
                        "url": "https://fuchsia.googlesource.com/integration/+/c59cdabc5da71f01942f997beacf80719c69faef"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "df75ab05d8c9b6be40c721784c7f9cd266fca0a4"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@df75ab05d8c9b6be40c721784c7f9cd266fca0a4",
                        "title": "df75ab05d8c9b6be40c721784c7f9cd266fca0a4",
                        "url": "https://fuchsia.googlesource.com/integration/+/df75ab05d8c9b6be40c721784c7f9cd266fca0a4"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "81652838bfbe544be76ca1201f447e2ac8423e20"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@81652838bfbe544be76ca1201f447e2ac8423e20",
                        "title": "81652838bfbe544be76ca1201f447e2ac8423e20",
                        "url": "https://fuchsia.googlesource.com/integration/+/81652838bfbe544be76ca1201f447e2ac8423e20"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "9a9f06678edba09e33c16d0cb0454fe0b9d3a52b"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a9f06678edba09e33c16d0cb0454fe0b9d3a52b",
                        "title": "9a9f06678edba09e33c16d0cb0454fe0b9d3a52b",
                        "url": "https://fuchsia.googlesource.com/integration/+/9a9f06678edba09e33c16d0cb0454fe0b9d3a52b"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "7204c507339bd5509f15722f026a1e5a5b9c6c49"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7204c507339bd5509f15722f026a1e5a5b9c6c49",
                        "title": "7204c507339bd5509f15722f026a1e5a5b9c6c49",
                        "url": "https://fuchsia.googlesource.com/integration/+/7204c507339bd5509f15722f026a1e5a5b9c6c49"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "731f1307fbcf937f73b61ae78b8e44489083d683"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@731f1307fbcf937f73b61ae78b8e44489083d683",
                        "title": "731f1307fbcf937f73b61ae78b8e44489083d683",
                        "url": "https://fuchsia.googlesource.com/integration/+/731f1307fbcf937f73b61ae78b8e44489083d683"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "6daed5e0ed262d74a2626b39d2b28dfe189946e2"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6daed5e0ed262d74a2626b39d2b28dfe189946e2",
                        "title": "6daed5e0ed262d74a2626b39d2b28dfe189946e2",
                        "url": "https://fuchsia.googlesource.com/integration/+/6daed5e0ed262d74a2626b39d2b28dfe189946e2"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "e8b3102054fda28ef2dda188cef4f50bfb9a77d9"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e8b3102054fda28ef2dda188cef4f50bfb9a77d9",
                        "title": "e8b3102054fda28ef2dda188cef4f50bfb9a77d9",
                        "url": "https://fuchsia.googlesource.com/integration/+/e8b3102054fda28ef2dda188cef4f50bfb9a77d9"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "9673d6a032ffed52ca75ffe25acd3e2360136cdf"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9673d6a032ffed52ca75ffe25acd3e2360136cdf",
                        "title": "9673d6a032ffed52ca75ffe25acd3e2360136cdf",
                        "url": "https://fuchsia.googlesource.com/integration/+/9673d6a032ffed52ca75ffe25acd3e2360136cdf"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "9e8cd2397e8126911ae4b7b9256976526f280718"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9e8cd2397e8126911ae4b7b9256976526f280718",
                        "title": "9e8cd2397e8126911ae4b7b9256976526f280718",
                        "url": "https://fuchsia.googlesource.com/integration/+/9e8cd2397e8126911ae4b7b9256976526f280718"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "e60e8eb0d3dc7a89f6e157ff692d23c7c717c8e7"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e60e8eb0d3dc7a89f6e157ff692d23c7c717c8e7",
                        "title": "e60e8eb0d3dc7a89f6e157ff692d23c7c717c8e7",
                        "url": "https://fuchsia.googlesource.com/integration/+/e60e8eb0d3dc7a89f6e157ff692d23c7c717c8e7"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "c86a8a9410884cd464f66a603c32c680dd52a96e"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c86a8a9410884cd464f66a603c32c680dd52a96e",
                        "title": "c86a8a9410884cd464f66a603c32c680dd52a96e",
                        "url": "https://fuchsia.googlesource.com/integration/+/c86a8a9410884cd464f66a603c32c680dd52a96e"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "e7b46f1f52e326fa61f84223acf964af478504a5"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e7b46f1f52e326fa61f84223acf964af478504a5",
                        "title": "e7b46f1f52e326fa61f84223acf964af478504a5",
                        "url": "https://fuchsia.googlesource.com/integration/+/e7b46f1f52e326fa61f84223acf964af478504a5"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "8f864e9d5ad9b82365f83519edfcdbf873d4b29f"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f864e9d5ad9b82365f83519edfcdbf873d4b29f",
                        "title": "8f864e9d5ad9b82365f83519edfcdbf873d4b29f",
                        "url": "https://fuchsia.googlesource.com/integration/+/8f864e9d5ad9b82365f83519edfcdbf873d4b29f"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "a00626b60d94e49061e4068b1453b5c786db87e0"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a00626b60d94e49061e4068b1453b5c786db87e0",
                        "title": "a00626b60d94e49061e4068b1453b5c786db87e0",
                        "url": "https://fuchsia.googlesource.com/integration/+/a00626b60d94e49061e4068b1453b5c786db87e0"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://fuchsia.googlesource.com/integration",
                              "revision": "347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f"
                            },
                        "id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f",
                        "title": "347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f",
                        "url": "https://fuchsia.googlesource.com/integration/+/347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "fuchsia.googlesource.com",
    "project": "integration",
    "id": "347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8867787273354337728"
    },
    {
      "key": "scheduler_job_id",
      "value": "fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[21:47:37.833] Scheduled build:
{
  "id": "8702357211437184353",
  "builder": {
    "project": "fuchsia",
    "bucket": "global.ci",
    "builder": "bringup.riscv64-lto"
  },
  "createdBy": "project:fuchsia",
  "createTime": "2025-09-29T21:47:37.467667925Z",
  "updateTime": "2025-09-29T21:47:37.467667925Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "fuchsia.googlesource.com",
      "project": "integration",
      "id": "347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f",
      "ref": "refs/heads/main"
    }
  }
}
[21:47:37.833] Task URL: https://cr-buildbucket.appspot.com/build/8702357211437184353
[21:47:37.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:2:0) after 5m49s
[21:47:38.799] Received PubSub notification, asking Buildbucket for the build status
[21:47:38.818] Build status: SCHEDULED
[21:48:09.320] Received PubSub notification, asking Buildbucket for the build status
[21:48:09.351] Build status: STARTED
[21:53:26.847] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:2:0)
[21:53:26.862] Build status: STARTED
[21:53:26.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:5:0) after 6m30s
[21:59:56.886] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:5:0)
[21:59:56.913] Build status: STARTED
[21:59:56.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:6:0) after 6m58s
[22:06:54.994] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:6:0)
[22:06:55.018] Build status: STARTED
[22:06:55.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:7:0) after 3m18s
[22:10:13.213] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:7:0)
[22:10:13.240] Build status: STARTED
[22:10:13.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:8:0) after 3m30s
[22:13:43.255] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:8:0)
[22:13:43.270] Build status: STARTED
[22:13:43.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:9:0) after 8m27s
[22:22:10.248] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:9:0)
[22:22:10.262] Build status: STARTED
[22:22:10.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:10:0) after 3m28s
[22:25:38.284] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:10:0)
[22:25:38.303] Build status: STARTED
[22:25:38.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-bringup.riscv64-lto-e5a0ec7f:8867787273354337728:11:0) after 6m11s
[22:31:20.561] Received PubSub notification, asking Buildbucket for the build status
[22:31:20.584] Build:
{
  "id": "8702357211437184353",
  "builder": {
    "project": "fuchsia",
    "bucket": "global.ci",
    "builder": "bringup.riscv64-lto"
  },
  "createdBy": "project:fuchsia",
  "createTime": "2025-09-29T21:47:37.467667925Z",
  "startTime": "2025-09-29T21:48:09.142517812Z",
  "endTime": "2025-09-29T22:31:18.740151919Z",
  "updateTime": "2025-09-29T22:31:18.740151919Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "fuchsia.googlesource.com",
      "project": "integration",
      "id": "347e739bc1e2e969d5dd4dd7f2c70765e5c37f1f",
      "ref": "refs/heads/main"
    }
  }
}
[22:31:20.584] Invocation finished in 43m44.329724598s with status SUCCEEDED