[22:27:10.942] New invocation is queued and will start shortly
[22:27:12.028] Starting the invocation (attempt 1)
[22:27:12.058] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8a1c4223684502e73274e2a8652926ec21bd4c8c"
[22:27:12.058] Popped gitiles commit info from properties and tags
[22:27:12.058] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:27:12.059] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:27:12.059] Buildbucket request:
{
"requestId": "8908281627308973024",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-cxx20"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8908281627308973024",
"job": "fuchsia/minimal.riscv64-cxx20-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5cdeb00bf7922c68823fb73b14de4c483ba3b14f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5cdeb00bf7922c68823fb73b14de4c483ba3b14f",
"title": "5cdeb00bf7922c68823fb73b14de4c483ba3b14f",
"url": "https://fuchsia.googlesource.com/integration/+/5cdeb00bf7922c68823fb73b14de4c483ba3b14f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c172edbdc82d032c1495b21daf721268a95f2108"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c172edbdc82d032c1495b21daf721268a95f2108",
"title": "c172edbdc82d032c1495b21daf721268a95f2108",
"url": "https://fuchsia.googlesource.com/integration/+/c172edbdc82d032c1495b21daf721268a95f2108"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ce1874150be6905a87e932cc8da08829fb9b8d43"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ce1874150be6905a87e932cc8da08829fb9b8d43",
"title": "ce1874150be6905a87e932cc8da08829fb9b8d43",
"url": "https://fuchsia.googlesource.com/integration/+/ce1874150be6905a87e932cc8da08829fb9b8d43"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "336a93dcda18789f52daec726ba57b415785dc32"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@336a93dcda18789f52daec726ba57b415785dc32",
"title": "336a93dcda18789f52daec726ba57b415785dc32",
"url": "https://fuchsia.googlesource.com/integration/+/336a93dcda18789f52daec726ba57b415785dc32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "97c477c8d0bc2d7906fec391674fb4cb4e2f20ea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@97c477c8d0bc2d7906fec391674fb4cb4e2f20ea",
"title": "97c477c8d0bc2d7906fec391674fb4cb4e2f20ea",
"url": "https://fuchsia.googlesource.com/integration/+/97c477c8d0bc2d7906fec391674fb4cb4e2f20ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "adaefea10dd11fa0cddc760be7d260ec6998f7d0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@adaefea10dd11fa0cddc760be7d260ec6998f7d0",
"title": "adaefea10dd11fa0cddc760be7d260ec6998f7d0",
"url": "https://fuchsia.googlesource.com/integration/+/adaefea10dd11fa0cddc760be7d260ec6998f7d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a1c4223684502e73274e2a8652926ec21bd4c8c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a1c4223684502e73274e2a8652926ec21bd4c8c",
"title": "8a1c4223684502e73274e2a8652926ec21bd4c8c",
"url": "https://fuchsia.googlesource.com/integration/+/8a1c4223684502e73274e2a8652926ec21bd4c8c"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8a1c4223684502e73274e2a8652926ec21bd4c8c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8908281627308973024"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/minimal.riscv64-cxx20-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:27:12.554] Scheduled build:
{
"id": "8742851565414609729",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-09T22:27:12.119450249Z",
"updateTime": "2024-07-09T22:27:12.119450249Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8a1c4223684502e73274e2a8652926ec21bd4c8c",
"ref": "refs/heads/main"
}
}
}
[22:27:12.554] Task URL: https://cr-buildbucket.appspot.com/build/8742851565414609729
[22:27:12.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:2:0) after 6m7s
[22:27:13.408] Received PubSub notification, asking Buildbucket for the build status
[22:27:13.426] Build status: SCHEDULED
[22:27:18.966] Received PubSub notification, asking Buildbucket for the build status
[22:27:18.980] Build status: STARTED
[22:33:20.007] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:2:0)
[22:33:20.025] Build status: STARTED
[22:33:20.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:5:0) after 4m58s
[22:38:18.044] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:5:0)
[22:38:18.065] Build status: STARTED
[22:38:18.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:6:0) after 4m36s
[22:42:54.131] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:6:0)
[22:42:54.147] Build status: STARTED
[22:42:54.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:7:0) after 3m48s
[22:46:42.145] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:7:0)
[22:46:42.179] Build status: STARTED
[22:46:42.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:8:0) after 9m8s
[22:55:51.062] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:8:0)
[22:55:51.079] Build status: STARTED
[22:55:51.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:9:0) after 3m46s
[22:59:37.323] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:9:0)
[22:59:37.422] Build status: STARTED
[22:59:37.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:10:0) after 1m44s
[23:01:21.874] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:10:0)
[23:01:22.001] Build status: STARTED
[23:01:22.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:11:0) after 7m25s
[23:08:47.066] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:11:0)
[23:08:47.097] Build status: STARTED
[23:08:47.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:12:0) after 5m39s
[23:14:26.323] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:12:0)
[23:14:26.390] Build status: STARTED
[23:14:26.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:13:0) after 1m13s
[23:15:39.418] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:13:0)
[23:15:39.439] Build status: STARTED
[23:15:39.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:14:0) after 4m13s
[23:19:52.458] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:14:0)
[23:19:52.485] Build status: STARTED
[23:19:52.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:15:0) after 4m50s
[23:24:42.512] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:15:0)
[23:24:42.547] Build status: STARTED
[23:24:42.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:16:0) after 8m35s
[23:33:17.557] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:16:0)
[23:33:17.578] Build status: STARTED
[23:33:17.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:17:0) after 6m36s
[23:39:53.595] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:17:0)
[23:39:53.612] Build status: STARTED
[23:39:53.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:18:0) after 7m20s
[23:47:13.720] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:18:0)
[23:47:13.742] Build status: STARTED
[23:47:13.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:19:0) after 3m12s
[23:50:25.847] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:19:0)
[23:50:25.874] Build status: STARTED
[23:50:25.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:20:0) after 4m44s
[23:55:09.904] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:20:0)
[23:55:09.922] Build status: STARTED
[23:55:09.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:21:0) after 2m58s
[23:58:08.447] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:21:0)
[23:58:08.501] Build status: STARTED
[23:58:08.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-cxx20-e5a0ec7f:8908281627308973024:22:0) after 8m58s
[00:06:19.666] Received PubSub notification, asking Buildbucket for the build status
[00:06:19.684] Build:
{
"id": "8742851565414609729",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-09T22:27:12.119450249Z",
"startTime": "2024-07-09T22:27:18.584874556Z",
"endTime": "2024-07-10T00:06:19.396992223Z",
"updateTime": "2024-07-10T00:06:19.396992223Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8a1c4223684502e73274e2a8652926ec21bd4c8c",
"ref": "refs/heads/main"
}
}
}
[00:06:19.684] Invocation finished in 1h39m8.75593625s with status FAILED