[16:51:00.772] New invocation is queued and will start shortly
[16:51:01.969] Starting the invocation (attempt 1)
[16:51:01.996] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b8dcf53dc636239b82e2524d1cffc2c46ace751a"
[16:51:01.996] Popped gitiles commit info from properties and tags
[16:51:01.996] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:51:01.996] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:51:01.997] Buildbucket request:
{
"requestId": "8879039957109482048",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879039957109482048",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a",
"title": "4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a",
"url": "https://llvm.googlesource.com/llvm-project/+/4608df5b9fea7322714fc5fe7e6bcc5e5e3a666a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4ad230bebd1dcdf09f445181f34e8fa92e970412"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4ad230bebd1dcdf09f445181f34e8fa92e970412",
"title": "4ad230bebd1dcdf09f445181f34e8fa92e970412",
"url": "https://llvm.googlesource.com/llvm-project/+/4ad230bebd1dcdf09f445181f34e8fa92e970412"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f64cd30367e7cee4a0b82b405d96e9b37412b391"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f64cd30367e7cee4a0b82b405d96e9b37412b391",
"title": "f64cd30367e7cee4a0b82b405d96e9b37412b391",
"url": "https://llvm.googlesource.com/llvm-project/+/f64cd30367e7cee4a0b82b405d96e9b37412b391"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "caaca3298e4c08936d8f10df4ebc1749c8a66902"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@caaca3298e4c08936d8f10df4ebc1749c8a66902",
"title": "caaca3298e4c08936d8f10df4ebc1749c8a66902",
"url": "https://llvm.googlesource.com/llvm-project/+/caaca3298e4c08936d8f10df4ebc1749c8a66902"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a1191b48755a8ce651792ba06a430338f41af2f1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a1191b48755a8ce651792ba06a430338f41af2f1",
"title": "a1191b48755a8ce651792ba06a430338f41af2f1",
"url": "https://llvm.googlesource.com/llvm-project/+/a1191b48755a8ce651792ba06a430338f41af2f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "63385e7fc94039e1af6a8f21bebf8974f9d4a2a7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@63385e7fc94039e1af6a8f21bebf8974f9d4a2a7",
"title": "63385e7fc94039e1af6a8f21bebf8974f9d4a2a7",
"url": "https://llvm.googlesource.com/llvm-project/+/63385e7fc94039e1af6a8f21bebf8974f9d4a2a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1610d41d8397301c3c39486b7ed1d329f43aad5d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1610d41d8397301c3c39486b7ed1d329f43aad5d",
"title": "1610d41d8397301c3c39486b7ed1d329f43aad5d",
"url": "https://llvm.googlesource.com/llvm-project/+/1610d41d8397301c3c39486b7ed1d329f43aad5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61a98eb7d3a6e42b4a0a0c651bd62411f783c166"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61a98eb7d3a6e42b4a0a0c651bd62411f783c166",
"title": "61a98eb7d3a6e42b4a0a0c651bd62411f783c166",
"url": "https://llvm.googlesource.com/llvm-project/+/61a98eb7d3a6e42b4a0a0c651bd62411f783c166"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff5095db93762412a1c09225b18f80b06b99ff68"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff5095db93762412a1c09225b18f80b06b99ff68",
"title": "ff5095db93762412a1c09225b18f80b06b99ff68",
"url": "https://llvm.googlesource.com/llvm-project/+/ff5095db93762412a1c09225b18f80b06b99ff68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8dcf53dc636239b82e2524d1cffc2c46ace751a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"title": "b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"url": "https://llvm.googlesource.com/llvm-project/+/b8dcf53dc636239b82e2524d1cffc2c46ace751a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879039957109482048"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:51:02.455] Scheduled build:
{
"id": "8713609895051849073",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-28T16:51:02.113706448Z",
"updateTime": "2025-05-28T16:51:02.113706448Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"ref": "refs/heads/main"
}
}
}
[16:51:02.455] Task URL: https://cr-buildbucket.appspot.com/build/8713609895051849073
[16:51:02.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:2:0) after 8m11s
[16:51:03.433] Received PubSub notification, asking Buildbucket for the build status
[16:51:03.507] Build status: SCHEDULED
[16:51:07.519] Received PubSub notification, asking Buildbucket for the build status
[16:51:07.545] Build status: STARTED
[16:59:13.483] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:2:0)
[16:59:13.506] Build status: STARTED
[16:59:13.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:5:0) after 1m20s
[17:00:33.519] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:5:0)
[17:00:33.549] Build status: STARTED
[17:00:33.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:6:0) after 8m16s
[17:08:49.660] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:6:0)
[17:08:49.679] Build status: STARTED
[17:08:49.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:7:0) after 5m51s
[17:14:40.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:7:0)
[17:14:40.768] Build status: STARTED
[17:14:40.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:8:0) after 2m21s
[17:17:01.928] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:8:0)
[17:17:01.944] Build status: STARTED
[17:17:01.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:9:0) after 3m39s
[17:20:41.078] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:9:0)
[17:20:41.094] Build status: STARTED
[17:20:41.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:10:0) after 2m20s
[17:23:01.187] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:10:0)
[17:23:01.205] Build status: STARTED
[17:23:01.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:11:0) after 4m25s
[17:27:26.242] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:11:0)
[17:27:26.267] Build status: STARTED
[17:27:26.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:12:0) after 1m18s
[17:28:44.527] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:12:0)
[17:28:44.545] Build status: STARTED
[17:28:44.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8879039957109482048:13:0) after 7m6s
[17:31:56.152] Received PubSub notification, asking Buildbucket for the build status
[17:31:56.171] Build:
{
"id": "8713609895051849073",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-28T16:51:02.113706448Z",
"startTime": "2025-05-28T16:51:07.314236087Z",
"endTime": "2025-05-28T17:31:55.780506411Z",
"updateTime": "2025-05-28T17:31:55.780506411Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b8dcf53dc636239b82e2524d1cffc2c46ace751a",
"ref": "refs/heads/main"
}
}
}
[17:31:56.171] Invocation finished in 40m55.404159902s with status SUCCEEDED