[09:30:00.604] New invocation is queued and will start shortly
[09:30:01.787] Starting the invocation (attempt 1)
[09:30:01.819] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b4f3a9662d308c869ac97e4f147edb38bc4f0626"
[09:30:01.819] Popped gitiles commit info from properties and tags
[09:30:01.819] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:30:01.819] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:30:01.820] Buildbucket request:
{
"requestId": "8907333956124311904",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907333956124311904",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d26f65414afe496b00ee803cc24722a9bf3f41d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d26f65414afe496b00ee803cc24722a9bf3f41d",
"title": "0d26f65414afe496b00ee803cc24722a9bf3f41d",
"url": "https://llvm.googlesource.com/llvm-project/+/0d26f65414afe496b00ee803cc24722a9bf3f41d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bbd4af5da2b741672a8e6f625eb12ea5c2d6220f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bbd4af5da2b741672a8e6f625eb12ea5c2d6220f",
"title": "bbd4af5da2b741672a8e6f625eb12ea5c2d6220f",
"url": "https://llvm.googlesource.com/llvm-project/+/bbd4af5da2b741672a8e6f625eb12ea5c2d6220f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "62aa596ba19af26f73c292c00d9c7f50df71d836"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@62aa596ba19af26f73c292c00d9c7f50df71d836",
"title": "62aa596ba19af26f73c292c00d9c7f50df71d836",
"url": "https://llvm.googlesource.com/llvm-project/+/62aa596ba19af26f73c292c00d9c7f50df71d836"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "155f6b49d90357d4062aa97f035f42617565ee26"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@155f6b49d90357d4062aa97f035f42617565ee26",
"title": "155f6b49d90357d4062aa97f035f42617565ee26",
"url": "https://llvm.googlesource.com/llvm-project/+/155f6b49d90357d4062aa97f035f42617565ee26"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a8a7d62d0497cf0f9a8b343e0a2e5098f363ae23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a8a7d62d0497cf0f9a8b343e0a2e5098f363ae23",
"title": "a8a7d62d0497cf0f9a8b343e0a2e5098f363ae23",
"url": "https://llvm.googlesource.com/llvm-project/+/a8a7d62d0497cf0f9a8b343e0a2e5098f363ae23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b4f3a9662d308c869ac97e4f147edb38bc4f0626"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b4f3a9662d308c869ac97e4f147edb38bc4f0626",
"title": "b4f3a9662d308c869ac97e4f147edb38bc4f0626",
"url": "https://llvm.googlesource.com/llvm-project/+/b4f3a9662d308c869ac97e4f147edb38bc4f0626"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b4f3a9662d308c869ac97e4f147edb38bc4f0626",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907333956124311904"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:30:02.240] Scheduled build:
{
"id": "8741903894130973889",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-20T09:30:01.883302056Z",
"updateTime": "2024-07-20T09:30:01.883302056Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b4f3a9662d308c869ac97e4f147edb38bc4f0626",
"ref": "refs/heads/main"
}
},
"canary": true
}
[09:30:02.240] Task URL: https://cr-buildbucket.appspot.com/build/8741903894130973889
[09:30:02.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:2:0) after 3m19s
[09:30:03.232] Received PubSub notification, asking Buildbucket for the build status
[09:30:03.250] Build status: SCHEDULED
[09:30:07.995] Received PubSub notification, asking Buildbucket for the build status
[09:30:08.022] Build status: STARTED
[09:33:21.266] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:2:0)
[09:33:21.289] Build status: STARTED
[09:33:21.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:5:0) after 7m58s
[09:41:19.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:5:0)
[09:41:19.364] Build status: STARTED
[09:41:19.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:6:0) after 7m3s
[09:48:22.383] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:6:0)
[09:48:22.419] Build status: STARTED
[09:48:22.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:7:0) after 6m57s
[09:55:19.439] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:7:0)
[09:55:19.459] Build status: STARTED
[09:55:19.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:8:0) after 6m32s
[10:01:51.502] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:8:0)
[10:01:51.517] Build status: STARTED
[10:01:51.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:9:0) after 1m25s
[10:03:16.541] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:9:0)
[10:03:16.572] Build status: STARTED
[10:03:16.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:10:0) after 3m23s
[10:06:39.855] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:10:0)
[10:06:39.883] Build status: STARTED
[10:06:39.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:11:0) after 6m10s
[10:12:50.000] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:11:0)
[10:12:50.062] Build status: STARTED
[10:12:50.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:12:0) after 5m1s
[10:17:52.888] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:12:0)
[10:17:52.909] Build status: STARTED
[10:17:52.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:13:0) after 7m49s
[10:25:41.928] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:13:0)
[10:25:41.950] Build status: STARTED
[10:25:41.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:14:0) after 3m24s
[10:29:06.069] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:14:0)
[10:29:06.109] Build status: STARTED
[10:29:06.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:15:0) after 9m19s
[10:38:25.109] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:15:0)
[10:38:25.132] Build status: STARTED
[10:38:25.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:16:0) after 9m31s
[10:47:56.167] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:16:0)
[10:47:56.188] Build status: STARTED
[10:47:56.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8907333956124311904:17:0) after 9m52s
[10:57:23.244] Received PubSub notification, asking Buildbucket for the build status
[10:57:23.262] Build:
{
"id": "8741903894130973889",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-20T09:30:01.883302056Z",
"startTime": "2024-07-20T09:30:06.265208569Z",
"endTime": "2024-07-20T10:57:23.022670121Z",
"updateTime": "2024-07-20T10:57:23.022670121Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b4f3a9662d308c869ac97e4f147edb38bc4f0626",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:57:23.262] Invocation finished in 1h27m22.663544739s with status SUCCEEDED