[20:50:09.171] New invocation is queued and will start shortly
[20:50:10.255] Starting the invocation (attempt 1)
[20:50:10.287] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/59347d6a015f48cf280aa744917b048d6e0f4dbb"
[20:50:10.288] Popped gitiles commit info from properties and tags
[20:50:10.288] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:50:10.290] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:50:10.291] Buildbucket request:
{
"requestId": "8907019374342712512",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.qemu-arm64-release-netstack3"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907019374342712512",
"job": "fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "24647bef7befafda457a5d93ed98fb7e529de14d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@24647bef7befafda457a5d93ed98fb7e529de14d",
"title": "24647bef7befafda457a5d93ed98fb7e529de14d",
"url": "https://fuchsia.googlesource.com/integration/+/24647bef7befafda457a5d93ed98fb7e529de14d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3bfcb968a5e8b9efe1c140e7c51caedab968a9bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3bfcb968a5e8b9efe1c140e7c51caedab968a9bd",
"title": "3bfcb968a5e8b9efe1c140e7c51caedab968a9bd",
"url": "https://fuchsia.googlesource.com/integration/+/3bfcb968a5e8b9efe1c140e7c51caedab968a9bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "046eac61a8b26957188b58c24caa265887bbb4a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@046eac61a8b26957188b58c24caa265887bbb4a4",
"title": "046eac61a8b26957188b58c24caa265887bbb4a4",
"url": "https://fuchsia.googlesource.com/integration/+/046eac61a8b26957188b58c24caa265887bbb4a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7b531d7ad735c82b660ba74088f8ec57f8635636"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7b531d7ad735c82b660ba74088f8ec57f8635636",
"title": "7b531d7ad735c82b660ba74088f8ec57f8635636",
"url": "https://fuchsia.googlesource.com/integration/+/7b531d7ad735c82b660ba74088f8ec57f8635636"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e5fed09cabb3d1652504094b84205a8ffc22e093"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e5fed09cabb3d1652504094b84205a8ffc22e093",
"title": "e5fed09cabb3d1652504094b84205a8ffc22e093",
"url": "https://fuchsia.googlesource.com/integration/+/e5fed09cabb3d1652504094b84205a8ffc22e093"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2e86d6f11642e457d75c3e505a76045f5aac927"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2e86d6f11642e457d75c3e505a76045f5aac927",
"title": "d2e86d6f11642e457d75c3e505a76045f5aac927",
"url": "https://fuchsia.googlesource.com/integration/+/d2e86d6f11642e457d75c3e505a76045f5aac927"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6610a4c386b059aec3aa73dcd9d91733c13bf2b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6610a4c386b059aec3aa73dcd9d91733c13bf2b8",
"title": "6610a4c386b059aec3aa73dcd9d91733c13bf2b8",
"url": "https://fuchsia.googlesource.com/integration/+/6610a4c386b059aec3aa73dcd9d91733c13bf2b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c75f29513b4b3835ee159ce1ab178f7eb675a7dd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c75f29513b4b3835ee159ce1ab178f7eb675a7dd",
"title": "c75f29513b4b3835ee159ce1ab178f7eb675a7dd",
"url": "https://fuchsia.googlesource.com/integration/+/c75f29513b4b3835ee159ce1ab178f7eb675a7dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "85af657d25404e946786d9db629e481d0c706a7d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@85af657d25404e946786d9db629e481d0c706a7d",
"title": "85af657d25404e946786d9db629e481d0c706a7d",
"url": "https://fuchsia.googlesource.com/integration/+/85af657d25404e946786d9db629e481d0c706a7d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "717753d0139d67e25bf33f7bcc1ce9d30e16aa5a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@717753d0139d67e25bf33f7bcc1ce9d30e16aa5a",
"title": "717753d0139d67e25bf33f7bcc1ce9d30e16aa5a",
"url": "https://fuchsia.googlesource.com/integration/+/717753d0139d67e25bf33f7bcc1ce9d30e16aa5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "21d526642c77ebe1e6773ea262708b08fae87063"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@21d526642c77ebe1e6773ea262708b08fae87063",
"title": "21d526642c77ebe1e6773ea262708b08fae87063",
"url": "https://fuchsia.googlesource.com/integration/+/21d526642c77ebe1e6773ea262708b08fae87063"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59347d6a015f48cf280aa744917b048d6e0f4dbb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59347d6a015f48cf280aa744917b048d6e0f4dbb",
"title": "59347d6a015f48cf280aa744917b048d6e0f4dbb",
"url": "https://fuchsia.googlesource.com/integration/+/59347d6a015f48cf280aa744917b048d6e0f4dbb"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "59347d6a015f48cf280aa744917b048d6e0f4dbb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907019374342712512"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:50:10.867] Scheduled build:
{
"id": "8741589312402739585",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.qemu-arm64-release-netstack3"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-23T20:50:10.398300162Z",
"updateTime": "2024-07-23T20:50:10.398300162Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "59347d6a015f48cf280aa744917b048d6e0f4dbb",
"ref": "refs/heads/main"
}
}
}
[20:50:10.867] Task URL: https://cr-buildbucket.appspot.com/build/8741589312402739585
[20:50:10.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:2:0) after 3m33s
[20:50:11.766] Received PubSub notification, asking Buildbucket for the build status
[20:50:11.794] Build status: SCHEDULED
[20:50:19.313] Received PubSub notification, asking Buildbucket for the build status
[20:50:19.341] Build status: STARTED
[20:53:43.901] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:2:0)
[20:53:43.943] Build status: STARTED
[20:53:43.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:5:0) after 8m33s
[21:02:17.057] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:5:0)
[21:02:17.075] Build status: STARTED
[21:02:17.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:6:0) after 7m10s
[21:09:27.106] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:6:0)
[21:09:27.135] Build status: STARTED
[21:09:27.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:7:0) after 6m22s
[21:15:49.218] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:7:0)
[21:15:49.265] Build status: STARTED
[21:15:49.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:8:0) after 3m11s
[21:19:00.260] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:8:0)
[21:19:00.311] Build status: STARTED
[21:19:00.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:9:0) after 2m31s
[21:21:31.355] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:9:0)
[21:21:31.374] Build status: STARTED
[21:21:31.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:10:0) after 1m10s
[21:22:41.391] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:10:0)
[21:22:41.420] Build status: STARTED
[21:22:41.420] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:11:0) after 1m36s
[21:24:17.512] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:11:0)
[21:24:17.528] Build status: STARTED
[21:24:17.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:12:0) after 2m32s
[21:26:49.576] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:12:0)
[21:26:49.599] Build status: STARTED
[21:26:49.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:13:0) after 9m50s
[21:36:39.636] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:13:0)
[21:36:39.653] Build status: STARTED
[21:36:39.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:14:0) after 8m1s
[21:44:40.688] Handling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:14:0)
[21:44:40.704] Build status: STARTED
[21:44:40.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.qemu-arm64-release-netstack3-e5a0ec7f:8907019374342712512:15:0) after 3m51s
[21:45:08.337] Received PubSub notification, asking Buildbucket for the build status
[21:45:08.363] Build:
{
"id": "8741589312402739585",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.qemu-arm64-release-netstack3"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-23T20:50:10.398300162Z",
"startTime": "2024-07-23T20:50:19.103472239Z",
"endTime": "2024-07-23T21:45:07.869040429Z",
"updateTime": "2024-07-23T21:45:07.869040429Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "59347d6a015f48cf280aa744917b048d6e0f4dbb",
"ref": "refs/heads/main"
}
}
}
[21:45:08.363] Invocation finished in 54m59.199359356s with status SUCCEEDED