[21:41:45.500] New invocation is queued and will start shortly
[21:41:46.715] Starting the invocation (attempt 1)
[21:41:46.755] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/e4116c281b412e671587a848a1b58fd2c3780cbf"
[21:41:46.755] Popped gitiles commit info from properties and tags
[21:41:46.755] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:41:46.757] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:41:46.758] Buildbucket request:
{
"requestId": "8873857637911702896",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-minimal.arm64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873857637911702896",
"job": "fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae7129dcfdd86c9de1c4cbac61018bb7112df333"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae7129dcfdd86c9de1c4cbac61018bb7112df333",
"title": "ae7129dcfdd86c9de1c4cbac61018bb7112df333",
"url": "https://fuchsia.googlesource.com/integration/+/ae7129dcfdd86c9de1c4cbac61018bb7112df333"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "280069c1b8061b77bf9ff77dcd34d18581e99bcd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@280069c1b8061b77bf9ff77dcd34d18581e99bcd",
"title": "280069c1b8061b77bf9ff77dcd34d18581e99bcd",
"url": "https://fuchsia.googlesource.com/integration/+/280069c1b8061b77bf9ff77dcd34d18581e99bcd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dc57da9f9c8ea9b553962ab52a124ade13669091"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dc57da9f9c8ea9b553962ab52a124ade13669091",
"title": "dc57da9f9c8ea9b553962ab52a124ade13669091",
"url": "https://fuchsia.googlesource.com/integration/+/dc57da9f9c8ea9b553962ab52a124ade13669091"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a612020936d56fbe3c43e1b68714e8ceebf9e48e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a612020936d56fbe3c43e1b68714e8ceebf9e48e",
"title": "a612020936d56fbe3c43e1b68714e8ceebf9e48e",
"url": "https://fuchsia.googlesource.com/integration/+/a612020936d56fbe3c43e1b68714e8ceebf9e48e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a15e6ae3aa4822cd887ad02076f547ae58cc5377"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a15e6ae3aa4822cd887ad02076f547ae58cc5377",
"title": "a15e6ae3aa4822cd887ad02076f547ae58cc5377",
"url": "https://fuchsia.googlesource.com/integration/+/a15e6ae3aa4822cd887ad02076f547ae58cc5377"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8155ee266eafdf82d0019fef0da8088f0327edaa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8155ee266eafdf82d0019fef0da8088f0327edaa",
"title": "8155ee266eafdf82d0019fef0da8088f0327edaa",
"url": "https://fuchsia.googlesource.com/integration/+/8155ee266eafdf82d0019fef0da8088f0327edaa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ba3e503b0df6ae16f878640addd7be01b8db1008"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ba3e503b0df6ae16f878640addd7be01b8db1008",
"title": "ba3e503b0df6ae16f878640addd7be01b8db1008",
"url": "https://fuchsia.googlesource.com/integration/+/ba3e503b0df6ae16f878640addd7be01b8db1008"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7303ae763375aa7a6ca721975fba377d6be5ab9d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7303ae763375aa7a6ca721975fba377d6be5ab9d",
"title": "7303ae763375aa7a6ca721975fba377d6be5ab9d",
"url": "https://fuchsia.googlesource.com/integration/+/7303ae763375aa7a6ca721975fba377d6be5ab9d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "62e77e33876ffb8331505b1ab7f203d0ebbe9b04"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@62e77e33876ffb8331505b1ab7f203d0ebbe9b04",
"title": "62e77e33876ffb8331505b1ab7f203d0ebbe9b04",
"url": "https://fuchsia.googlesource.com/integration/+/62e77e33876ffb8331505b1ab7f203d0ebbe9b04"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cbd3b2d85213f471ed4fba2525c99f99d1bdb653"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cbd3b2d85213f471ed4fba2525c99f99d1bdb653",
"title": "cbd3b2d85213f471ed4fba2525c99f99d1bdb653",
"url": "https://fuchsia.googlesource.com/integration/+/cbd3b2d85213f471ed4fba2525c99f99d1bdb653"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c724a05b31cafc896355aa24b79f32eff313c2bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c724a05b31cafc896355aa24b79f32eff313c2bd",
"title": "c724a05b31cafc896355aa24b79f32eff313c2bd",
"url": "https://fuchsia.googlesource.com/integration/+/c724a05b31cafc896355aa24b79f32eff313c2bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "14c4bbcdd86ee5b1a7c1855aecf8bc4072b7f617"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@14c4bbcdd86ee5b1a7c1855aecf8bc4072b7f617",
"title": "14c4bbcdd86ee5b1a7c1855aecf8bc4072b7f617",
"url": "https://fuchsia.googlesource.com/integration/+/14c4bbcdd86ee5b1a7c1855aecf8bc4072b7f617"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e4116c281b412e671587a848a1b58fd2c3780cbf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e4116c281b412e671587a848a1b58fd2c3780cbf",
"title": "e4116c281b412e671587a848a1b58fd2c3780cbf",
"url": "https://fuchsia.googlesource.com/integration/+/e4116c281b412e671587a848a1b58fd2c3780cbf"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e4116c281b412e671587a848a1b58fd2c3780cbf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873857637911702896"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:41:47.196] Scheduled build:
{
"id": "8708427575863454641",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-minimal.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-24T21:41:46.823717748Z",
"updateTime": "2025-07-24T21:41:46.823717748Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e4116c281b412e671587a848a1b58fd2c3780cbf",
"ref": "refs/heads/main"
}
}
}
[21:41:47.196] Task URL: https://cr-buildbucket.appspot.com/build/8708427575863454641
[21:41:47.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:2:0) after 8m8s
[21:41:48.181] Received PubSub notification, asking Buildbucket for the build status
[21:41:48.213] Build status: SCHEDULED
[21:41:50.388] Received PubSub notification, asking Buildbucket for the build status
[21:41:50.462] Build status: STARTED
[21:49:55.253] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:2:0)
[21:49:55.273] Build status: STARTED
[21:49:55.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:5:0) after 4m11s
[21:54:06.308] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:5:0)
[21:54:06.329] Build status: STARTED
[21:54:06.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:6:0) after 3m52s
[21:57:58.381] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:6:0)
[21:57:58.398] Build status: STARTED
[21:57:58.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:7:0) after 6m38s
[22:04:36.421] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:7:0)
[22:04:36.444] Build status: STARTED
[22:04:36.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:8:0) after 4m29s
[22:09:05.464] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:8:0)
[22:09:05.489] Build status: STARTED
[22:09:05.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:9:0) after 5m34s
[22:14:39.514] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:9:0)
[22:14:39.539] Build status: STARTED
[22:14:39.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:10:0) after 7m46s
[22:22:25.566] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:10:0)
[22:22:25.600] Build status: STARTED
[22:22:25.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:11:0) after 1m56s
[22:24:21.574] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:11:0)
[22:24:21.641] Build status: STARTED
[22:24:21.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:12:0) after 4m36s
[22:28:57.666] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:12:0)
[22:28:57.700] Build status: STARTED
[22:28:57.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:13:0) after 4m27s
[22:33:24.718] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:13:0)
[22:33:24.732] Build status: STARTED
[22:33:24.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:14:0) after 6m6s
[22:39:30.755] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:14:0)
[22:39:30.809] Build status: STARTED
[22:39:30.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:15:0) after 5m3s
[22:44:33.918] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:15:0)
[22:44:33.945] Build status: STARTED
[22:44:33.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:16:0) after 1m22s
[22:45:55.965] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:16:0)
[22:45:56.003] Build status: STARTED
[22:45:56.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:17:0) after 2m18s
[22:48:14.180] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:17:0)
[22:48:14.210] Build status: STARTED
[22:48:14.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:18:0) after 5m56s
[22:54:10.297] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:18:0)
[22:54:10.315] Build status: STARTED
[22:54:10.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:19:0) after 5m31s
[22:59:41.426] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:19:0)
[22:59:41.499] Build status: STARTED
[22:59:41.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:20:0) after 6m42s
[23:06:23.531] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:20:0)
[23:06:23.552] Build status: STARTED
[23:06:23.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:21:0) after 6m31s
[23:12:54.618] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:21:0)
[23:12:54.636] Build status: STARTED
[23:12:54.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:22:0) after 9m8s
[23:22:02.762] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:22:0)
[23:22:02.788] Build status: STARTED
[23:22:02.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-minimal.arm64-release-e5a0ec7f:8873857637911702896:23:0) after 3m0s
[23:24:38.417] Received PubSub notification, asking Buildbucket for the build status
[23:24:38.437] Build:
{
"id": "8708427575863454641",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-minimal.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-24T21:41:46.823717748Z",
"startTime": "2025-07-24T21:41:50.193292214Z",
"endTime": "2025-07-24T23:24:38.126749062Z",
"updateTime": "2025-07-24T23:24:38.126749062Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e4116c281b412e671587a848a1b58fd2c3780cbf",
"ref": "refs/heads/main"
}
}
}
[23:24:38.437] Invocation finished in 1h42m52.951911896s with status SUCCEEDED