[07:22:12.243] New invocation is queued and will start shortly
[07:22:13.369] Starting the invocation (attempt 1)
[07:22:13.395] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b15aa7f88c21d126bac4cf77eb05c522e0f1870d"
[07:22:13.395] Popped gitiles commit info from properties and tags
[07:22:13.395] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:22:13.395] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:22:13.395] Buildbucket request:
{
"requestId": "8907160803055814080",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907160803055814080",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58854facb30f7c660c1fd05376f8a4722eeefb9e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58854facb30f7c660c1fd05376f8a4722eeefb9e",
"title": "58854facb30f7c660c1fd05376f8a4722eeefb9e",
"url": "https://llvm.googlesource.com/llvm-project/+/58854facb30f7c660c1fd05376f8a4722eeefb9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f18fd6e3f9c38560bc26253cae77ac3935149602"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f18fd6e3f9c38560bc26253cae77ac3935149602",
"title": "f18fd6e3f9c38560bc26253cae77ac3935149602",
"url": "https://llvm.googlesource.com/llvm-project/+/f18fd6e3f9c38560bc26253cae77ac3935149602"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4d4ce1a3189730ef09ee04207004f500a71070d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4d4ce1a3189730ef09ee04207004f500a71070d",
"title": "f4d4ce1a3189730ef09ee04207004f500a71070d",
"url": "https://llvm.googlesource.com/llvm-project/+/f4d4ce1a3189730ef09ee04207004f500a71070d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2873edd2867c151871f7ec3865819ff0f874c95a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2873edd2867c151871f7ec3865819ff0f874c95a",
"title": "2873edd2867c151871f7ec3865819ff0f874c95a",
"url": "https://llvm.googlesource.com/llvm-project/+/2873edd2867c151871f7ec3865819ff0f874c95a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8dafbb5fdd4099df72d24af2ceb7ecade8216820"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8dafbb5fdd4099df72d24af2ceb7ecade8216820",
"title": "8dafbb5fdd4099df72d24af2ceb7ecade8216820",
"url": "https://llvm.googlesource.com/llvm-project/+/8dafbb5fdd4099df72d24af2ceb7ecade8216820"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b9ac2a4951453fa61fbda285a23be1b32bbff49"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b9ac2a4951453fa61fbda285a23be1b32bbff49",
"title": "6b9ac2a4951453fa61fbda285a23be1b32bbff49",
"url": "https://llvm.googlesource.com/llvm-project/+/6b9ac2a4951453fa61fbda285a23be1b32bbff49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "10d720b5b4383c9900caaed7edf38ae31e8b9ac4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@10d720b5b4383c9900caaed7edf38ae31e8b9ac4",
"title": "10d720b5b4383c9900caaed7edf38ae31e8b9ac4",
"url": "https://llvm.googlesource.com/llvm-project/+/10d720b5b4383c9900caaed7edf38ae31e8b9ac4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "36d384b4ddb54d40866614df5128be60f36d92a2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@36d384b4ddb54d40866614df5128be60f36d92a2",
"title": "36d384b4ddb54d40866614df5128be60f36d92a2",
"url": "https://llvm.googlesource.com/llvm-project/+/36d384b4ddb54d40866614df5128be60f36d92a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c73b1a986bb4f3af6c5d5e9e705934dbcc36262"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c73b1a986bb4f3af6c5d5e9e705934dbcc36262",
"title": "4c73b1a986bb4f3af6c5d5e9e705934dbcc36262",
"url": "https://llvm.googlesource.com/llvm-project/+/4c73b1a986bb4f3af6c5d5e9e705934dbcc36262"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b15aa7f88c21d126bac4cf77eb05c522e0f1870d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b15aa7f88c21d126bac4cf77eb05c522e0f1870d",
"title": "b15aa7f88c21d126bac4cf77eb05c522e0f1870d",
"url": "https://llvm.googlesource.com/llvm-project/+/b15aa7f88c21d126bac4cf77eb05c522e0f1870d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b15aa7f88c21d126bac4cf77eb05c522e0f1870d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907160803055814080"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:22:14.133] Scheduled build:
{
"id": "8741730741114844897",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-22T07:22:13.467750747Z",
"updateTime": "2024-07-22T07:22:13.467750747Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b15aa7f88c21d126bac4cf77eb05c522e0f1870d",
"ref": "refs/heads/main"
}
}
}
[07:22:14.133] Task URL: https://cr-buildbucket.appspot.com/build/8741730741114844897
[07:22:14.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:2:0) after 4m31s
[07:22:14.873] Received PubSub notification, asking Buildbucket for the build status
[07:22:14.895] Build status: SCHEDULED
[07:22:18.363] Received PubSub notification, asking Buildbucket for the build status
[07:22:18.383] Build status: STARTED
[07:26:45.156] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:2:0)
[07:26:45.188] Build status: STARTED
[07:26:45.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:5:0) after 6m40s
[07:33:25.207] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:5:0)
[07:33:25.305] Build status: STARTED
[07:33:25.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:6:0) after 7m19s
[07:40:44.453] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:6:0)
[07:40:44.477] Build status: STARTED
[07:40:44.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:7:0) after 4m30s
[07:45:14.599] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:7:0)
[07:45:14.622] Build status: STARTED
[07:45:14.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:8:0) after 6m55s
[07:52:09.772] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:8:0)
[07:52:09.794] Build status: STARTED
[07:52:09.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:9:0) after 8m1s
[08:00:10.864] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:9:0)
[08:00:10.888] Build status: STARTED
[08:00:10.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:10:0) after 9m35s
[08:09:46.305] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:10:0)
[08:09:46.323] Build status: STARTED
[08:09:46.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:11:0) after 2m41s
[08:12:27.367] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:11:0)
[08:12:27.386] Build status: STARTED
[08:12:27.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:12:0) after 7m16s
[08:19:43.684] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:12:0)
[08:19:43.710] Build status: STARTED
[08:19:43.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:13:0) after 7m38s
[08:27:21.736] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:13:0)
[08:27:21.754] Build status: STARTED
[08:27:21.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:14:0) after 3m36s
[08:30:57.774] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:14:0)
[08:30:57.798] Build status: STARTED
[08:30:57.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:15:0) after 3m17s
[08:34:14.932] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:15:0)
[08:34:14.954] Build status: STARTED
[08:34:14.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:16:0) after 7m21s
[08:41:36.202] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:16:0)
[08:41:36.238] Build status: STARTED
[08:41:36.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:17:0) after 5m56s
[08:47:32.264] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:17:0)
[08:47:32.296] Build status: STARTED
[08:47:32.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:18:0) after 1m13s
[08:48:45.431] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:18:0)
[08:48:45.475] Build status: STARTED
[08:48:45.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:19:0) after 1m40s
[08:50:25.535] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:19:0)
[08:50:25.555] Build status: STARTED
[08:50:25.555] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:20:0) after 8m35s
[08:59:00.587] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:20:0)
[08:59:00.609] Build status: STARTED
[08:59:00.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8907160803055814080:21:0) after 9m23s
[09:00:12.435] Received PubSub notification, asking Buildbucket for the build status
[09:00:12.461] Build:
{
"id": "8741730741114844897",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-22T07:22:13.467750747Z",
"startTime": "2024-07-22T07:22:18.156919171Z",
"endTime": "2024-07-22T09:00:11.912134339Z",
"updateTime": "2024-07-22T09:00:11.912134339Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b15aa7f88c21d126bac4cf77eb05c522e0f1870d",
"ref": "refs/heads/main"
}
}
}
[09:00:12.461] Invocation finished in 1h38m0.22781028s with status SUCCEEDED