[22:22:52.289] New invocation is queued and will start shortly
[22:22:53.416] Starting the invocation (attempt 1)
[22:22:53.487] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/2b385b77a1c3a18db1d70459cfef3b986aaaed54"
[22:22:53.487] Popped gitiles commit info from properties and tags
[22:22:53.487] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:22:53.487] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:22:53.487] Buildbucket request:
{
"requestId": "8837978652592010016",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux-rstest"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8837978652592010016",
"job": "fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7a4c20ea3e75a4f7aad2115b0e16e7070c3d0c66"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7a4c20ea3e75a4f7aad2115b0e16e7070c3d0c66",
"title": "7a4c20ea3e75a4f7aad2115b0e16e7070c3d0c66",
"url": "https://fuchsia.googlesource.com/integration/+/7a4c20ea3e75a4f7aad2115b0e16e7070c3d0c66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "57374217bb0b38377dc42cea8d52332d84b06c43"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@57374217bb0b38377dc42cea8d52332d84b06c43",
"title": "57374217bb0b38377dc42cea8d52332d84b06c43",
"url": "https://fuchsia.googlesource.com/integration/+/57374217bb0b38377dc42cea8d52332d84b06c43"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c800765b5467e5adb676c998edff65174b111d11"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c800765b5467e5adb676c998edff65174b111d11",
"title": "c800765b5467e5adb676c998edff65174b111d11",
"url": "https://fuchsia.googlesource.com/integration/+/c800765b5467e5adb676c998edff65174b111d11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "77cae1a9417782393603c69e81b49e6a4780558f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@77cae1a9417782393603c69e81b49e6a4780558f",
"title": "77cae1a9417782393603c69e81b49e6a4780558f",
"url": "https://fuchsia.googlesource.com/integration/+/77cae1a9417782393603c69e81b49e6a4780558f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed802ab41b61a94b29bf32d811e5e390f0c17c51"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed802ab41b61a94b29bf32d811e5e390f0c17c51",
"title": "ed802ab41b61a94b29bf32d811e5e390f0c17c51",
"url": "https://fuchsia.googlesource.com/integration/+/ed802ab41b61a94b29bf32d811e5e390f0c17c51"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "23f4a99becfc773b369236f1d0dfb46d3fe8619d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@23f4a99becfc773b369236f1d0dfb46d3fe8619d",
"title": "23f4a99becfc773b369236f1d0dfb46d3fe8619d",
"url": "https://fuchsia.googlesource.com/integration/+/23f4a99becfc773b369236f1d0dfb46d3fe8619d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f62dad90b86fb1e451e55c673e39a6aafba7c0b6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f62dad90b86fb1e451e55c673e39a6aafba7c0b6",
"title": "f62dad90b86fb1e451e55c673e39a6aafba7c0b6",
"url": "https://fuchsia.googlesource.com/integration/+/f62dad90b86fb1e451e55c673e39a6aafba7c0b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2b385b77a1c3a18db1d70459cfef3b986aaaed54"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2b385b77a1c3a18db1d70459cfef3b986aaaed54",
"title": "2b385b77a1c3a18db1d70459cfef3b986aaaed54",
"url": "https://fuchsia.googlesource.com/integration/+/2b385b77a1c3a18db1d70459cfef3b986aaaed54"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2b385b77a1c3a18db1d70459cfef3b986aaaed54",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8837978652592010016"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:22:53.911] Scheduled build:
{
"id": "8672548590599340833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux-rstest"
},
"createdBy": "project:fuchsia",
"createTime": "2026-08-24T22:22:53.568677599Z",
"updateTime": "2026-08-24T22:22:53.568677599Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2b385b77a1c3a18db1d70459cfef3b986aaaed54",
"ref": "refs/heads/main"
}
}
}
[22:22:53.911] Task URL: https://cr-buildbucket.appspot.com/build/8672548590599340833
[22:22:53.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:2:0) after 8m39s
[22:22:54.833] Received PubSub notification, asking Buildbucket for the build status
[22:22:54.906] Build status: SCHEDULED
[22:22:56.934] Received PubSub notification, asking Buildbucket for the build status
[22:22:56.953] Build status: STARTED
[22:31:32.948] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:2:0)
[22:31:33.099] Build status: STARTED
[22:31:33.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:5:0) after 9m46s
[22:41:19.168] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:5:0)
[22:41:19.189] Build status: STARTED
[22:41:19.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:6:0) after 1m48s
[22:43:07.287] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:6:0)
[22:43:07.322] Build status: STARTED
[22:43:07.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:7:0) after 9m24s
[22:52:31.340] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:7:0)
[22:52:31.367] Build status: STARTED
[22:52:31.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:8:0) after 6m10s
[22:58:41.448] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:8:0)
[22:58:41.473] Build status: STARTED
[22:58:41.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:9:0) after 1m35s
[23:00:16.490] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:9:0)
[23:00:16.511] Build status: STARTED
[23:00:16.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:10:0) after 4m36s
[23:04:52.515] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:10:0)
[23:04:52.559] Build status: STARTED
[23:04:52.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-linux-rstest-e5a0ec7f:8837978652592010016:11:0) after 1m37s
[23:06:05.334] Received PubSub notification, asking Buildbucket for the build status
[23:06:05.367] Build:
{
"id": "8672548590599340833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux-rstest"
},
"createdBy": "project:fuchsia",
"createTime": "2026-08-24T22:22:53.568677599Z",
"startTime": "2026-08-24T22:22:56.709846138Z",
"endTime": "2026-08-24T23:06:04.505580174Z",
"updateTime": "2026-08-24T23:06:04.505580174Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2b385b77a1c3a18db1d70459cfef3b986aaaed54",
"ref": "refs/heads/main"
}
}
}
[23:06:05.367] Invocation finished in 43m13.082622303s with status SUCCEEDED