[20:55:58.757] New invocation is queued and will start shortly
[20:55:59.799] Starting the invocation (attempt 1)
[20:55:59.828] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f93cecf59c03b85d251758d01f1bfe0de36efb0a"
[20:55:59.828] Popped gitiles commit info from properties and tags
[20:55:59.828] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:55:59.829] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:55:59.830] Buildbucket request:
{
"requestId": "8851754858273040592",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-balanced"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851754858273040592",
"job": "fuchsia/global.ci-core.arm64-balanced-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d54ac32fa1f68978db742b91c48c8b0ca078c0ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d54ac32fa1f68978db742b91c48c8b0ca078c0ad",
"title": "d54ac32fa1f68978db742b91c48c8b0ca078c0ad",
"url": "https://fuchsia.googlesource.com/integration/+/d54ac32fa1f68978db742b91c48c8b0ca078c0ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b4c80c4516272fafe4f1f6e54e752d9d1d6d58e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b4c80c4516272fafe4f1f6e54e752d9d1d6d58e",
"title": "0b4c80c4516272fafe4f1f6e54e752d9d1d6d58e",
"url": "https://fuchsia.googlesource.com/integration/+/0b4c80c4516272fafe4f1f6e54e752d9d1d6d58e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1e6e826503523a2e26e25ed09ad52be0bb7913b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1e6e826503523a2e26e25ed09ad52be0bb7913b",
"title": "b1e6e826503523a2e26e25ed09ad52be0bb7913b",
"url": "https://fuchsia.googlesource.com/integration/+/b1e6e826503523a2e26e25ed09ad52be0bb7913b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8c2c7e54da3865e33b48c3aae651eee462deaa0c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8c2c7e54da3865e33b48c3aae651eee462deaa0c",
"title": "8c2c7e54da3865e33b48c3aae651eee462deaa0c",
"url": "https://fuchsia.googlesource.com/integration/+/8c2c7e54da3865e33b48c3aae651eee462deaa0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ac6b46b5b3707aedc5c598e6239e097e37eb77c0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ac6b46b5b3707aedc5c598e6239e097e37eb77c0",
"title": "ac6b46b5b3707aedc5c598e6239e097e37eb77c0",
"url": "https://fuchsia.googlesource.com/integration/+/ac6b46b5b3707aedc5c598e6239e097e37eb77c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f095c263b69c7a71cdf16cfec1bd154a157f224"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f095c263b69c7a71cdf16cfec1bd154a157f224",
"title": "8f095c263b69c7a71cdf16cfec1bd154a157f224",
"url": "https://fuchsia.googlesource.com/integration/+/8f095c263b69c7a71cdf16cfec1bd154a157f224"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "31cdd0b62ce4e3b23634388b0174e5b1c538fd05"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@31cdd0b62ce4e3b23634388b0174e5b1c538fd05",
"title": "31cdd0b62ce4e3b23634388b0174e5b1c538fd05",
"url": "https://fuchsia.googlesource.com/integration/+/31cdd0b62ce4e3b23634388b0174e5b1c538fd05"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "559a106bff33277812e370fdc8a8a2d3fe573556"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@559a106bff33277812e370fdc8a8a2d3fe573556",
"title": "559a106bff33277812e370fdc8a8a2d3fe573556",
"url": "https://fuchsia.googlesource.com/integration/+/559a106bff33277812e370fdc8a8a2d3fe573556"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "03e28c05f697c994b051cd522b54b0e21b116172"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@03e28c05f697c994b051cd522b54b0e21b116172",
"title": "03e28c05f697c994b051cd522b54b0e21b116172",
"url": "https://fuchsia.googlesource.com/integration/+/03e28c05f697c994b051cd522b54b0e21b116172"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "29514ac7501443588ee7caed1b2af6e3b30ba927"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@29514ac7501443588ee7caed1b2af6e3b30ba927",
"title": "29514ac7501443588ee7caed1b2af6e3b30ba927",
"url": "https://fuchsia.googlesource.com/integration/+/29514ac7501443588ee7caed1b2af6e3b30ba927"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4c818d68ca2bdb6c4f927d5a375af20e2cbf4b54"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4c818d68ca2bdb6c4f927d5a375af20e2cbf4b54",
"title": "4c818d68ca2bdb6c4f927d5a375af20e2cbf4b54",
"url": "https://fuchsia.googlesource.com/integration/+/4c818d68ca2bdb6c4f927d5a375af20e2cbf4b54"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e4d19593bad4055ffa3191f94b2fffaba4b33313"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e4d19593bad4055ffa3191f94b2fffaba4b33313",
"title": "e4d19593bad4055ffa3191f94b2fffaba4b33313",
"url": "https://fuchsia.googlesource.com/integration/+/e4d19593bad4055ffa3191f94b2fffaba4b33313"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f93cecf59c03b85d251758d01f1bfe0de36efb0a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f93cecf59c03b85d251758d01f1bfe0de36efb0a",
"title": "f93cecf59c03b85d251758d01f1bfe0de36efb0a",
"url": "https://fuchsia.googlesource.com/integration/+/f93cecf59c03b85d251758d01f1bfe0de36efb0a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f93cecf59c03b85d251758d01f1bfe0de36efb0a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851754858273040592"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-balanced-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:56:00.752] Scheduled build:
{
"id": "8686324796422378513",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-balanced"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-25T20:55:59.897968260Z",
"updateTime": "2026-03-25T20:55:59.897968260Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f93cecf59c03b85d251758d01f1bfe0de36efb0a",
"ref": "refs/heads/main"
}
}
}
[20:56:00.752] Task URL: https://cr-buildbucket.appspot.com/build/8686324796422378513
[20:56:00.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:2:0) after 1m31s
[20:56:01.495] Received PubSub notification, asking Buildbucket for the build status
[20:56:01.539] Build status: SCHEDULED
[20:56:06.857] Received PubSub notification, asking Buildbucket for the build status
[20:56:06.886] Build status: STARTED
[20:57:31.958] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:2:0)
[20:57:31.983] Build status: STARTED
[20:57:31.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:5:0) after 9m35s
[21:07:07.083] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:5:0)
[21:07:07.164] Build status: STARTED
[21:07:07.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:6:0) after 9m1s
[21:16:08.210] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:6:0)
[21:16:08.227] Build status: STARTED
[21:16:08.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:7:0) after 8m35s
[21:24:43.338] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:7:0)
[21:24:43.355] Build status: STARTED
[21:24:43.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:8:0) after 1m54s
[21:26:37.374] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:8:0)
[21:26:37.398] Build status: STARTED
[21:26:37.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:9:0) after 2m29s
[21:29:06.417] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:9:0)
[21:29:06.441] Build status: STARTED
[21:29:06.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:10:0) after 2m13s
[21:31:19.453] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:10:0)
[21:31:19.473] Build status: STARTED
[21:31:19.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:11:0) after 6m2s
[21:37:21.586] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:11:0)
[21:37:21.605] Build status: STARTED
[21:37:21.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:12:0) after 3m58s
[21:41:19.676] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:12:0)
[21:41:19.731] Build status: STARTED
[21:41:19.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:13:0) after 5m18s
[21:46:38.016] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:13:0)
[21:46:38.052] Build status: STARTED
[21:46:38.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:14:0) after 1m35s
[21:48:13.201] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:14:0)
[21:48:13.233] Build status: STARTED
[21:48:13.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:15:0) after 5m27s
[21:53:40.349] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:15:0)
[21:53:40.364] Build status: STARTED
[21:53:40.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:16:0) after 9m51s
[22:03:31.474] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:16:0)
[22:03:31.495] Build status: STARTED
[22:03:31.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:17:0) after 8m36s
[22:12:07.616] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:17:0)
[22:12:07.633] Build status: STARTED
[22:12:07.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:18:0) after 8m19s
[22:20:26.697] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:18:0)
[22:20:26.722] Build status: STARTED
[22:20:26.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:19:0) after 1m12s
[22:21:38.823] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:19:0)
[22:21:38.840] Build status: STARTED
[22:21:38.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:20:0) after 7m0s
[22:28:38.859] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:20:0)
[22:28:38.877] Build status: STARTED
[22:28:38.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:21:0) after 9m41s
[22:38:19.918] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:21:0)
[22:38:19.938] Build status: STARTED
[22:38:19.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:22:0) after 4m6s
[22:42:26.031] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:22:0)
[22:42:26.065] Build status: STARTED
[22:42:26.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:23:0) after 3m48s
[22:46:14.150] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:23:0)
[22:46:14.173] Build status: STARTED
[22:46:14.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:24:0) after 1m44s
[22:47:58.251] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:24:0)
[22:47:58.266] Build status: STARTED
[22:47:58.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:25:0) after 7m55s
[22:55:53.312] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:25:0)
[22:55:53.327] Build status: STARTED
[22:55:53.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:26:0) after 5m54s
[23:01:47.343] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:26:0)
[23:01:47.357] Build status: STARTED
[23:01:47.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-balanced-e5a0ec7f:8851754858273040592:27:0) after 3m57s
[23:04:01.555] Received PubSub notification, asking Buildbucket for the build status
[23:04:01.569] Build:
{
"id": "8686324796422378513",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-balanced"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-25T20:55:59.897968260Z",
"startTime": "2026-03-25T20:56:05.278336253Z",
"endTime": "2026-03-25T23:04:01.078815286Z",
"updateTime": "2026-03-25T23:04:01.078815286Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f93cecf59c03b85d251758d01f1bfe0de36efb0a",
"ref": "refs/heads/main"
}
}
}
[23:04:01.569] Invocation finished in 2h8m2.820639022s with status SUCCEEDED