[20:30:31.023] New invocation is queued and will start shortly
[20:30:32.894] Starting the invocation (attempt 1)
[20:30:32.935] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/65d04a28572f16e29b18bf054e76bda11b923b92"
[20:30:32.935] Popped gitiles commit info from properties and tags
[20:30:32.935] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:32.935] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:32.935] Buildbucket request:
{
"requestId": "8837170348634270816",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8837170348634270816",
"job": "fuchsia/global.ci-core.arm64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "671fb8d4055b45b4970961d0948e54b2ff05d63a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@671fb8d4055b45b4970961d0948e54b2ff05d63a",
"title": "671fb8d4055b45b4970961d0948e54b2ff05d63a",
"url": "https://fuchsia.googlesource.com/integration/+/671fb8d4055b45b4970961d0948e54b2ff05d63a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9081a64b474263d965c35c8203caa2c104a4d043"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9081a64b474263d965c35c8203caa2c104a4d043",
"title": "9081a64b474263d965c35c8203caa2c104a4d043",
"url": "https://fuchsia.googlesource.com/integration/+/9081a64b474263d965c35c8203caa2c104a4d043"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3904627df271ed1019d1eb366b8e62cf88d34da4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3904627df271ed1019d1eb366b8e62cf88d34da4",
"title": "3904627df271ed1019d1eb366b8e62cf88d34da4",
"url": "https://fuchsia.googlesource.com/integration/+/3904627df271ed1019d1eb366b8e62cf88d34da4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d498d996e08748eab3be9fe8bb996c1b75ef40e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d498d996e08748eab3be9fe8bb996c1b75ef40e",
"title": "7d498d996e08748eab3be9fe8bb996c1b75ef40e",
"url": "https://fuchsia.googlesource.com/integration/+/7d498d996e08748eab3be9fe8bb996c1b75ef40e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1dbad508be49458c80f5e6dbae7e0f977c235cdf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1dbad508be49458c80f5e6dbae7e0f977c235cdf",
"title": "1dbad508be49458c80f5e6dbae7e0f977c235cdf",
"url": "https://fuchsia.googlesource.com/integration/+/1dbad508be49458c80f5e6dbae7e0f977c235cdf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a7ce9150e341bb3836e7196f5b1063d758d95d0c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a7ce9150e341bb3836e7196f5b1063d758d95d0c",
"title": "a7ce9150e341bb3836e7196f5b1063d758d95d0c",
"url": "https://fuchsia.googlesource.com/integration/+/a7ce9150e341bb3836e7196f5b1063d758d95d0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "47372a66be938f372bae64fd3a9cf2a862aa6a9b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@47372a66be938f372bae64fd3a9cf2a862aa6a9b",
"title": "47372a66be938f372bae64fd3a9cf2a862aa6a9b",
"url": "https://fuchsia.googlesource.com/integration/+/47372a66be938f372bae64fd3a9cf2a862aa6a9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5089003b47281463e5a94b955d0d98a1047a1789"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5089003b47281463e5a94b955d0d98a1047a1789",
"title": "5089003b47281463e5a94b955d0d98a1047a1789",
"url": "https://fuchsia.googlesource.com/integration/+/5089003b47281463e5a94b955d0d98a1047a1789"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "839cc62cf5cb2d8ab03265b2bb0852187b8ef012"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@839cc62cf5cb2d8ab03265b2bb0852187b8ef012",
"title": "839cc62cf5cb2d8ab03265b2bb0852187b8ef012",
"url": "https://fuchsia.googlesource.com/integration/+/839cc62cf5cb2d8ab03265b2bb0852187b8ef012"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "19bca9dec7f2ce88ff22503bcb5654138a7435b9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@19bca9dec7f2ce88ff22503bcb5654138a7435b9",
"title": "19bca9dec7f2ce88ff22503bcb5654138a7435b9",
"url": "https://fuchsia.googlesource.com/integration/+/19bca9dec7f2ce88ff22503bcb5654138a7435b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "997ed00c56fde5b6976e7728e690f66059124322"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@997ed00c56fde5b6976e7728e690f66059124322",
"title": "997ed00c56fde5b6976e7728e690f66059124322",
"url": "https://fuchsia.googlesource.com/integration/+/997ed00c56fde5b6976e7728e690f66059124322"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f3ace418ab6c1c980afe21de818dca8039c38630"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f3ace418ab6c1c980afe21de818dca8039c38630",
"title": "f3ace418ab6c1c980afe21de818dca8039c38630",
"url": "https://fuchsia.googlesource.com/integration/+/f3ace418ab6c1c980afe21de818dca8039c38630"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "83563d41c7ae0129944ddddbf19b8e8a58f8a304"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@83563d41c7ae0129944ddddbf19b8e8a58f8a304",
"title": "83563d41c7ae0129944ddddbf19b8e8a58f8a304",
"url": "https://fuchsia.googlesource.com/integration/+/83563d41c7ae0129944ddddbf19b8e8a58f8a304"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0c67128c0bf2926dfa7808fae7d5eb9dae30c942"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0c67128c0bf2926dfa7808fae7d5eb9dae30c942",
"title": "0c67128c0bf2926dfa7808fae7d5eb9dae30c942",
"url": "https://fuchsia.googlesource.com/integration/+/0c67128c0bf2926dfa7808fae7d5eb9dae30c942"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "65d04a28572f16e29b18bf054e76bda11b923b92"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@65d04a28572f16e29b18bf054e76bda11b923b92",
"title": "65d04a28572f16e29b18bf054e76bda11b923b92",
"url": "https://fuchsia.googlesource.com/integration/+/65d04a28572f16e29b18bf054e76bda11b923b92"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "65d04a28572f16e29b18bf054e76bda11b923b92",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8837170348634270816"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-debug-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:30:33.377] Scheduled build:
{
"id": "8671740285895576273",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-02T20:30:33.003819565Z",
"updateTime": "2026-09-02T20:30:33.003819565Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "65d04a28572f16e29b18bf054e76bda11b923b92",
"ref": "refs/heads/main"
}
}
}
[20:30:33.377] Task URL: https://cr-buildbucket.appspot.com/build/8671740285895576273
[20:30:33.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:2:0) after 7m51s
[20:30:34.419] Received PubSub notification, asking Buildbucket for the build status
[20:30:34.446] Build status: SCHEDULED
[20:30:37.240] Received PubSub notification, asking Buildbucket for the build status
[20:30:37.450] Build status: STARTED
[20:38:24.401] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:2:0)
[20:38:24.424] Build status: STARTED
[20:38:24.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:5:0) after 1m29s
[20:39:53.444] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:5:0)
[20:39:53.529] Build status: STARTED
[20:39:53.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:6:0) after 3m5s
[20:42:58.557] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:6:0)
[20:42:58.578] Build status: STARTED
[20:42:58.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:7:0) after 4m3s
[20:47:01.602] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:7:0)
[20:47:01.624] Build status: STARTED
[20:47:01.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:8:0) after 3m20s
[20:50:21.671] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:8:0)
[20:50:21.696] Build status: STARTED
[20:50:21.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:9:0) after 8m14s
[20:58:35.690] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:9:0)
[20:58:35.711] Build status: STARTED
[20:58:35.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:10:0) after 3m22s
[21:01:57.782] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:10:0)
[21:01:57.800] Build status: STARTED
[21:01:57.800] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:11:0) after 7m55s
[21:09:52.843] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:11:0)
[21:09:52.865] Build status: STARTED
[21:09:52.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:12:0) after 7m22s
[21:17:14.886] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:12:0)
[21:17:14.921] Build status: STARTED
[21:17:14.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:13:0) after 6m25s
[21:23:39.916] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:13:0)
[21:23:39.965] Build status: STARTED
[21:23:39.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:14:0) after 4m27s
[21:28:07.005] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:14:0)
[21:28:07.098] Build status: STARTED
[21:28:07.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:15:0) after 2m5s
[21:30:12.194] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:15:0)
[21:30:12.215] Build status: STARTED
[21:30:12.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:16:0) after 2m30s
[21:32:42.299] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:16:0)
[21:32:42.319] Build status: STARTED
[21:32:42.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:17:0) after 3m13s
[21:35:55.372] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:17:0)
[21:35:55.405] Build status: STARTED
[21:35:55.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:18:0) after 6m4s
[21:41:59.396] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:18:0)
[21:41:59.417] Build status: STARTED
[21:41:59.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:19:0) after 8m34s
[21:50:33.520] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:19:0)
[21:50:33.571] Build status: STARTED
[21:50:33.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:20:0) after 5m19s
[21:55:52.628] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:20:0)
[21:55:52.643] Build status: STARTED
[21:55:52.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:21:0) after 2m55s
[21:58:47.750] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:21:0)
[21:58:47.772] Build status: STARTED
[21:58:47.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:22:0) after 1m40s
[22:00:27.792] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:22:0)
[22:00:27.818] Build status: STARTED
[22:00:27.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:23:0) after 4m31s
[22:04:58.837] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:23:0)
[22:04:58.868] Build status: STARTED
[22:04:58.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8837170348634270816:24:0) after 8m19s
[22:08:24.366] Received PubSub notification, asking Buildbucket for the build status
[22:08:24.400] Build:
{
"id": "8671740285895576273",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-02T20:30:33.003819565Z",
"startTime": "2026-09-02T20:30:37.041234163Z",
"endTime": "2026-09-02T22:08:22.391595580Z",
"updateTime": "2026-09-02T22:08:22.391595580Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "65d04a28572f16e29b18bf054e76bda11b923b92",
"ref": "refs/heads/main"
}
}
}
[22:08:24.400] Invocation finished in 1h37m53.392522881s with status SUCCEEDED