[21:53:10.555] New invocation is queued and will start shortly
[21:53:11.757] Starting the invocation (attempt 1)
[21:53:11.797] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/2f8d669c61b202921415daccd0b8e2b9fba09398"
[21:53:11.797] Popped gitiles commit info from properties and tags
[21:53:11.797] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:53:11.797] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:53:11.798] Buildbucket request:
{
"requestId": "8842057384363077856",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8842057384363077856",
"job": "fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a9ce2164041ed5063d0eddece077c77e29992b14"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a9ce2164041ed5063d0eddece077c77e29992b14",
"title": "a9ce2164041ed5063d0eddece077c77e29992b14",
"url": "https://fuchsia.googlesource.com/integration/+/a9ce2164041ed5063d0eddece077c77e29992b14"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d012628cad588bbde0d4873187ba7c2464f25330"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d012628cad588bbde0d4873187ba7c2464f25330",
"title": "d012628cad588bbde0d4873187ba7c2464f25330",
"url": "https://fuchsia.googlesource.com/integration/+/d012628cad588bbde0d4873187ba7c2464f25330"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8c2ec512893af21d79c255f6e890aacf2f35af08"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8c2ec512893af21d79c255f6e890aacf2f35af08",
"title": "8c2ec512893af21d79c255f6e890aacf2f35af08",
"url": "https://fuchsia.googlesource.com/integration/+/8c2ec512893af21d79c255f6e890aacf2f35af08"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "87e4d0afcd931dbc4c069eee06cd43177b8a26f8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@87e4d0afcd931dbc4c069eee06cd43177b8a26f8",
"title": "87e4d0afcd931dbc4c069eee06cd43177b8a26f8",
"url": "https://fuchsia.googlesource.com/integration/+/87e4d0afcd931dbc4c069eee06cd43177b8a26f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "184203669bd9335444048fe60ac97d7b5f51a06a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@184203669bd9335444048fe60ac97d7b5f51a06a",
"title": "184203669bd9335444048fe60ac97d7b5f51a06a",
"url": "https://fuchsia.googlesource.com/integration/+/184203669bd9335444048fe60ac97d7b5f51a06a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59c8e6af4b8af54c6ba015bef31aca7f2817f491"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59c8e6af4b8af54c6ba015bef31aca7f2817f491",
"title": "59c8e6af4b8af54c6ba015bef31aca7f2817f491",
"url": "https://fuchsia.googlesource.com/integration/+/59c8e6af4b8af54c6ba015bef31aca7f2817f491"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "15cceb455e267441d6ac633935102fb3afca7dc0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@15cceb455e267441d6ac633935102fb3afca7dc0",
"title": "15cceb455e267441d6ac633935102fb3afca7dc0",
"url": "https://fuchsia.googlesource.com/integration/+/15cceb455e267441d6ac633935102fb3afca7dc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "30ebf8d27bd44fe1977b167cb478eeaddcdc7f85"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@30ebf8d27bd44fe1977b167cb478eeaddcdc7f85",
"title": "30ebf8d27bd44fe1977b167cb478eeaddcdc7f85",
"url": "https://fuchsia.googlesource.com/integration/+/30ebf8d27bd44fe1977b167cb478eeaddcdc7f85"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ef9e7e3f1a61c4e3cbd01b29ba6783d7a3c6a6e2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ef9e7e3f1a61c4e3cbd01b29ba6783d7a3c6a6e2",
"title": "ef9e7e3f1a61c4e3cbd01b29ba6783d7a3c6a6e2",
"url": "https://fuchsia.googlesource.com/integration/+/ef9e7e3f1a61c4e3cbd01b29ba6783d7a3c6a6e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ecdc8843f9f0f398f2a9f5b6122dae9c89ae0d16"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ecdc8843f9f0f398f2a9f5b6122dae9c89ae0d16",
"title": "ecdc8843f9f0f398f2a9f5b6122dae9c89ae0d16",
"url": "https://fuchsia.googlesource.com/integration/+/ecdc8843f9f0f398f2a9f5b6122dae9c89ae0d16"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a953feaa7d75ed2722ea56bb001caa79b55ce7bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a953feaa7d75ed2722ea56bb001caa79b55ce7bd",
"title": "a953feaa7d75ed2722ea56bb001caa79b55ce7bd",
"url": "https://fuchsia.googlesource.com/integration/+/a953feaa7d75ed2722ea56bb001caa79b55ce7bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "adbd8f77f6a3317df1320626a3d1a8eb59d2b842"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@adbd8f77f6a3317df1320626a3d1a8eb59d2b842",
"title": "adbd8f77f6a3317df1320626a3d1a8eb59d2b842",
"url": "https://fuchsia.googlesource.com/integration/+/adbd8f77f6a3317df1320626a3d1a8eb59d2b842"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa6d8d9174907e22a5c89c560fe6162670cebfa9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa6d8d9174907e22a5c89c560fe6162670cebfa9",
"title": "aa6d8d9174907e22a5c89c560fe6162670cebfa9",
"url": "https://fuchsia.googlesource.com/integration/+/aa6d8d9174907e22a5c89c560fe6162670cebfa9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2f8d669c61b202921415daccd0b8e2b9fba09398"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2f8d669c61b202921415daccd0b8e2b9fba09398",
"title": "2f8d669c61b202921415daccd0b8e2b9fba09398",
"url": "https://fuchsia.googlesource.com/integration/+/2f8d669c61b202921415daccd0b8e2b9fba09398"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2f8d669c61b202921415daccd0b8e2b9fba09398",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8842057384363077856"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:53:12.235] Scheduled build:
{
"id": "8676627322319675041",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-10T21:53:11.882879808Z",
"updateTime": "2026-07-10T21:53:11.882879808Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2f8d669c61b202921415daccd0b8e2b9fba09398",
"ref": "refs/heads/main"
}
}
}
[21:53:12.235] Task URL: https://cr-buildbucket.appspot.com/build/8676627322319675041
[21:53:12.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:2:0) after 3m28s
[21:53:13.270] Received PubSub notification, asking Buildbucket for the build status
[21:53:13.287] Build status: SCHEDULED
[21:53:56.091] Received PubSub notification, asking Buildbucket for the build status
[21:53:56.118] Build status: STARTED
[21:56:40.304] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:2:0)
[21:56:40.358] Build status: STARTED
[21:56:40.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:5:0) after 2m23s
[21:59:03.376] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:5:0)
[21:59:03.394] Build status: STARTED
[21:59:03.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:6:0) after 6m8s
[22:05:11.464] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:6:0)
[22:05:11.486] Build status: STARTED
[22:05:11.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:7:0) after 7m34s
[22:12:45.516] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:7:0)
[22:12:45.629] Build status: STARTED
[22:12:45.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:8:0) after 7m48s
[22:20:33.651] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:8:0)
[22:20:33.667] Build status: STARTED
[22:20:33.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:9:0) after 3m0s
[22:23:33.782] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:9:0)
[22:23:33.798] Build status: STARTED
[22:23:33.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:10:0) after 2m51s
[22:26:24.870] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:10:0)
[22:26:24.890] Build status: STARTED
[22:26:24.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:11:0) after 3m25s
[22:29:49.933] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:11:0)
[22:29:49.966] Build status: STARTED
[22:29:49.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:12:0) after 5m10s
[22:34:59.985] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:12:0)
[22:35:00.002] Build status: STARTED
[22:35:00.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:13:0) after 5m30s
[22:40:30.025] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:13:0)
[22:40:30.047] Build status: STARTED
[22:40:30.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:14:0) after 5m22s
[22:45:52.068] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:14:0)
[22:45:52.136] Build status: STARTED
[22:45:52.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:15:0) after 1m57s
[22:47:49.113] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:15:0)
[22:47:49.133] Build status: STARTED
[22:47:49.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:16:0) after 4m3s
[22:51:52.177] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:16:0)
[22:51:52.204] Build status: STARTED
[22:51:52.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:17:0) after 3m42s
[22:55:34.284] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:17:0)
[22:55:34.300] Build status: STARTED
[22:55:34.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:18:0) after 4m28s
[23:00:02.405] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:18:0)
[23:00:02.430] Build status: STARTED
[23:00:02.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:19:0) after 2m58s
[23:03:00.449] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:19:0)
[23:03:00.472] Build status: STARTED
[23:03:00.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:20:0) after 6m31s
[23:09:31.537] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:20:0)
[23:09:31.553] Build status: STARTED
[23:09:31.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:21:0) after 4m5s
[23:13:36.597] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:21:0)
[23:13:36.614] Build status: STARTED
[23:13:36.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:22:0) after 6m32s
[23:20:08.678] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:22:0)
[23:20:08.700] Build status: STARTED
[23:20:08.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:23:0) after 3m56s
[23:24:04.717] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:23:0)
[23:24:04.806] Build status: STARTED
[23:24:04.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:24:0) after 3m59s
[23:28:03.795] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:24:0)
[23:28:03.832] Build status: STARTED
[23:28:03.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:25:0) after 7m19s
[23:35:22.900] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:25:0)
[23:35:22.918] Build status: STARTED
[23:35:22.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:26:0) after 6m23s
[23:41:46.147] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:26:0)
[23:41:46.169] Build status: STARTED
[23:41:46.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-minimal.riscv64-debug-e5a0ec7f:8842057384363077856:27:0) after 6m40s
[23:45:00.821] Received PubSub notification, asking Buildbucket for the build status
[23:45:00.856] Build:
{
"id": "8676627322319675041",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-10T21:53:11.882879808Z",
"startTime": "2026-07-10T21:53:55.815217466Z",
"endTime": "2026-07-10T23:45:00.297534187Z",
"updateTime": "2026-07-10T23:45:00.297534187Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2f8d669c61b202921415daccd0b8e2b9fba09398",
"ref": "refs/heads/main"
}
}
}
[23:45:00.856] Invocation finished in 1h51m50.305773822s with status FAILED