[17:51:04.569] New invocation is queued and will start shortly
[17:51:05.701] Starting the invocation (attempt 1)
[17:51:05.736] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/511dc261ab94da7db6e67b05cdcef9dcff44798a"
[17:51:05.736] Popped gitiles commit info from properties and tags
[17:51:05.736] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:51:05.736] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:51:05.737] Buildbucket request:
{
"requestId": "8890451396025402752",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8890451396025402752",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5a9b74d20d5f3b7f92c01d68d28778108dfb1308"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5a9b74d20d5f3b7f92c01d68d28778108dfb1308",
"title": "5a9b74d20d5f3b7f92c01d68d28778108dfb1308",
"url": "https://llvm.googlesource.com/llvm-project/+/5a9b74d20d5f3b7f92c01d68d28778108dfb1308"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "75ce2dc475b12c12419904cd67b9d12b79a66242"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@75ce2dc475b12c12419904cd67b9d12b79a66242",
"title": "75ce2dc475b12c12419904cd67b9d12b79a66242",
"url": "https://llvm.googlesource.com/llvm-project/+/75ce2dc475b12c12419904cd67b9d12b79a66242"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa6f88af102cb79a0371725b487e929cb0bcfcb2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa6f88af102cb79a0371725b487e929cb0bcfcb2",
"title": "fa6f88af102cb79a0371725b487e929cb0bcfcb2",
"url": "https://llvm.googlesource.com/llvm-project/+/fa6f88af102cb79a0371725b487e929cb0bcfcb2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "13d09dfad6d1f6a15721688822ce33b74b44a8d8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@13d09dfad6d1f6a15721688822ce33b74b44a8d8",
"title": "13d09dfad6d1f6a15721688822ce33b74b44a8d8",
"url": "https://llvm.googlesource.com/llvm-project/+/13d09dfad6d1f6a15721688822ce33b74b44a8d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e6494c0fb29dfb5d4d2b7bf3ed7af261efee034"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e6494c0fb29dfb5d4d2b7bf3ed7af261efee034",
"title": "9e6494c0fb29dfb5d4d2b7bf3ed7af261efee034",
"url": "https://llvm.googlesource.com/llvm-project/+/9e6494c0fb29dfb5d4d2b7bf3ed7af261efee034"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f63e8ed16ef1fd2deb80cd88b5ca9d5b631b1c36"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f63e8ed16ef1fd2deb80cd88b5ca9d5b631b1c36",
"title": "f63e8ed16ef1fd2deb80cd88b5ca9d5b631b1c36",
"url": "https://llvm.googlesource.com/llvm-project/+/f63e8ed16ef1fd2deb80cd88b5ca9d5b631b1c36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "16298e4cf23d351fcd789fd027d8a30d9329fa81"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@16298e4cf23d351fcd789fd027d8a30d9329fa81",
"title": "16298e4cf23d351fcd789fd027d8a30d9329fa81",
"url": "https://llvm.googlesource.com/llvm-project/+/16298e4cf23d351fcd789fd027d8a30d9329fa81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "603529b29eb5441fe7d32f8d154a0ed876038ef2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@603529b29eb5441fe7d32f8d154a0ed876038ef2",
"title": "603529b29eb5441fe7d32f8d154a0ed876038ef2",
"url": "https://llvm.googlesource.com/llvm-project/+/603529b29eb5441fe7d32f8d154a0ed876038ef2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e6c7d6a56a850228ccb7b1659e383dd5a55e7bdb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e6c7d6a56a850228ccb7b1659e383dd5a55e7bdb",
"title": "e6c7d6a56a850228ccb7b1659e383dd5a55e7bdb",
"url": "https://llvm.googlesource.com/llvm-project/+/e6c7d6a56a850228ccb7b1659e383dd5a55e7bdb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bb754f2c98ddeeadf75f21e6fbc6bd03898f008c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bb754f2c98ddeeadf75f21e6fbc6bd03898f008c",
"title": "bb754f2c98ddeeadf75f21e6fbc6bd03898f008c",
"url": "https://llvm.googlesource.com/llvm-project/+/bb754f2c98ddeeadf75f21e6fbc6bd03898f008c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a25f2cb3e6953691fade076c8e0ccebf1016d3d9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a25f2cb3e6953691fade076c8e0ccebf1016d3d9",
"title": "a25f2cb3e6953691fade076c8e0ccebf1016d3d9",
"url": "https://llvm.googlesource.com/llvm-project/+/a25f2cb3e6953691fade076c8e0ccebf1016d3d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44f316811016e677ca3e6c6237619e71bae28986"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44f316811016e677ca3e6c6237619e71bae28986",
"title": "44f316811016e677ca3e6c6237619e71bae28986",
"url": "https://llvm.googlesource.com/llvm-project/+/44f316811016e677ca3e6c6237619e71bae28986"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2476417232cdf2e1fce1a1df466b0995cdf559c5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2476417232cdf2e1fce1a1df466b0995cdf559c5",
"title": "2476417232cdf2e1fce1a1df466b0995cdf559c5",
"url": "https://llvm.googlesource.com/llvm-project/+/2476417232cdf2e1fce1a1df466b0995cdf559c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f3c3a9b8829760b730b6651e460f9035065dd4c5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f3c3a9b8829760b730b6651e460f9035065dd4c5",
"title": "f3c3a9b8829760b730b6651e460f9035065dd4c5",
"url": "https://llvm.googlesource.com/llvm-project/+/f3c3a9b8829760b730b6651e460f9035065dd4c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ddb8607fe8b0b74a6d89c79d4fcc158673ac765a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ddb8607fe8b0b74a6d89c79d4fcc158673ac765a",
"title": "ddb8607fe8b0b74a6d89c79d4fcc158673ac765a",
"url": "https://llvm.googlesource.com/llvm-project/+/ddb8607fe8b0b74a6d89c79d4fcc158673ac765a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e79ade49d68c49aeb8ba008b59f559b86d22765"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e79ade49d68c49aeb8ba008b59f559b86d22765",
"title": "8e79ade49d68c49aeb8ba008b59f559b86d22765",
"url": "https://llvm.googlesource.com/llvm-project/+/8e79ade49d68c49aeb8ba008b59f559b86d22765"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f78359cf43cb990f66412059383cdd95ab6e6ec4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f78359cf43cb990f66412059383cdd95ab6e6ec4",
"title": "f78359cf43cb990f66412059383cdd95ab6e6ec4",
"url": "https://llvm.googlesource.com/llvm-project/+/f78359cf43cb990f66412059383cdd95ab6e6ec4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "511dc261ab94da7db6e67b05cdcef9dcff44798a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@511dc261ab94da7db6e67b05cdcef9dcff44798a",
"title": "511dc261ab94da7db6e67b05cdcef9dcff44798a",
"url": "https://llvm.googlesource.com/llvm-project/+/511dc261ab94da7db6e67b05cdcef9dcff44798a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "511dc261ab94da7db6e67b05cdcef9dcff44798a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8890451396025402752"
},
{
"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"
}
}
[17:51:06.158] Scheduled build:
{
"id": "8725021334077079457",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-22T17:51:05.802755575Z",
"updateTime": "2025-01-22T17:51:05.802755575Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "511dc261ab94da7db6e67b05cdcef9dcff44798a",
"ref": "refs/heads/main"
}
}
}
[17:51:06.158] Task URL: https://cr-buildbucket.appspot.com/build/8725021334077079457
[17:51:06.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:2:0) after 9m11s
[17:51:07.178] Received PubSub notification, asking Buildbucket for the build status
[17:51:07.199] Build status: SCHEDULED
[17:51:11.691] Received PubSub notification, asking Buildbucket for the build status
[17:51:11.727] Build status: STARTED
[18:00:17.193] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:2:0)
[18:00:17.268] Build status: STARTED
[18:00:17.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:5:0) after 4m52s
[18:05:09.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:5:0)
[18:05:09.370] Build status: STARTED
[18:05:09.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:6:0) after 6m16s
[18:11:25.398] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:6:0)
[18:11:25.420] Build status: STARTED
[18:11:25.420] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:7:0) after 4m26s
[18:15:51.427] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:7:0)
[18:15:51.464] Build status: STARTED
[18:15:51.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:8:0) after 9m7s
[18:24:58.566] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:8:0)
[18:24:58.652] Build status: STARTED
[18:24:58.652] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:9:0) after 3m12s
[18:28:10.694] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:9:0)
[18:28:10.715] Build status: STARTED
[18:28:10.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:10:0) after 1m14s
[18:29:24.689] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:10:0)
[18:29:24.765] Build status: STARTED
[18:29:24.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:11:0) after 5m38s
[18:35:02.796] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:11:0)
[18:35:02.817] Build status: STARTED
[18:35:02.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:12:0) after 6m42s
[18:41:44.842] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:12:0)
[18:41:44.884] Build status: STARTED
[18:41:44.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:13:0) after 7m17s
[18:49:01.904] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:13:0)
[18:49:01.932] Build status: STARTED
[18:49:01.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:14:0) after 4m34s
[18:53:35.912] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:14:0)
[18:53:35.938] Build status: STARTED
[18:53:35.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:15:0) after 3m50s
[18:57:25.916] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:15:0)
[18:57:25.943] Build status: STARTED
[18:57:25.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:16:0) after 2m6s
[18:59:31.969] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:16:0)
[18:59:32.032] Build status: STARTED
[18:59:32.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:17:0) after 9m2s
[19:08:34.103] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:17:0)
[19:08:34.132] Build status: STARTED
[19:08:34.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:18:0) after 2m12s
[19:10:46.125] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:18:0)
[19:10:46.155] Build status: STARTED
[19:10:46.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:19:0) after 3m18s
[19:14:04.141] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:19:0)
[19:14:04.156] Build status: STARTED
[19:14:04.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8890451396025402752:20:0) after 9m14s
[19:20:06.610] Received PubSub notification, asking Buildbucket for the build status
[19:20:06.628] Build:
{
"id": "8725021334077079457",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-22T17:51:05.802755575Z",
"startTime": "2025-01-22T17:51:11.463211980Z",
"endTime": "2025-01-22T19:20:04.648473314Z",
"updateTime": "2025-01-22T19:20:04.648473314Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "511dc261ab94da7db6e67b05cdcef9dcff44798a",
"ref": "refs/heads/main"
}
}
}
[19:20:06.628] Invocation finished in 1h29m2.068185271s with status FAILED