[01:12:48.087] New invocation is queued and will start shortly
[01:12:49.196] Starting the invocation (attempt 1)
[01:12:49.223] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/dbd71472c827c6d88a5bd63546aaf57a9f1f32a0"
[01:12:49.223] Popped gitiles commit info from properties and tags
[01:12:49.223] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:12:49.223] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:12:49.224] Buildbucket request:
{
"requestId": "8898849122946509680",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "core.arm64-profile-qemu_kvm"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8898849122946509680",
"job": "fuchsia/core.arm64-profile-qemu_kvm-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0516c72a3ca84fb25d374f9f2c5a8d89a5fa4d67"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0516c72a3ca84fb25d374f9f2c5a8d89a5fa4d67",
"title": "0516c72a3ca84fb25d374f9f2c5a8d89a5fa4d67",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0516c72a3ca84fb25d374f9f2c5a8d89a5fa4d67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "4e84cce8512bfd3c229cce6226fa5aa2c2999075"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@4e84cce8512bfd3c229cce6226fa5aa2c2999075",
"title": "4e84cce8512bfd3c229cce6226fa5aa2c2999075",
"url": "https://fuchsia.googlesource.com/fuchsia/+/4e84cce8512bfd3c229cce6226fa5aa2c2999075"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "628bae3108ec134f5876a319c7b20b67e096b5df"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@628bae3108ec134f5876a319c7b20b67e096b5df",
"title": "628bae3108ec134f5876a319c7b20b67e096b5df",
"url": "https://fuchsia.googlesource.com/fuchsia/+/628bae3108ec134f5876a319c7b20b67e096b5df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0ff9e400fc03ed3259ec019dfa593b9cbd320263"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0ff9e400fc03ed3259ec019dfa593b9cbd320263",
"title": "0ff9e400fc03ed3259ec019dfa593b9cbd320263",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0ff9e400fc03ed3259ec019dfa593b9cbd320263"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "eddd1eb439d3a79b286c42556c5f083ba7396d7c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@eddd1eb439d3a79b286c42556c5f083ba7396d7c",
"title": "eddd1eb439d3a79b286c42556c5f083ba7396d7c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/eddd1eb439d3a79b286c42556c5f083ba7396d7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "adc9634e9b1fcec6f63f761f59ef6c6939a63fad"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@adc9634e9b1fcec6f63f761f59ef6c6939a63fad",
"title": "adc9634e9b1fcec6f63f761f59ef6c6939a63fad",
"url": "https://fuchsia.googlesource.com/fuchsia/+/adc9634e9b1fcec6f63f761f59ef6c6939a63fad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "f57a9328c203f7b989771972d623aca0b1947ba9"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@f57a9328c203f7b989771972d623aca0b1947ba9",
"title": "f57a9328c203f7b989771972d623aca0b1947ba9",
"url": "https://fuchsia.googlesource.com/fuchsia/+/f57a9328c203f7b989771972d623aca0b1947ba9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "749530575721fe1db6fa9adad6ed107cfab75ff9"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@749530575721fe1db6fa9adad6ed107cfab75ff9",
"title": "749530575721fe1db6fa9adad6ed107cfab75ff9",
"url": "https://fuchsia.googlesource.com/fuchsia/+/749530575721fe1db6fa9adad6ed107cfab75ff9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "69a50e8bb7c1a574b90676fa7c9815d4a72448ee"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@69a50e8bb7c1a574b90676fa7c9815d4a72448ee",
"title": "69a50e8bb7c1a574b90676fa7c9815d4a72448ee",
"url": "https://fuchsia.googlesource.com/fuchsia/+/69a50e8bb7c1a574b90676fa7c9815d4a72448ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "8b65b6655f1e1f66bc40bf811bcb2b02bfa05dfe"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@8b65b6655f1e1f66bc40bf811bcb2b02bfa05dfe",
"title": "8b65b6655f1e1f66bc40bf811bcb2b02bfa05dfe",
"url": "https://fuchsia.googlesource.com/fuchsia/+/8b65b6655f1e1f66bc40bf811bcb2b02bfa05dfe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "9c0d3e33f87358630ec4ff0268523ebb630d3add"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@9c0d3e33f87358630ec4ff0268523ebb630d3add",
"title": "9c0d3e33f87358630ec4ff0268523ebb630d3add",
"url": "https://fuchsia.googlesource.com/fuchsia/+/9c0d3e33f87358630ec4ff0268523ebb630d3add"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "b43daadbb552a8c48ccb06a54f5586af093cd349"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@b43daadbb552a8c48ccb06a54f5586af093cd349",
"title": "b43daadbb552a8c48ccb06a54f5586af093cd349",
"url": "https://fuchsia.googlesource.com/fuchsia/+/b43daadbb552a8c48ccb06a54f5586af093cd349"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "350216054d24b1b31a050451e0694e9470546bd5"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@350216054d24b1b31a050451e0694e9470546bd5",
"title": "350216054d24b1b31a050451e0694e9470546bd5",
"url": "https://fuchsia.googlesource.com/fuchsia/+/350216054d24b1b31a050451e0694e9470546bd5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "4d09bc38185a196fdfc640d8e6db9cf719944cf6"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@4d09bc38185a196fdfc640d8e6db9cf719944cf6",
"title": "4d09bc38185a196fdfc640d8e6db9cf719944cf6",
"url": "https://fuchsia.googlesource.com/fuchsia/+/4d09bc38185a196fdfc640d8e6db9cf719944cf6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "dbd71472c827c6d88a5bd63546aaf57a9f1f32a0"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@dbd71472c827c6d88a5bd63546aaf57a9f1f32a0",
"title": "dbd71472c827c6d88a5bd63546aaf57a9f1f32a0",
"url": "https://fuchsia.googlesource.com/fuchsia/+/dbd71472c827c6d88a5bd63546aaf57a9f1f32a0"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "dbd71472c827c6d88a5bd63546aaf57a9f1f32a0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8898849122946509680"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-profile-qemu_kvm-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:12:49.632] Scheduled build:
{
"id": "8733419061036300993",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "core.arm64-profile-qemu_kvm"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-22T01:12:49.284927880Z",
"updateTime": "2024-10-22T01:12:49.284927880Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "dbd71472c827c6d88a5bd63546aaf57a9f1f32a0",
"ref": "refs/heads/main"
}
}
}
[01:12:49.632] Task URL: https://cr-buildbucket.appspot.com/build/8733419061036300993
[01:12:49.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:2:0) after 8m43s
[01:12:50.621] Received PubSub notification, asking Buildbucket for the build status
[01:12:50.640] Build status: SCHEDULED
[01:12:55.599] Received PubSub notification, asking Buildbucket for the build status
[01:12:55.646] Build status: STARTED
[01:21:32.647] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:2:0)
[01:21:32.726] Build status: STARTED
[01:21:32.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:5:0) after 8m18s
[01:29:50.778] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:5:0)
[01:29:50.799] Build status: STARTED
[01:29:50.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:6:0) after 7m5s
[01:36:55.910] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:6:0)
[01:36:55.935] Build status: STARTED
[01:36:55.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:7:0) after 6m8s
[01:43:03.950] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:7:0)
[01:43:03.971] Build status: STARTED
[01:43:03.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:8:0) after 5m48s
[01:48:51.988] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:8:0)
[01:48:52.006] Build status: STARTED
[01:48:52.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:9:0) after 5m44s
[01:54:36.045] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:9:0)
[01:54:36.062] Build status: STARTED
[01:54:36.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:10:0) after 6m41s
[02:01:17.054] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:10:0)
[02:01:17.082] Build status: STARTED
[02:01:17.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:11:0) after 2m40s
[02:03:57.198] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:11:0)
[02:03:57.215] Build status: STARTED
[02:03:57.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-profile-qemu_kvm-af244ac6:8898849122946509680:12:0) after 3m49s
[02:06:22.801] Received PubSub notification, asking Buildbucket for the build status
[02:06:22.827] Build:
{
"id": "8733419061036300993",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "core.arm64-profile-qemu_kvm"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-22T01:12:49.284927880Z",
"startTime": "2024-10-22T01:12:55.392191138Z",
"endTime": "2024-10-22T02:06:21.923509413Z",
"updateTime": "2024-10-22T02:06:21.923509413Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "dbd71472c827c6d88a5bd63546aaf57a9f1f32a0",
"ref": "refs/heads/main"
}
}
}
[02:06:22.828] Invocation finished in 53m34.749026353s with status SUCCEEDED