[20:20:11.076] New invocation is queued and will start shortly
[20:20:14.347] Starting the invocation (attempt 1)
[20:20:14.375] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6f1adbdb2b6f21d81e491c9ddd307fca0d183850"
[20:20:14.375] Popped gitiles commit info from properties and tags
[20:20:14.375] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:20:14.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:20:14.375] Buildbucket request:
{
"requestId": "8882288287955602000",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882288287955602000",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b5eae19f64d5a53cd85ece433f448be1fd4c8539"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b5eae19f64d5a53cd85ece433f448be1fd4c8539",
"title": "b5eae19f64d5a53cd85ece433f448be1fd4c8539",
"url": "https://llvm.googlesource.com/llvm-project/+/b5eae19f64d5a53cd85ece433f448be1fd4c8539"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "80872d7a32cd335a7964df95e9fbcdee43eb1ad4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@80872d7a32cd335a7964df95e9fbcdee43eb1ad4",
"title": "80872d7a32cd335a7964df95e9fbcdee43eb1ad4",
"url": "https://llvm.googlesource.com/llvm-project/+/80872d7a32cd335a7964df95e9fbcdee43eb1ad4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0",
"title": "2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0",
"url": "https://llvm.googlesource.com/llvm-project/+/2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "718a50963ca4b3860fe1cb638d6030b8ae9e818c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@718a50963ca4b3860fe1cb638d6030b8ae9e818c",
"title": "718a50963ca4b3860fe1cb638d6030b8ae9e818c",
"url": "https://llvm.googlesource.com/llvm-project/+/718a50963ca4b3860fe1cb638d6030b8ae9e818c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e5128332dbb3bedfa30633fad30a52f5b1567d70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e5128332dbb3bedfa30633fad30a52f5b1567d70",
"title": "e5128332dbb3bedfa30633fad30a52f5b1567d70",
"url": "https://llvm.googlesource.com/llvm-project/+/e5128332dbb3bedfa30633fad30a52f5b1567d70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "11d5c4dcccf19b5c01742a2a402889da89783630"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@11d5c4dcccf19b5c01742a2a402889da89783630",
"title": "11d5c4dcccf19b5c01742a2a402889da89783630",
"url": "https://llvm.googlesource.com/llvm-project/+/11d5c4dcccf19b5c01742a2a402889da89783630"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "694c52cef5d24673836cb2199598445753a96864"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@694c52cef5d24673836cb2199598445753a96864",
"title": "694c52cef5d24673836cb2199598445753a96864",
"url": "https://llvm.googlesource.com/llvm-project/+/694c52cef5d24673836cb2199598445753a96864"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bf33f03f5a728d79bd828664cd155903a885a391"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bf33f03f5a728d79bd828664cd155903a885a391",
"title": "bf33f03f5a728d79bd828664cd155903a885a391",
"url": "https://llvm.googlesource.com/llvm-project/+/bf33f03f5a728d79bd828664cd155903a885a391"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dee96a3d078f382b870b62146e38ab1f4a1e596b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dee96a3d078f382b870b62146e38ab1f4a1e596b",
"title": "dee96a3d078f382b870b62146e38ab1f4a1e596b",
"url": "https://llvm.googlesource.com/llvm-project/+/dee96a3d078f382b870b62146e38ab1f4a1e596b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7460da554e3d5efdc5b9db3901078c9bf650fad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7460da554e3d5efdc5b9db3901078c9bf650fad",
"title": "d7460da554e3d5efdc5b9db3901078c9bf650fad",
"url": "https://llvm.googlesource.com/llvm-project/+/d7460da554e3d5efdc5b9db3901078c9bf650fad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "50320504c852e0cb3a8b1e43e85c9137219d44fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@50320504c852e0cb3a8b1e43e85c9137219d44fd",
"title": "50320504c852e0cb3a8b1e43e85c9137219d44fd",
"url": "https://llvm.googlesource.com/llvm-project/+/50320504c852e0cb3a8b1e43e85c9137219d44fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "32fd97c61d82b6cc0edec0ac389d69add9e64aab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@32fd97c61d82b6cc0edec0ac389d69add9e64aab",
"title": "32fd97c61d82b6cc0edec0ac389d69add9e64aab",
"url": "https://llvm.googlesource.com/llvm-project/+/32fd97c61d82b6cc0edec0ac389d69add9e64aab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d6622df115c0de92bf8fc10f8787345ff96b26cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d6622df115c0de92bf8fc10f8787345ff96b26cc",
"title": "d6622df115c0de92bf8fc10f8787345ff96b26cc",
"url": "https://llvm.googlesource.com/llvm-project/+/d6622df115c0de92bf8fc10f8787345ff96b26cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b",
"title": "ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b",
"url": "https://llvm.googlesource.com/llvm-project/+/ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e6747686dc2eea4aa988f61db567c4f67a7421e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e6747686dc2eea4aa988f61db567c4f67a7421e",
"title": "5e6747686dc2eea4aa988f61db567c4f67a7421e",
"url": "https://llvm.googlesource.com/llvm-project/+/5e6747686dc2eea4aa988f61db567c4f67a7421e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f5564895ea8a9e09744826c9fa918a6fe0d2e478"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"title": "f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"url": "https://llvm.googlesource.com/llvm-project/+/f5564895ea8a9e09744826c9fa918a6fe0d2e478"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "66b2c343541a914e591aeae7091b97564cf534a7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@66b2c343541a914e591aeae7091b97564cf534a7",
"title": "66b2c343541a914e591aeae7091b97564cf534a7",
"url": "https://llvm.googlesource.com/llvm-project/+/66b2c343541a914e591aeae7091b97564cf534a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f1adbdb2b6f21d81e491c9ddd307fca0d183850"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f1adbdb2b6f21d81e491c9ddd307fca0d183850",
"title": "6f1adbdb2b6f21d81e491c9ddd307fca0d183850",
"url": "https://llvm.googlesource.com/llvm-project/+/6f1adbdb2b6f21d81e491c9ddd307fca0d183850"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f1adbdb2b6f21d81e491c9ddd307fca0d183850",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882288287955602000"
},
{
"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"
}
}
[20:20:14.925] Scheduled build:
{
"id": "8716858223723615745",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-22T20:20:14.488163596Z",
"updateTime": "2025-04-22T20:20:14.488163596Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f1adbdb2b6f21d81e491c9ddd307fca0d183850",
"ref": "refs/heads/main"
}
}
}
[20:20:14.925] Task URL: https://cr-buildbucket.appspot.com/build/8716858223723615745
[20:20:14.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:2:0) after 1m20s
[20:20:15.950] Received PubSub notification, asking Buildbucket for the build status
[20:20:15.972] Build status: SCHEDULED
[20:20:18.789] Received PubSub notification, asking Buildbucket for the build status
[20:20:18.823] Build status: STARTED
[20:21:34.946] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:2:0)
[20:21:34.965] Build status: STARTED
[20:21:34.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:5:0) after 6m53s
[20:28:27.998] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:5:0)
[20:28:28.447] Build status: STARTED
[20:28:28.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:6:0) after 1m30s
[20:29:58.480] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:6:0)
[20:29:58.523] Build status: STARTED
[20:29:58.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:7:0) after 2m42s
[20:32:40.558] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:7:0)
[20:32:40.596] Build status: STARTED
[20:32:40.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:8:0) after 3m21s
[20:36:01.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:8:0)
[20:36:01.651] Build status: STARTED
[20:36:01.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:9:0) after 1m50s
[20:37:51.669] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:9:0)
[20:37:51.694] Build status: STARTED
[20:37:51.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:10:0) after 6m22s
[20:44:13.741] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:10:0)
[20:44:13.826] Build status: STARTED
[20:44:13.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:11:0) after 1m43s
[20:45:56.965] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:11:0)
[20:45:56.999] Build status: STARTED
[20:45:56.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:12:0) after 9m20s
[20:55:17.032] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:12:0)
[20:55:17.055] Build status: STARTED
[20:55:17.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:13:0) after 8m42s
[21:03:59.089] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:13:0)
[21:03:59.119] Build status: STARTED
[21:03:59.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:14:0) after 8m12s
[21:12:11.143] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:14:0)
[21:12:11.192] Build status: STARTED
[21:12:11.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:15:0) after 3m29s
[21:15:40.210] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:15:0)
[21:15:40.289] Build status: STARTED
[21:15:40.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:16:0) after 4m42s
[21:20:22.338] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:16:0)
[21:20:22.356] Build status: STARTED
[21:20:22.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:17:0) after 8m13s
[21:28:35.446] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:17:0)
[21:28:35.465] Build status: STARTED
[21:28:35.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:18:0) after 2m28s
[21:31:03.484] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:18:0)
[21:31:03.504] Build status: STARTED
[21:31:03.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:19:0) after 8m51s
[21:39:54.581] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:19:0)
[21:39:54.607] Build status: STARTED
[21:39:54.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:20:0) after 4m15s
[21:44:09.628] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:20:0)
[21:44:09.653] Build status: STARTED
[21:44:09.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:21:0) after 1m53s
[21:46:02.733] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:21:0)
[21:46:02.781] Build status: STARTED
[21:46:02.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8882288287955602000:22:0) after 6m12s
[21:51:13.950] Received PubSub notification, asking Buildbucket for the build status
[21:51:13.979] Build:
{
"id": "8716858223723615745",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-22T20:20:14.488163596Z",
"startTime": "2025-04-22T20:20:18.545386124Z",
"endTime": "2025-04-22T21:51:13.591334750Z",
"updateTime": "2025-04-22T21:51:13.591334750Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f1adbdb2b6f21d81e491c9ddd307fca0d183850",
"ref": "refs/heads/main"
}
}
}
[21:51:13.979] Invocation finished in 1h31m2.911418926s with status SUCCEEDED