[20:47:55.202] New invocation is queued and will start shortly
[20:47:55.202] Triggered by user:qemu-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[20:47:56.306] Starting the invocation (attempt 1)
[20:47:56.337] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76"
[20:47:56.337] Reconstructed gitiles commit from tags
[20:47:56.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:47:56.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:47:56.338] Buildbucket request:
{
"requestId": "8845866562500557984",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "qemu.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01e4a3255cbb573cc5037391aca0b4e8216dc859",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"qemu": {
"cas_digest": "6cc5a980ded3fd9da476b38c7483acf65a6bfd4da219f781144c55fb442c9a0c/334",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8845866562500557984",
"job": "fuchsia/global.ci-qemu.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01e4a3255cbb573cc5037391aca0b4e8216dc859",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"qemu": {
"cas_digest": "6cc5a980ded3fd9da476b38c7483acf65a6bfd4da219f781144c55fb442c9a0c/334",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"qemu": {
"git_repository": "https://qemu.googlesource.com/qemu",
"git_revision": "81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76"
}
},
"tags": [
"buildset:commit/gitiles/qemu.googlesource.com/qemu/+/81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76",
"gitiles_ref:refs/heads/main",
"parent_buildername:qemu-linux-x64",
"user_agent:recipe"
]
},
"id": "3010d799-ad25-4446-8526-8ea76fb934a0",
"title": "qemu-linux-x64/0",
"url": "https://cr-buildbucket.appspot.com/build/8680436874794432993"
}
]
},
"qemu": {
"git_repository": "https://qemu.googlesource.com/qemu",
"git_revision": "81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76"
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8845866562500557984"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-qemu.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "qemu-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:47:56.761] Scheduled build:
{
"id": "8680436500582405009",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "qemu.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-29T20:47:56.407461499Z",
"updateTime": "2026-05-29T20:47:56.407461499Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76",
"ref": "refs/heads/main"
}
}
}
[20:47:56.761] Task URL: https://cr-buildbucket.appspot.com/build/8680436500582405009
[20:47:56.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:2:0) after 4m5s
[20:47:57.679] Received PubSub notification, asking Buildbucket for the build status
[20:47:57.696] Build status: SCHEDULED
[20:51:10.478] Received PubSub notification, asking Buildbucket for the build status
[20:51:10.496] Build status: STARTED
[20:52:01.731] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:2:0)
[20:52:01.770] Build status: STARTED
[20:52:01.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:5:0) after 6m49s
[20:58:50.785] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:5:0)
[20:58:50.801] Build status: STARTED
[20:58:50.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:6:0) after 1m54s
[21:00:44.822] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:6:0)
[21:00:44.847] Build status: STARTED
[21:00:44.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:7:0) after 4m56s
[21:05:40.842] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:7:0)
[21:05:40.859] Build status: STARTED
[21:05:40.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:8:0) after 1m56s
[21:07:36.857] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:8:0)
[21:07:36.897] Build status: STARTED
[21:07:36.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:9:0) after 6m5s
[21:13:41.910] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:9:0)
[21:13:41.927] Build status: STARTED
[21:13:41.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:10:0) after 3m5s
[21:16:47.138] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:10:0)
[21:16:47.163] Build status: STARTED
[21:16:47.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:11:0) after 5m9s
[21:21:56.179] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:11:0)
[21:21:56.201] Build status: STARTED
[21:21:56.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:12:0) after 5m28s
[21:27:24.362] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:12:0)
[21:27:24.385] Build status: STARTED
[21:27:24.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:13:0) after 7m9s
[21:34:33.399] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:13:0)
[21:34:33.416] Build status: STARTED
[21:34:33.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:14:0) after 7m37s
[21:42:10.495] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:14:0)
[21:42:10.515] Build status: STARTED
[21:42:10.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:15:0) after 8m44s
[21:50:54.609] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:15:0)
[21:50:54.639] Build status: STARTED
[21:50:54.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:16:0) after 2m44s
[21:53:38.749] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:16:0)
[21:53:38.763] Build status: STARTED
[21:53:38.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:17:0) after 9m47s
[22:03:25.958] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:17:0)
[22:03:25.986] Build status: STARTED
[22:03:25.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:18:0) after 4m14s
[22:07:40.018] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:18:0)
[22:07:40.035] Build status: STARTED
[22:07:40.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:19:0) after 4m19s
[22:11:59.094] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:19:0)
[22:11:59.120] Build status: STARTED
[22:11:59.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:20:0) after 8m2s
[22:20:01.094] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:20:0)
[22:20:01.114] Build status: STARTED
[22:20:01.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:21:0) after 2m31s
[22:22:32.141] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:21:0)
[22:22:32.173] Build status: STARTED
[22:22:32.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-qemu.ci.core.x64-debug:8845866562500557984:22:0) after 5m35s
[22:24:34.852] Received PubSub notification, asking Buildbucket for the build status
[22:24:34.906] Build:
{
"id": "8680436500582405009",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "qemu.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-29T20:47:56.407461499Z",
"startTime": "2026-05-29T20:51:10.317231514Z",
"endTime": "2026-05-29T22:24:34.318915440Z",
"updateTime": "2026-05-29T22:24:34.318915440Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "81cc5f39aa3042e9c0b2ea772b42a2c8b1488e76",
"ref": "refs/heads/main"
}
}
}
[22:24:34.906] Invocation finished in 1h36m39.712602693s with status SUCCEEDED