[04:00:48.527] New invocation is queued and will start shortly
[04:00:49.741] Starting the invocation (attempt 1)
[04:00:49.766] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/1111f065fbc0c9d3b8c15590c614dc705c65dd41"
[04:00:49.766] Popped gitiles commit info from properties and tags
[04:00:49.766] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:49.766] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:49.766] Buildbucket request:
{
"requestId": "8843574403335214480",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8843574403335214480",
"job": "fuchsia/global.ci-core.arm64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2f71884d81a316f5a97513a73171fde071a4285"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2f71884d81a316f5a97513a73171fde071a4285",
"title": "d2f71884d81a316f5a97513a73171fde071a4285",
"url": "https://fuchsia.googlesource.com/integration/+/d2f71884d81a316f5a97513a73171fde071a4285"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "01d8732ad72d8dea461b5497766322ca96cacfa0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@01d8732ad72d8dea461b5497766322ca96cacfa0",
"title": "01d8732ad72d8dea461b5497766322ca96cacfa0",
"url": "https://fuchsia.googlesource.com/integration/+/01d8732ad72d8dea461b5497766322ca96cacfa0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59df974362ac2cf9afdb5d6a89cab18e84dacbc9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59df974362ac2cf9afdb5d6a89cab18e84dacbc9",
"title": "59df974362ac2cf9afdb5d6a89cab18e84dacbc9",
"url": "https://fuchsia.googlesource.com/integration/+/59df974362ac2cf9afdb5d6a89cab18e84dacbc9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9cd12dacdf8b955e46ac90a6f8b4ead30c434eff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9cd12dacdf8b955e46ac90a6f8b4ead30c434eff",
"title": "9cd12dacdf8b955e46ac90a6f8b4ead30c434eff",
"url": "https://fuchsia.googlesource.com/integration/+/9cd12dacdf8b955e46ac90a6f8b4ead30c434eff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7e5a1f14f1f33bcdeef12062a48a08ba655397ee"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7e5a1f14f1f33bcdeef12062a48a08ba655397ee",
"title": "7e5a1f14f1f33bcdeef12062a48a08ba655397ee",
"url": "https://fuchsia.googlesource.com/integration/+/7e5a1f14f1f33bcdeef12062a48a08ba655397ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "840e646a2d51e68e7f521fd7ef4dcae223b47300"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@840e646a2d51e68e7f521fd7ef4dcae223b47300",
"title": "840e646a2d51e68e7f521fd7ef4dcae223b47300",
"url": "https://fuchsia.googlesource.com/integration/+/840e646a2d51e68e7f521fd7ef4dcae223b47300"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "83835faf325582f64bceec59af9414db59e78eb1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@83835faf325582f64bceec59af9414db59e78eb1",
"title": "83835faf325582f64bceec59af9414db59e78eb1",
"url": "https://fuchsia.googlesource.com/integration/+/83835faf325582f64bceec59af9414db59e78eb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a142f9e5575b03e010a38e0265d55c885bdf650e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a142f9e5575b03e010a38e0265d55c885bdf650e",
"title": "a142f9e5575b03e010a38e0265d55c885bdf650e",
"url": "https://fuchsia.googlesource.com/integration/+/a142f9e5575b03e010a38e0265d55c885bdf650e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "154fa336c9871ccdba4f2f588a1ebda450a94508"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@154fa336c9871ccdba4f2f588a1ebda450a94508",
"title": "154fa336c9871ccdba4f2f588a1ebda450a94508",
"url": "https://fuchsia.googlesource.com/integration/+/154fa336c9871ccdba4f2f588a1ebda450a94508"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "67f6ea90ce37b34f2caceeee44eb7d2d32e254eb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@67f6ea90ce37b34f2caceeee44eb7d2d32e254eb",
"title": "67f6ea90ce37b34f2caceeee44eb7d2d32e254eb",
"url": "https://fuchsia.googlesource.com/integration/+/67f6ea90ce37b34f2caceeee44eb7d2d32e254eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6970c1c72d4c498e3c7fdc9b08b29ec0ba9a381e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6970c1c72d4c498e3c7fdc9b08b29ec0ba9a381e",
"title": "6970c1c72d4c498e3c7fdc9b08b29ec0ba9a381e",
"url": "https://fuchsia.googlesource.com/integration/+/6970c1c72d4c498e3c7fdc9b08b29ec0ba9a381e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8b87644b0c5dd8c57c8143cde0b5e6203ff39852"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8b87644b0c5dd8c57c8143cde0b5e6203ff39852",
"title": "8b87644b0c5dd8c57c8143cde0b5e6203ff39852",
"url": "https://fuchsia.googlesource.com/integration/+/8b87644b0c5dd8c57c8143cde0b5e6203ff39852"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e274c9328fb0992620f5802a6058851d510d9996"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e274c9328fb0992620f5802a6058851d510d9996",
"title": "e274c9328fb0992620f5802a6058851d510d9996",
"url": "https://fuchsia.googlesource.com/integration/+/e274c9328fb0992620f5802a6058851d510d9996"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1111f065fbc0c9d3b8c15590c614dc705c65dd41"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1111f065fbc0c9d3b8c15590c614dc705c65dd41",
"title": "1111f065fbc0c9d3b8c15590c614dc705c65dd41",
"url": "https://fuchsia.googlesource.com/integration/+/1111f065fbc0c9d3b8c15590c614dc705c65dd41"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1111f065fbc0c9d3b8c15590c614dc705c65dd41",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8843574403335214480"
},
{
"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"
}
}
[04:00:50.123] Scheduled build:
{
"id": "8678144341310451313",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-24T04:00:49.833416548Z",
"updateTime": "2026-06-24T04:00:49.833416548Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1111f065fbc0c9d3b8c15590c614dc705c65dd41",
"ref": "refs/heads/main"
}
}
}
[04:00:50.123] Task URL: https://cr-buildbucket.appspot.com/build/8678144341310451313
[04:00:50.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:2:0) after 5m17s
[04:00:50.225] Received PubSub notification, asking Buildbucket for the build status
[04:00:50.249] Build status: SCHEDULED
[04:06:07.118] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:2:0)
[04:06:07.139] Build status: SCHEDULED
[04:06:07.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:4:0) after 2m53s
[04:06:13.117] Received PubSub notification, asking Buildbucket for the build status
[04:06:13.137] Build status: STARTED
[04:09:00.205] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:4:0)
[04:09:00.223] Build status: STARTED
[04:09:00.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:6:0) after 3m42s
[04:12:42.296] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:6:0)
[04:12:42.643] Build status: STARTED
[04:12:42.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:7:0) after 1m57s
[04:14:39.659] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:7:0)
[04:14:39.676] Build status: STARTED
[04:14:39.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:8:0) after 7m16s
[04:21:55.814] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:8:0)
[04:21:55.891] Build status: STARTED
[04:21:55.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:9:0) after 7m52s
[04:29:47.935] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:9:0)
[04:29:47.964] Build status: STARTED
[04:29:47.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:10:0) after 3m10s
[04:32:58.004] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:10:0)
[04:32:58.047] Build status: STARTED
[04:32:58.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:11:0) after 4m16s
[04:37:14.065] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:11:0)
[04:37:14.149] Build status: STARTED
[04:37:14.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:12:0) after 3m18s
[04:40:32.148] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:12:0)
[04:40:32.166] Build status: STARTED
[04:40:32.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:13:0) after 1m10s
[04:41:42.230] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:13:0)
[04:41:42.249] Build status: STARTED
[04:41:42.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:14:0) after 7m5s
[04:48:47.329] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:14:0)
[04:48:47.345] Build status: STARTED
[04:48:47.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:15:0) after 8m25s
[04:57:12.509] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:15:0)
[04:57:12.581] Build status: STARTED
[04:57:12.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:16:0) after 1m51s
[04:59:03.676] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:16:0)
[04:59:03.693] Build status: STARTED
[04:59:03.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:17:0) after 9m19s
[05:08:22.742] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:17:0)
[05:08:22.759] Build status: STARTED
[05:08:22.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:18:0) after 8m8s
[05:16:30.777] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:18:0)
[05:16:30.799] Build status: STARTED
[05:16:30.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:19:0) after 4m19s
[05:20:49.897] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:19:0)
[05:20:49.910] Build status: STARTED
[05:20:49.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:20:0) after 8m36s
[05:29:25.932] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:20:0)
[05:29:25.953] Build status: STARTED
[05:29:25.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8843574403335214480:21:0) after 4m53s
[05:33:54.634] Received PubSub notification, asking Buildbucket for the build status
[05:33:54.653] Build:
{
"id": "8678144341310451313",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-24T04:00:49.833416548Z",
"startTime": "2026-06-24T04:06:12.899976669Z",
"endTime": "2026-06-24T05:33:54.138784459Z",
"updateTime": "2026-06-24T05:33:54.138784459Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1111f065fbc0c9d3b8c15590c614dc705c65dd41",
"ref": "refs/heads/main"
}
}
}
[05:33:54.653] Invocation finished in 1h33m6.133935225s with status SUCCEEDED