[23:43:10.372] New invocation is queued and will start shortly
[23:43:11.479] Starting the invocation (attempt 1)
[23:43:11.509] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6"
[23:43:11.509] Popped gitiles commit info from properties and tags
[23:43:11.509] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:43:11.509] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:43:11.509] Buildbucket request:
{
"requestId": "8843318821484579472",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8843318821484579472",
"job": "fuchsia/global.ci-core.arm64-lto-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "54027fde4d4c76d62c49c8e3c99ec4a2186fc82c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@54027fde4d4c76d62c49c8e3c99ec4a2186fc82c",
"title": "54027fde4d4c76d62c49c8e3c99ec4a2186fc82c",
"url": "https://fuchsia.googlesource.com/integration/+/54027fde4d4c76d62c49c8e3c99ec4a2186fc82c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "44d1e97a4a3a41bc39b97487ce6bf671904cf2c6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@44d1e97a4a3a41bc39b97487ce6bf671904cf2c6",
"title": "44d1e97a4a3a41bc39b97487ce6bf671904cf2c6",
"url": "https://fuchsia.googlesource.com/integration/+/44d1e97a4a3a41bc39b97487ce6bf671904cf2c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3963eec91fed1a22118e807d759b7383125b15bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3963eec91fed1a22118e807d759b7383125b15bd",
"title": "3963eec91fed1a22118e807d759b7383125b15bd",
"url": "https://fuchsia.googlesource.com/integration/+/3963eec91fed1a22118e807d759b7383125b15bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6c470b7a8a1e0b1ab90f46145ffc9930d49c288"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6c470b7a8a1e0b1ab90f46145ffc9930d49c288",
"title": "f6c470b7a8a1e0b1ab90f46145ffc9930d49c288",
"url": "https://fuchsia.googlesource.com/integration/+/f6c470b7a8a1e0b1ab90f46145ffc9930d49c288"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d04bd20e716369d6435023fda5c82cbc50fa9ac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d04bd20e716369d6435023fda5c82cbc50fa9ac",
"title": "6d04bd20e716369d6435023fda5c82cbc50fa9ac",
"url": "https://fuchsia.googlesource.com/integration/+/6d04bd20e716369d6435023fda5c82cbc50fa9ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c81b079b1e539d324226ca42c60ba49b28d867c9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c81b079b1e539d324226ca42c60ba49b28d867c9",
"title": "c81b079b1e539d324226ca42c60ba49b28d867c9",
"url": "https://fuchsia.googlesource.com/integration/+/c81b079b1e539d324226ca42c60ba49b28d867c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9680fece7a4df9e2da295fc0b351494527c787a8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9680fece7a4df9e2da295fc0b351494527c787a8",
"title": "9680fece7a4df9e2da295fc0b351494527c787a8",
"url": "https://fuchsia.googlesource.com/integration/+/9680fece7a4df9e2da295fc0b351494527c787a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a5de6f3eac7da408611c6315c97d5d6bd6a7784"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a5de6f3eac7da408611c6315c97d5d6bd6a7784",
"title": "8a5de6f3eac7da408611c6315c97d5d6bd6a7784",
"url": "https://fuchsia.googlesource.com/integration/+/8a5de6f3eac7da408611c6315c97d5d6bd6a7784"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f5f26f107fc01f369cb1ae2060096d80a7ff44b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f5f26f107fc01f369cb1ae2060096d80a7ff44b",
"title": "8f5f26f107fc01f369cb1ae2060096d80a7ff44b",
"url": "https://fuchsia.googlesource.com/integration/+/8f5f26f107fc01f369cb1ae2060096d80a7ff44b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2dfbe6ea86277feb160c3757272f2b3da29439df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2dfbe6ea86277feb160c3757272f2b3da29439df",
"title": "2dfbe6ea86277feb160c3757272f2b3da29439df",
"url": "https://fuchsia.googlesource.com/integration/+/2dfbe6ea86277feb160c3757272f2b3da29439df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e944a25213484919ff45bc4e904ab42067d36b27"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e944a25213484919ff45bc4e904ab42067d36b27",
"title": "e944a25213484919ff45bc4e904ab42067d36b27",
"url": "https://fuchsia.googlesource.com/integration/+/e944a25213484919ff45bc4e904ab42067d36b27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f687b2752692007ae1864fb8013d0f90e650b837"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f687b2752692007ae1864fb8013d0f90e650b837",
"title": "f687b2752692007ae1864fb8013d0f90e650b837",
"url": "https://fuchsia.googlesource.com/integration/+/f687b2752692007ae1864fb8013d0f90e650b837"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4aadbbea729fcc6212d9eeb7ece64697b7042141"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4aadbbea729fcc6212d9eeb7ece64697b7042141",
"title": "4aadbbea729fcc6212d9eeb7ece64697b7042141",
"url": "https://fuchsia.googlesource.com/integration/+/4aadbbea729fcc6212d9eeb7ece64697b7042141"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "01c8406a3dc71772f4841cbccffce02ab2efc954"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@01c8406a3dc71772f4841cbccffce02ab2efc954",
"title": "01c8406a3dc71772f4841cbccffce02ab2efc954",
"url": "https://fuchsia.googlesource.com/integration/+/01c8406a3dc71772f4841cbccffce02ab2efc954"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "19d751c3dcad83d11ad55eb8aa7ef76b61c42345"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@19d751c3dcad83d11ad55eb8aa7ef76b61c42345",
"title": "19d751c3dcad83d11ad55eb8aa7ef76b61c42345",
"url": "https://fuchsia.googlesource.com/integration/+/19d751c3dcad83d11ad55eb8aa7ef76b61c42345"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c8be868bbae2ce9d728e031795f959a499d32107"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c8be868bbae2ce9d728e031795f959a499d32107",
"title": "c8be868bbae2ce9d728e031795f959a499d32107",
"url": "https://fuchsia.googlesource.com/integration/+/c8be868bbae2ce9d728e031795f959a499d32107"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c4f23ad76b2ed751568e2b9e380a9f1b384183a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c4f23ad76b2ed751568e2b9e380a9f1b384183a",
"title": "6c4f23ad76b2ed751568e2b9e380a9f1b384183a",
"url": "https://fuchsia.googlesource.com/integration/+/6c4f23ad76b2ed751568e2b9e380a9f1b384183a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c4b2a93b39c174fe36f5625cfb10bf1d7a705ed2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c4b2a93b39c174fe36f5625cfb10bf1d7a705ed2",
"title": "c4b2a93b39c174fe36f5625cfb10bf1d7a705ed2",
"url": "https://fuchsia.googlesource.com/integration/+/c4b2a93b39c174fe36f5625cfb10bf1d7a705ed2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6",
"title": "ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6",
"url": "https://fuchsia.googlesource.com/integration/+/ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8843318821484579472"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-lto-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:43:11.955] Scheduled build:
{
"id": "8677888759564500321",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-26T23:43:11.580813091Z",
"updateTime": "2026-06-26T23:43:11.580813091Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6",
"ref": "refs/heads/main"
}
}
}
[23:43:11.955] Task URL: https://cr-buildbucket.appspot.com/build/8677888759564500321
[23:43:11.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:2:0) after 2m20s
[23:43:12.168] Received PubSub notification, asking Buildbucket for the build status
[23:43:12.185] Build status: SCHEDULED
[23:45:31.936] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:2:0)
[23:45:31.965] Build status: SCHEDULED
[23:45:31.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:4:0) after 7m33s
[23:50:21.379] Received PubSub notification, asking Buildbucket for the build status
[23:50:21.428] Build status: STARTED
[23:53:04.979] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:4:0)
[23:53:04.995] Build status: STARTED
[23:53:04.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:6:0) after 9m55s
[00:03:00.171] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:6:0)
[00:03:00.202] Build status: STARTED
[00:03:00.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:7:0) after 9m18s
[00:12:18.248] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:7:0)
[00:12:18.266] Build status: STARTED
[00:12:18.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:8:0) after 1m40s
[00:13:58.333] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:8:0)
[00:13:58.352] Build status: STARTED
[00:13:58.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:9:0) after 6m46s
[00:20:44.393] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:9:0)
[00:20:44.428] Build status: STARTED
[00:20:44.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:10:0) after 3m13s
[00:23:57.470] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:10:0)
[00:23:57.488] Build status: STARTED
[00:23:57.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:11:0) after 4m51s
[00:28:48.504] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:11:0)
[00:28:48.561] Build status: STARTED
[00:28:48.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:12:0) after 7m5s
[00:35:53.569] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:12:0)
[00:35:53.647] Build status: STARTED
[00:35:53.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:13:0) after 4m34s
[00:40:27.663] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:13:0)
[00:40:27.682] Build status: STARTED
[00:40:27.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:14:0) after 3m52s
[00:44:19.686] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:14:0)
[00:44:19.711] Build status: STARTED
[00:44:19.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:15:0) after 5m39s
[00:49:58.727] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:15:0)
[00:49:58.746] Build status: STARTED
[00:49:58.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:16:0) after 7m59s
[00:57:57.811] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:16:0)
[00:57:57.828] Build status: STARTED
[00:57:57.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:17:0) after 2m28s
[01:00:25.849] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:17:0)
[01:00:25.870] Build status: STARTED
[01:00:25.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:18:0) after 9m33s
[01:09:58.898] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:18:0)
[01:09:58.914] Build status: STARTED
[01:09:58.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:19:0) after 7m55s
[01:17:53.929] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:19:0)
[01:17:54.000] Build status: STARTED
[01:17:54.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:20:0) after 3m18s
[01:21:11.988] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:20:0)
[01:21:12.010] Build status: STARTED
[01:21:12.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:21:0) after 8m15s
[01:29:27.115] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:21:0)
[01:29:27.140] Build status: STARTED
[01:29:27.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:22:0) after 4m23s
[01:33:50.203] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:22:0)
[01:33:50.289] Build status: STARTED
[01:33:50.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:23:0) after 6m55s
[01:40:45.334] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:23:0)
[01:40:45.399] Build status: STARTED
[01:40:45.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:24:0) after 9m34s
[01:50:19.415] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:24:0)
[01:50:19.434] Build status: STARTED
[01:50:19.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:25:0) after 4m41s
[01:55:00.452] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:25:0)
[01:55:00.471] Build status: STARTED
[01:55:00.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:26:0) after 1m37s
[01:56:37.488] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:26:0)
[01:56:37.512] Build status: STARTED
[01:56:37.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:27:0) after 5m58s
[02:02:35.532] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:27:0)
[02:02:35.550] Build status: STARTED
[02:02:35.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8843318821484579472:28:0) after 7m2s
[02:08:27.386] Received PubSub notification, asking Buildbucket for the build status
[02:08:27.405] Build:
{
"id": "8677888759564500321",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-26T23:43:11.580813091Z",
"startTime": "2026-06-26T23:50:21.215540074Z",
"endTime": "2026-06-27T02:08:26.798508403Z",
"updateTime": "2026-06-27T02:08:26.798508403Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ad6d901ca06be8145b23ce1c4c5a1a6ac62887e6",
"ref": "refs/heads/main"
}
}
}
[02:08:27.405] Invocation finished in 2h25m17.039485013s with status SUCCEEDED