[19:18:28.063] New invocation is queued and will start shortly
[19:18:29.149] Starting the invocation (attempt 1)
[19:18:29.183] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5f88f0c63fa75169665732a3377f5bb3fef6256d"
[19:18:29.183] Popped gitiles commit info from properties and tags
[19:18:29.183] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:18:29.183] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:18:29.183] Buildbucket request:
{
"requestId": "8914635287854117040",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914635287854117040",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "40083cf378e8c93165c5f9dd9d06611beca78f54"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@40083cf378e8c93165c5f9dd9d06611beca78f54",
"title": "40083cf378e8c93165c5f9dd9d06611beca78f54",
"url": "https://llvm.googlesource.com/llvm-project/+/40083cf378e8c93165c5f9dd9d06611beca78f54"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7a8d15e919dde70118dbfa34e927be1705ded67d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7a8d15e919dde70118dbfa34e927be1705ded67d",
"title": "7a8d15e919dde70118dbfa34e927be1705ded67d",
"url": "https://llvm.googlesource.com/llvm-project/+/7a8d15e919dde70118dbfa34e927be1705ded67d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49bb993959668b3f319e9ea5fa0c97a41ab0890e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49bb993959668b3f319e9ea5fa0c97a41ab0890e",
"title": "49bb993959668b3f319e9ea5fa0c97a41ab0890e",
"url": "https://llvm.googlesource.com/llvm-project/+/49bb993959668b3f319e9ea5fa0c97a41ab0890e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d2353695f8cb864f88475d3a921249b0dcbcc6f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d2353695f8cb864f88475d3a921249b0dcbcc6f4",
"title": "d2353695f8cb864f88475d3a921249b0dcbcc6f4",
"url": "https://llvm.googlesource.com/llvm-project/+/d2353695f8cb864f88475d3a921249b0dcbcc6f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7662f95f2c767ae3c9b22eb4bdedb07ffcf258b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7662f95f2c767ae3c9b22eb4bdedb07ffcf258b7",
"title": "7662f95f2c767ae3c9b22eb4bdedb07ffcf258b7",
"url": "https://llvm.googlesource.com/llvm-project/+/7662f95f2c767ae3c9b22eb4bdedb07ffcf258b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f061a395ffb78215a23e0f503e8ea121ee3b13ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f061a395ffb78215a23e0f503e8ea121ee3b13ad",
"title": "f061a395ffb78215a23e0f503e8ea121ee3b13ad",
"url": "https://llvm.googlesource.com/llvm-project/+/f061a395ffb78215a23e0f503e8ea121ee3b13ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8009bbec59d1c5d47ae06c431647ebee6d886ff2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8009bbec59d1c5d47ae06c431647ebee6d886ff2",
"title": "8009bbec59d1c5d47ae06c431647ebee6d886ff2",
"url": "https://llvm.googlesource.com/llvm-project/+/8009bbec59d1c5d47ae06c431647ebee6d886ff2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa67986d5b309ddd4c2ea74e8a5eeb0559aa8022"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa67986d5b309ddd4c2ea74e8a5eeb0559aa8022",
"title": "fa67986d5b309ddd4c2ea74e8a5eeb0559aa8022",
"url": "https://llvm.googlesource.com/llvm-project/+/fa67986d5b309ddd4c2ea74e8a5eeb0559aa8022"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1c979ab7e59feb03c58cac631a93143b0c776c20"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1c979ab7e59feb03c58cac631a93143b0c776c20",
"title": "1c979ab7e59feb03c58cac631a93143b0c776c20",
"url": "https://llvm.googlesource.com/llvm-project/+/1c979ab7e59feb03c58cac631a93143b0c776c20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0ecc1646cbbb1bdfce234a11bec33b8c64af29cb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0ecc1646cbbb1bdfce234a11bec33b8c64af29cb",
"title": "0ecc1646cbbb1bdfce234a11bec33b8c64af29cb",
"url": "https://llvm.googlesource.com/llvm-project/+/0ecc1646cbbb1bdfce234a11bec33b8c64af29cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "41f9c78f6a4efe38edbb0b62131b0a0bf619c99a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@41f9c78f6a4efe38edbb0b62131b0a0bf619c99a",
"title": "41f9c78f6a4efe38edbb0b62131b0a0bf619c99a",
"url": "https://llvm.googlesource.com/llvm-project/+/41f9c78f6a4efe38edbb0b62131b0a0bf619c99a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7cbaaed63612fe6446355c5ffe33ddd57578b929"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7cbaaed63612fe6446355c5ffe33ddd57578b929",
"title": "7cbaaed63612fe6446355c5ffe33ddd57578b929",
"url": "https://llvm.googlesource.com/llvm-project/+/7cbaaed63612fe6446355c5ffe33ddd57578b929"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "52cb9537896992e0fa689c45469bccb36970c0c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@52cb9537896992e0fa689c45469bccb36970c0c7",
"title": "52cb9537896992e0fa689c45469bccb36970c0c7",
"url": "https://llvm.googlesource.com/llvm-project/+/52cb9537896992e0fa689c45469bccb36970c0c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5f88f0c63fa75169665732a3377f5bb3fef6256d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5f88f0c63fa75169665732a3377f5bb3fef6256d",
"title": "5f88f0c63fa75169665732a3377f5bb3fef6256d",
"url": "https://llvm.googlesource.com/llvm-project/+/5f88f0c63fa75169665732a3377f5bb3fef6256d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5f88f0c63fa75169665732a3377f5bb3fef6256d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914635287854117040"
},
{
"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"
}
}
[19:18:29.853] Scheduled build:
{
"id": "8749205225832210289",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-30T19:18:29.364153277Z",
"updateTime": "2024-04-30T19:18:29.364153277Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5f88f0c63fa75169665732a3377f5bb3fef6256d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:18:29.853] Task URL: https://cr-buildbucket.appspot.com/build/8749205225832210289
[19:18:29.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:2:0) after 1m23s
[19:18:30.840] Received PubSub notification, asking Buildbucket for the build status
[19:18:30.908] Build status: SCHEDULED
[19:18:42.455] Received PubSub notification, asking Buildbucket for the build status
[19:18:42.489] Build status: STARTED
[19:19:53.123] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:2:0)
[19:19:53.146] Build status: STARTED
[19:19:53.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:5:0) after 8m24s
[19:28:17.163] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:5:0)
[19:28:17.208] Build status: STARTED
[19:28:17.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:6:0) after 7m13s
[19:35:30.279] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:6:0)
[19:35:30.303] Build status: STARTED
[19:35:30.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:7:0) after 4m8s
[19:39:38.320] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:7:0)
[19:39:38.354] Build status: STARTED
[19:39:38.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:8:0) after 2m41s
[19:42:19.377] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:8:0)
[19:42:19.445] Build status: STARTED
[19:42:19.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:9:0) after 1m12s
[19:43:31.480] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:9:0)
[19:43:31.499] Build status: STARTED
[19:43:31.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:10:0) after 8m55s
[19:52:26.635] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:10:0)
[19:52:26.704] Build status: STARTED
[19:52:26.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:11:0) after 8m6s
[20:00:32.684] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:11:0)
[20:00:32.709] Build status: STARTED
[20:00:32.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:12:0) after 4m52s
[20:05:24.734] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:12:0)
[20:05:24.755] Build status: STARTED
[20:05:24.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:13:0) after 5m55s
[20:11:19.828] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:13:0)
[20:11:19.844] Build status: STARTED
[20:11:19.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:14:0) after 2m46s
[20:14:05.880] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:14:0)
[20:14:05.902] Build status: STARTED
[20:14:05.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:15:0) after 8m43s
[20:22:48.931] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:15:0)
[20:22:48.950] Build status: STARTED
[20:22:48.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:16:0) after 3m55s
[20:26:44.078] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:16:0)
[20:26:44.146] Build status: STARTED
[20:26:44.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:17:0) after 1m36s
[20:28:20.178] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:17:0)
[20:28:20.195] Build status: STARTED
[20:28:20.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:18:0) after 3m30s
[20:31:50.322] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:18:0)
[20:31:50.349] Build status: STARTED
[20:31:50.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:19:0) after 8m28s
[20:40:18.479] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:19:0)
[20:40:18.503] Build status: STARTED
[20:40:18.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:20:0) after 1m32s
[20:41:50.548] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:20:0)
[20:41:50.585] Build status: STARTED
[20:41:50.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:21:0) after 7m34s
[20:49:24.601] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:21:0)
[20:49:24.621] Build status: STARTED
[20:49:24.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914635287854117040:22:0) after 5m6s
[20:50:13.194] Received PubSub notification, asking Buildbucket for the build status
[20:50:13.262] Build:
{
"id": "8749205225832210289",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-30T19:18:29.364153277Z",
"startTime": "2024-04-30T19:18:42.257977399Z",
"endTime": "2024-04-30T20:50:12.688239742Z",
"updateTime": "2024-04-30T20:50:12.688239742Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5f88f0c63fa75169665732a3377f5bb3fef6256d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:50:13.262] Invocation finished in 1h31m45.210819571s with status FAILED