[15:45:42.424] New invocation is queued and will start shortly
[15:45:42.424] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[15:45:43.696] Starting the invocation (attempt 1)
[15:45:43.722] Popped buildset tag "buildset:commit/gitiles/qemu.googlesource.com/qemu/+/760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0"
[15:45:43.722] Reconstructed gitiles commit from tags
[15:45:43.722] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:45:43.722] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:45:43.722] Buildbucket request:
{
"requestId": "8920990461242680496",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "24e380940d52da315bc9d79b0c717574dc6bae80",
"project": "integration"
},
"qemu": {
"cas_digest": "e1ccb4a05989a534e0de624f19644b8c798f49a0578e494488e265be708005bf/334",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920990461242680496",
"job": "fuchsia/qemu.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "24e380940d52da315bc9d79b0c717574dc6bae80",
"project": "integration"
},
"qemu": {
"cas_digest": "e1ccb4a05989a534e0de624f19644b8c798f49a0578e494488e265be708005bf/334",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"qemu": {
"git_repository": "https://qemu.googlesource.com/qemu",
"git_revision": "760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0"
}
},
"tags": [
"buildset:commit/gitiles/qemu.googlesource.com/qemu/+/760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0",
"gitiles_ref:refs/heads/main",
"parent_buildername:qemu-linux-arm64",
"user_agent:recipe"
]
},
"id": "fff3eca6-26d8-4514-840b-155e96d7265f",
"title": "qemu-linux-arm64/0"
}
]
},
"qemu": {
"git_repository": "https://qemu.googlesource.com/qemu",
"git_revision": "760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0"
}
},
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920990461242680496"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/qemu.ci.core.arm64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "qemu-linux-arm64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:45:44.277] Scheduled build:
{
"id": "8755560399163942113",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-20T15:45:43.781430Z",
"updateTime": "2024-02-20T15:45:43.781430Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0",
"ref": "refs/heads/main"
}
}
}
[15:45:44.277] Task URL: https://cr-buildbucket.appspot.com/build/8755560399163942113
[15:45:44.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:2:0) after 7m21s
[15:45:45.106] Received PubSub notification, asking Buildbucket for the build status
[15:45:45.128] Build status: SCHEDULED
[15:49:39.354] Received PubSub notification, asking Buildbucket for the build status
[15:49:39.442] Build status: STARTED
[15:53:05.293] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:2:0)
[15:53:05.315] Build status: STARTED
[15:53:05.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:5:0) after 6m35s
[15:59:40.377] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:5:0)
[15:59:40.396] Build status: STARTED
[15:59:40.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:6:0) after 7m5s
[16:06:45.433] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:6:0)
[16:06:45.468] Build status: STARTED
[16:06:45.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:7:0) after 4m34s
[16:11:19.573] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:7:0)
[16:11:19.602] Build status: STARTED
[16:11:19.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:8:0) after 2m47s
[16:14:06.626] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:8:0)
[16:14:06.750] Build status: STARTED
[16:14:06.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:9:0) after 4m7s
[16:18:13.791] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:9:0)
[16:18:13.859] Build status: STARTED
[16:18:13.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:10:0) after 6m40s
[16:24:53.885] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:10:0)
[16:24:53.904] Build status: STARTED
[16:24:53.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:11:0) after 9m48s
[16:34:41.935] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:11:0)
[16:34:41.961] Build status: STARTED
[16:34:41.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:12:0) after 2m13s
[16:36:54.992] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:12:0)
[16:36:55.028] Build status: STARTED
[16:36:55.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:13:0) after 6m51s
[16:43:46.045] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:13:0)
[16:43:46.086] Build status: STARTED
[16:43:46.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:14:0) after 7m5s
[16:50:51.118] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:14:0)
[16:50:51.140] Build status: STARTED
[16:50:51.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:15:0) after 2m55s
[16:53:46.205] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:15:0)
[16:53:46.260] Build status: STARTED
[16:53:46.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:16:0) after 2m13s
[16:55:59.295] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:16:0)
[16:55:59.314] Build status: STARTED
[16:55:59.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:17:0) after 7m32s
[17:03:31.362] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:17:0)
[17:03:31.469] Build status: STARTED
[17:03:31.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:18:0) after 4m37s
[17:08:08.915] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:18:0)
[17:08:08.953] Build status: STARTED
[17:08:08.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:19:0) after 6m54s
[17:15:03.069] Handling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:19:0)
[17:15:03.099] Build status: STARTED
[17:15:03.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/qemu.ci.core.arm64-debug:8920990461242680496:20:0) after 8m28s
[17:23:20.430] Received PubSub notification, asking Buildbucket for the build status
[17:23:20.460] Build:
{
"id": "8755560399163942113",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "qemu.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-20T15:45:43.781430Z",
"startTime": "2024-02-20T15:49:38.624192Z",
"endTime": "2024-02-20T17:23:19.486543Z",
"updateTime": "2024-02-20T17:23:19.486543Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "qemu.googlesource.com",
"project": "qemu",
"id": "760b4dcdddba4a40b9fa0eb78fdfc7eda7cb83d0",
"ref": "refs/heads/main"
}
}
}
[17:23:20.460] Invocation finished in 1h37m38.044653371s with status SUCCEEDED