[00:28:13.410] New invocation is queued and will start shortly
[00:28:15.910] Starting the invocation (attempt 1)
[00:28:15.944] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/21071f53803bc0f51b78e1ab34236cd0092ea8dc"
[00:28:15.944] Popped gitiles commit info from properties and tags
[00:28:15.944] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:28:15.944] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:28:15.945] Buildbucket request:
{
"requestId": "8841413450846512416",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-ffx_subtools"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8841413450846512416",
"job": "fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ed8bf262496dbe71fcbf81d4dc669ee2be1f70b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ed8bf262496dbe71fcbf81d4dc669ee2be1f70b",
"title": "4ed8bf262496dbe71fcbf81d4dc669ee2be1f70b",
"url": "https://fuchsia.googlesource.com/integration/+/4ed8bf262496dbe71fcbf81d4dc669ee2be1f70b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "03f2354c24970e45f2ad939a03b4d8ae19e7f6e0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@03f2354c24970e45f2ad939a03b4d8ae19e7f6e0",
"title": "03f2354c24970e45f2ad939a03b4d8ae19e7f6e0",
"url": "https://fuchsia.googlesource.com/integration/+/03f2354c24970e45f2ad939a03b4d8ae19e7f6e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "75752b4f243c947118647e8a70912913ff4bb105"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@75752b4f243c947118647e8a70912913ff4bb105",
"title": "75752b4f243c947118647e8a70912913ff4bb105",
"url": "https://fuchsia.googlesource.com/integration/+/75752b4f243c947118647e8a70912913ff4bb105"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1f71b07e56d31c1a0eb003abcd1238082029dc89"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1f71b07e56d31c1a0eb003abcd1238082029dc89",
"title": "1f71b07e56d31c1a0eb003abcd1238082029dc89",
"url": "https://fuchsia.googlesource.com/integration/+/1f71b07e56d31c1a0eb003abcd1238082029dc89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7ee22a44b730f97273520ae615fd3c3723ac255b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7ee22a44b730f97273520ae615fd3c3723ac255b",
"title": "7ee22a44b730f97273520ae615fd3c3723ac255b",
"url": "https://fuchsia.googlesource.com/integration/+/7ee22a44b730f97273520ae615fd3c3723ac255b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c04d6c9c48e0b6d88a0f26c335c937b1f8c08641"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c04d6c9c48e0b6d88a0f26c335c937b1f8c08641",
"title": "c04d6c9c48e0b6d88a0f26c335c937b1f8c08641",
"url": "https://fuchsia.googlesource.com/integration/+/c04d6c9c48e0b6d88a0f26c335c937b1f8c08641"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f35cd8bee43a9c38f9a6922a5ed1b3ecb802fb1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f35cd8bee43a9c38f9a6922a5ed1b3ecb802fb1",
"title": "7f35cd8bee43a9c38f9a6922a5ed1b3ecb802fb1",
"url": "https://fuchsia.googlesource.com/integration/+/7f35cd8bee43a9c38f9a6922a5ed1b3ecb802fb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "26e47d6cbac9da7bab151b48014d12695797d369"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@26e47d6cbac9da7bab151b48014d12695797d369",
"title": "26e47d6cbac9da7bab151b48014d12695797d369",
"url": "https://fuchsia.googlesource.com/integration/+/26e47d6cbac9da7bab151b48014d12695797d369"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "699154f954dba29590b8121671db05b4f1cee70d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@699154f954dba29590b8121671db05b4f1cee70d",
"title": "699154f954dba29590b8121671db05b4f1cee70d",
"url": "https://fuchsia.googlesource.com/integration/+/699154f954dba29590b8121671db05b4f1cee70d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e15eaf497bf629b76285c6f99f8d472f9e11cb77"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e15eaf497bf629b76285c6f99f8d472f9e11cb77",
"title": "e15eaf497bf629b76285c6f99f8d472f9e11cb77",
"url": "https://fuchsia.googlesource.com/integration/+/e15eaf497bf629b76285c6f99f8d472f9e11cb77"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d14e9c57cf131a44d585a6dc9e0ce3257171a274"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d14e9c57cf131a44d585a6dc9e0ce3257171a274",
"title": "d14e9c57cf131a44d585a6dc9e0ce3257171a274",
"url": "https://fuchsia.googlesource.com/integration/+/d14e9c57cf131a44d585a6dc9e0ce3257171a274"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "21071f53803bc0f51b78e1ab34236cd0092ea8dc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@21071f53803bc0f51b78e1ab34236cd0092ea8dc",
"title": "21071f53803bc0f51b78e1ab34236cd0092ea8dc",
"url": "https://fuchsia.googlesource.com/integration/+/21071f53803bc0f51b78e1ab34236cd0092ea8dc"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "21071f53803bc0f51b78e1ab34236cd0092ea8dc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8841413450846512416"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:28:16.391] Scheduled build:
{
"id": "8675983387462221985",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-ffx_subtools"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-18T00:28:16.017944253Z",
"updateTime": "2026-07-18T00:28:16.017944253Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "21071f53803bc0f51b78e1ab34236cd0092ea8dc",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:28:16.391] Task URL: https://cr-buildbucket.appspot.com/build/8675983387462221985
[00:28:16.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:2:0) after 4m11s
[00:28:17.331] Received PubSub notification, asking Buildbucket for the build status
[00:28:17.353] Build status: SCHEDULED
[00:28:36.408] Received PubSub notification, asking Buildbucket for the build status
[00:28:36.426] Build status: STARTED
[00:32:27.517] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:2:0)
[00:32:27.556] Build status: STARTED
[00:32:27.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:5:0) after 4m7s
[00:36:34.549] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:5:0)
[00:36:34.576] Build status: STARTED
[00:36:34.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:6:0) after 1m13s
[00:37:47.638] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:6:0)
[00:37:47.667] Build status: STARTED
[00:37:47.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:7:0) after 9m34s
[00:47:21.685] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:7:0)
[00:47:22.246] Build status: STARTED
[00:47:22.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:8:0) after 1m16s
[00:48:38.262] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:8:0)
[00:48:38.309] Build status: STARTED
[00:48:38.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:9:0) after 3m24s
[00:52:02.322] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:9:0)
[00:52:02.338] Build status: STARTED
[00:52:02.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:10:0) after 5m23s
[00:57:25.445] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:10:0)
[00:57:25.585] Build status: STARTED
[00:57:25.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:11:0) after 7m47s
[01:05:12.576] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:11:0)
[01:05:12.597] Build status: STARTED
[01:05:12.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:12:0) after 7m15s
[01:12:27.653] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:12:0)
[01:12:27.671] Build status: STARTED
[01:12:27.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:13:0) after 9m17s
[01:21:44.688] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:13:0)
[01:21:44.721] Build status: STARTED
[01:21:44.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:14:0) after 1m46s
[01:23:30.737] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:14:0)
[01:23:30.755] Build status: STARTED
[01:23:30.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:15:0) after 9m51s
[01:33:21.787] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:15:0)
[01:33:21.809] Build status: STARTED
[01:33:21.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:16:0) after 7m39s
[01:41:00.828] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:16:0)
[01:41:00.898] Build status: STARTED
[01:41:00.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:17:0) after 6m4s
[01:47:04.965] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:17:0)
[01:47:04.992] Build status: STARTED
[01:47:04.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:18:0) after 1m36s
[01:48:41.135] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:18:0)
[01:48:41.171] Build status: STARTED
[01:48:41.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:19:0) after 7m14s
[01:55:55.189] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:19:0)
[01:55:55.214] Build status: STARTED
[01:55:55.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-release-ffx_subtools-e5a0ec7f:8841413450846512416:20:0) after 8m42s
[01:56:18.872] Received PubSub notification, asking Buildbucket for the build status
[01:56:18.896] Build:
{
"id": "8675983387462221985",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release-ffx_subtools"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-18T00:28:16.017944253Z",
"startTime": "2026-07-18T00:28:35.788084053Z",
"endTime": "2026-07-18T01:56:17.835818820Z",
"updateTime": "2026-07-18T01:56:17.835818820Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "21071f53803bc0f51b78e1ab34236cd0092ea8dc",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:56:18.896] Invocation finished in 1h28m5.489738317s with status SUCCEEDED