[14:41:54.978] New invocation is queued and will start shortly
[14:41:56.161] Starting the invocation (attempt 1)
[14:41:56.192] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/49877625c97143ff19e63ac87df5d7094a9377ea"
[14:41:56.192] Popped gitiles commit info from properties and tags
[14:41:56.192] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:41:56.193] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:41:56.193] Buildbucket request:
{
"requestId": "8864008982746719200",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "qemu-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8864008982746719200",
"job": "fuchsia/prod-qemu-mac-arm64-74eaa511",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "9d1bccac8f1090a51468fddccfeb6e0c92bcb9ca"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@9d1bccac8f1090a51468fddccfeb6e0c92bcb9ca",
"title": "9d1bccac8f1090a51468fddccfeb6e0c92bcb9ca",
"url": "https://qemu.googlesource.com/qemu/+/9d1bccac8f1090a51468fddccfeb6e0c92bcb9ca"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "32878c6b4a2e399435bea0d0a2075c9379e55473"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@32878c6b4a2e399435bea0d0a2075c9379e55473",
"title": "32878c6b4a2e399435bea0d0a2075c9379e55473",
"url": "https://qemu.googlesource.com/qemu/+/32878c6b4a2e399435bea0d0a2075c9379e55473"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "343166a084c522e8090bea6e8ef0137e85759591"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@343166a084c522e8090bea6e8ef0137e85759591",
"title": "343166a084c522e8090bea6e8ef0137e85759591",
"url": "https://qemu.googlesource.com/qemu/+/343166a084c522e8090bea6e8ef0137e85759591"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "54c1e9cdeee71b84f1e78d01f3e083cf5158bd08"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@54c1e9cdeee71b84f1e78d01f3e083cf5158bd08",
"title": "54c1e9cdeee71b84f1e78d01f3e083cf5158bd08",
"url": "https://qemu.googlesource.com/qemu/+/54c1e9cdeee71b84f1e78d01f3e083cf5158bd08"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "2dd1d20b0932fb5c29960fa5c1e57fb11e490413"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@2dd1d20b0932fb5c29960fa5c1e57fb11e490413",
"title": "2dd1d20b0932fb5c29960fa5c1e57fb11e490413",
"url": "https://qemu.googlesource.com/qemu/+/2dd1d20b0932fb5c29960fa5c1e57fb11e490413"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "0336727f4859ee9ed1fbb7e88f4e22f6e08fab92"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@0336727f4859ee9ed1fbb7e88f4e22f6e08fab92",
"title": "0336727f4859ee9ed1fbb7e88f4e22f6e08fab92",
"url": "https://qemu.googlesource.com/qemu/+/0336727f4859ee9ed1fbb7e88f4e22f6e08fab92"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "8c1fa9cbecba50ae7e732923ee567fe40551d1a6"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@8c1fa9cbecba50ae7e732923ee567fe40551d1a6",
"title": "8c1fa9cbecba50ae7e732923ee567fe40551d1a6",
"url": "https://qemu.googlesource.com/qemu/+/8c1fa9cbecba50ae7e732923ee567fe40551d1a6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "98d7c299415bb21b5fa6e44020df608acfea729f"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@98d7c299415bb21b5fa6e44020df608acfea729f",
"title": "98d7c299415bb21b5fa6e44020df608acfea729f",
"url": "https://qemu.googlesource.com/qemu/+/98d7c299415bb21b5fa6e44020df608acfea729f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "31dd80e1e7a237cb7a096589b726801c085ebb19"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@31dd80e1e7a237cb7a096589b726801c085ebb19",
"title": "31dd80e1e7a237cb7a096589b726801c085ebb19",
"url": "https://qemu.googlesource.com/qemu/+/31dd80e1e7a237cb7a096589b726801c085ebb19"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "1ca08107c54227580786527db28fb77440f62391"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@1ca08107c54227580786527db28fb77440f62391",
"title": "1ca08107c54227580786527db28fb77440f62391",
"url": "https://qemu.googlesource.com/qemu/+/1ca08107c54227580786527db28fb77440f62391"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "290e4e7de7a579be7457bfbc338b697b8eea638f"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@290e4e7de7a579be7457bfbc338b697b8eea638f",
"title": "290e4e7de7a579be7457bfbc338b697b8eea638f",
"url": "https://qemu.googlesource.com/qemu/+/290e4e7de7a579be7457bfbc338b697b8eea638f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "4f503afc7eb503997fedad84f24e2cdf696a7a0e"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@4f503afc7eb503997fedad84f24e2cdf696a7a0e",
"title": "4f503afc7eb503997fedad84f24e2cdf696a7a0e",
"url": "https://qemu.googlesource.com/qemu/+/4f503afc7eb503997fedad84f24e2cdf696a7a0e"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "681480a1391b32c6d4474d4426ce3371eed06fa9"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@681480a1391b32c6d4474d4426ce3371eed06fa9",
"title": "681480a1391b32c6d4474d4426ce3371eed06fa9",
"url": "https://qemu.googlesource.com/qemu/+/681480a1391b32c6d4474d4426ce3371eed06fa9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://qemu.googlesource.com/qemu",
"revision": "49877625c97143ff19e63ac87df5d7094a9377ea"
},
"id": "https://qemu.googlesource.com/qemu/+/refs/heads/master@49877625c97143ff19e63ac87df5d7094a9377ea",
"title": "49877625c97143ff19e63ac87df5d7094a9377ea",
"url": "https://qemu.googlesource.com/qemu/+/49877625c97143ff19e63ac87df5d7094a9377ea"
}
]
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "49877625c97143ff19e63ac87df5d7094a9377ea",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8864008982746719200"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-qemu-mac-arm64-74eaa511"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:41:56.573] Scheduled build:
{
"id": "8698578920768012785",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "qemu-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-10T14:41:56.238565095Z",
"updateTime": "2025-11-10T14:41:56.238565095Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "49877625c97143ff19e63ac87df5d7094a9377ea",
"ref": "refs/heads/master"
}
}
}
[14:41:56.573] Task URL: https://cr-buildbucket.appspot.com/build/8698578920768012785
[14:41:56.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:2:0) after 3m49s
[14:41:56.960] Received PubSub notification, asking Buildbucket for the build status
[14:41:56.975] Build status: SCHEDULED
[14:45:46.718] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:2:0)
[14:45:46.745] Build status: SCHEDULED
[14:45:46.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:4:0) after 4m6s
[14:49:52.861] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:4:0)
[14:49:52.876] Build status: SCHEDULED
[14:49:52.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:5:0) after 1m35s
[14:51:27.890] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:5:0)
[14:51:27.913] Build status: SCHEDULED
[14:51:27.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:6:0) after 7m52s
[14:59:19.934] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:6:0)
[14:59:19.994] Build status: SCHEDULED
[14:59:19.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:7:0) after 4m46s
[15:04:06.211] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:7:0)
[15:04:06.231] Build status: SCHEDULED
[15:04:06.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:8:0) after 6m42s
[15:10:48.290] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:8:0)
[15:10:48.305] Build status: SCHEDULED
[15:10:48.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:9:0) after 9m58s
[15:20:46.423] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:9:0)
[15:20:46.518] Build status: SCHEDULED
[15:20:46.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:10:0) after 1m34s
[15:22:20.644] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:10:0)
[15:22:20.696] Build status: SCHEDULED
[15:22:20.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:11:0) after 5m50s
[15:28:10.769] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:11:0)
[15:28:10.797] Build status: SCHEDULED
[15:28:10.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:12:0) after 1m9s
[15:29:19.964] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:12:0)
[15:29:19.979] Build status: SCHEDULED
[15:29:19.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:13:0) after 8m50s
[15:38:10.017] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:13:0)
[15:38:10.036] Build status: SCHEDULED
[15:38:10.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:14:0) after 1m15s
[15:39:25.157] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:14:0)
[15:39:25.247] Build status: SCHEDULED
[15:39:25.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:15:0) after 6m27s
[15:45:52.271] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:15:0)
[15:45:52.298] Build status: SCHEDULED
[15:45:52.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:16:0) after 1m14s
[15:47:06.324] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:16:0)
[15:47:06.392] Build status: SCHEDULED
[15:47:06.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:17:0) after 7m34s
[15:54:40.458] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:17:0)
[15:54:40.479] Build status: SCHEDULED
[15:54:40.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:18:0) after 3m40s
[15:58:20.506] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:18:0)
[15:58:20.521] Build status: SCHEDULED
[15:58:20.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:19:0) after 3m36s
[16:01:56.536] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:19:0)
[16:01:56.554] Build status: SCHEDULED
[16:01:56.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:20:0) after 7m34s
[16:09:30.572] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:20:0)
[16:09:30.594] Build status: SCHEDULED
[16:09:30.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:21:0) after 7m48s
[16:17:18.666] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:21:0)
[16:17:18.682] Build status: SCHEDULED
[16:17:18.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:22:0) after 3m22s
[16:20:40.694] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:22:0)
[16:20:40.745] Build status: SCHEDULED
[16:20:40.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:23:0) after 7m31s
[16:28:11.762] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:23:0)
[16:28:11.777] Build status: SCHEDULED
[16:28:11.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:24:0) after 1m17s
[16:29:28.805] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:24:0)
[16:29:28.819] Build status: SCHEDULED
[16:29:28.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:25:0) after 5m42s
[16:35:11.011] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:25:0)
[16:35:11.025] Build status: SCHEDULED
[16:35:11.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:26:0) after 9m21s
[16:40:15.525] Received PubSub notification, asking Buildbucket for the build status
[16:40:15.579] Build status: STARTED
[16:44:32.058] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:26:0)
[16:44:32.072] Build status: STARTED
[16:44:32.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:28:0) after 4m53s
[16:49:25.087] Handling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:28:0)
[16:49:25.105] Build status: STARTED
[16:49:25.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-qemu-mac-arm64-74eaa511:8864008982746719200:29:0) after 9m45s
[16:53:50.109] Received PubSub notification, asking Buildbucket for the build status
[16:53:50.125] Build:
{
"id": "8698578920768012785",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "qemu-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-10T14:41:56.238565095Z",
"startTime": "2025-11-10T16:40:13.312586307Z",
"endTime": "2025-11-10T16:53:49.782449953Z",
"updateTime": "2025-11-10T16:53:49.782449953Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "49877625c97143ff19e63ac87df5d7094a9377ea",
"ref": "refs/heads/master"
}
}
}
[16:53:50.125] Invocation finished in 2h11m55.157290617s with status SUCCEEDED