[15:38:45.251] New invocation is queued and will start shortly
[15:38:46.353] Starting the invocation (attempt 1)
[15:38:46.384] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4e28d30e335e6e075f4624ae8d5782fef6d3f1ed"
[15:38:46.385] Popped gitiles commit info from properties and tags
[15:38:46.385] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:38:46.385] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:38:46.386] Buildbucket request:
{
"requestId": "8906948368892706432",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906948368892706432",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "83ea7ce3a132001dfd7665c7eb50ef44cfd79802"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@83ea7ce3a132001dfd7665c7eb50ef44cfd79802",
"title": "83ea7ce3a132001dfd7665c7eb50ef44cfd79802",
"url": "https://llvm.googlesource.com/llvm-project/+/83ea7ce3a132001dfd7665c7eb50ef44cfd79802"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9d2dd009b60793f562ba1b00e3d02773f060e4b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9d2dd009b60793f562ba1b00e3d02773f060e4b6",
"title": "9d2dd009b60793f562ba1b00e3d02773f060e4b6",
"url": "https://llvm.googlesource.com/llvm-project/+/9d2dd009b60793f562ba1b00e3d02773f060e4b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c4b66bf4d065d3bbc2e2fac8512a6df8e013c704"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c4b66bf4d065d3bbc2e2fac8512a6df8e013c704",
"title": "c4b66bf4d065d3bbc2e2fac8512a6df8e013c704",
"url": "https://llvm.googlesource.com/llvm-project/+/c4b66bf4d065d3bbc2e2fac8512a6df8e013c704"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6c23f974d6fe43d8e5c0adbc4a4f89fbabc9d9ea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6c23f974d6fe43d8e5c0adbc4a4f89fbabc9d9ea",
"title": "6c23f974d6fe43d8e5c0adbc4a4f89fbabc9d9ea",
"url": "https://llvm.googlesource.com/llvm-project/+/6c23f974d6fe43d8e5c0adbc4a4f89fbabc9d9ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d19676de417fa4dbfac07fc4fe0c30c232b3e68"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d19676de417fa4dbfac07fc4fe0c30c232b3e68",
"title": "4d19676de417fa4dbfac07fc4fe0c30c232b3e68",
"url": "https://llvm.googlesource.com/llvm-project/+/4d19676de417fa4dbfac07fc4fe0c30c232b3e68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f2b6f0b5868d052ef03431405b1053be18a36d75"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f2b6f0b5868d052ef03431405b1053be18a36d75",
"title": "f2b6f0b5868d052ef03431405b1053be18a36d75",
"url": "https://llvm.googlesource.com/llvm-project/+/f2b6f0b5868d052ef03431405b1053be18a36d75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "374bbc93bcb34268f175405a71806c4580495c6d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@374bbc93bcb34268f175405a71806c4580495c6d",
"title": "374bbc93bcb34268f175405a71806c4580495c6d",
"url": "https://llvm.googlesource.com/llvm-project/+/374bbc93bcb34268f175405a71806c4580495c6d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f83950ab8dfda1da882a6ef7b508639df251621a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f83950ab8dfda1da882a6ef7b508639df251621a",
"title": "f83950ab8dfda1da882a6ef7b508639df251621a",
"url": "https://llvm.googlesource.com/llvm-project/+/f83950ab8dfda1da882a6ef7b508639df251621a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e7a3aeb1f86b8d45815b834e4e20b1fc7e71705d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e7a3aeb1f86b8d45815b834e4e20b1fc7e71705d",
"title": "e7a3aeb1f86b8d45815b834e4e20b1fc7e71705d",
"url": "https://llvm.googlesource.com/llvm-project/+/e7a3aeb1f86b8d45815b834e4e20b1fc7e71705d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59e1c6cd63eb9287df6516f9a5ae564075e9c218"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59e1c6cd63eb9287df6516f9a5ae564075e9c218",
"title": "59e1c6cd63eb9287df6516f9a5ae564075e9c218",
"url": "https://llvm.googlesource.com/llvm-project/+/59e1c6cd63eb9287df6516f9a5ae564075e9c218"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f08ae8d2dd1ff9ec3b033d099282dee05528413"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f08ae8d2dd1ff9ec3b033d099282dee05528413",
"title": "9f08ae8d2dd1ff9ec3b033d099282dee05528413",
"url": "https://llvm.googlesource.com/llvm-project/+/9f08ae8d2dd1ff9ec3b033d099282dee05528413"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fbd303ba5dd98d4513d62058bc1ad463507464ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fbd303ba5dd98d4513d62058bc1ad463507464ce",
"title": "fbd303ba5dd98d4513d62058bc1ad463507464ce",
"url": "https://llvm.googlesource.com/llvm-project/+/fbd303ba5dd98d4513d62058bc1ad463507464ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1195df25f4df987d258e6b46c090ca3e72eccecb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1195df25f4df987d258e6b46c090ca3e72eccecb",
"title": "1195df25f4df987d258e6b46c090ca3e72eccecb",
"url": "https://llvm.googlesource.com/llvm-project/+/1195df25f4df987d258e6b46c090ca3e72eccecb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "338c35aabfbede9ba10a4f48a13e63f37d6f8c7c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@338c35aabfbede9ba10a4f48a13e63f37d6f8c7c",
"title": "338c35aabfbede9ba10a4f48a13e63f37d6f8c7c",
"url": "https://llvm.googlesource.com/llvm-project/+/338c35aabfbede9ba10a4f48a13e63f37d6f8c7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d8fa01a66d5051356b698ef0264a01f6aade185"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d8fa01a66d5051356b698ef0264a01f6aade185",
"title": "8d8fa01a66d5051356b698ef0264a01f6aade185",
"url": "https://llvm.googlesource.com/llvm-project/+/8d8fa01a66d5051356b698ef0264a01f6aade185"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7d787df5b932b73aae6532d1e981152f103f9244"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7d787df5b932b73aae6532d1e981152f103f9244",
"title": "7d787df5b932b73aae6532d1e981152f103f9244",
"url": "https://llvm.googlesource.com/llvm-project/+/7d787df5b932b73aae6532d1e981152f103f9244"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8a77961280536b680c404a49002a00b988ca45fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8a77961280536b680c404a49002a00b988ca45fc",
"title": "8a77961280536b680c404a49002a00b988ca45fc",
"url": "https://llvm.googlesource.com/llvm-project/+/8a77961280536b680c404a49002a00b988ca45fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd82a84e0eeafb017c7220c4a9fbd0a8a407f8a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd82a84e0eeafb017c7220c4a9fbd0a8a407f8a9",
"title": "dd82a84e0eeafb017c7220c4a9fbd0a8a407f8a9",
"url": "https://llvm.googlesource.com/llvm-project/+/dd82a84e0eeafb017c7220c4a9fbd0a8a407f8a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e1a3aa8c0fb0103427c45a5c861fc98aa44a4821"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e1a3aa8c0fb0103427c45a5c861fc98aa44a4821",
"title": "e1a3aa8c0fb0103427c45a5c861fc98aa44a4821",
"url": "https://llvm.googlesource.com/llvm-project/+/e1a3aa8c0fb0103427c45a5c861fc98aa44a4821"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e28d30e335e6e075f4624ae8d5782fef6d3f1ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e28d30e335e6e075f4624ae8d5782fef6d3f1ed",
"title": "4e28d30e335e6e075f4624ae8d5782fef6d3f1ed",
"url": "https://llvm.googlesource.com/llvm-project/+/4e28d30e335e6e075f4624ae8d5782fef6d3f1ed"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4e28d30e335e6e075f4624ae8d5782fef6d3f1ed",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906948368892706432"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:38:46.852] Scheduled build:
{
"id": "8741518306959680321",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-24T15:38:46.465155983Z",
"updateTime": "2024-07-24T15:38:46.465155983Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4e28d30e335e6e075f4624ae8d5782fef6d3f1ed",
"ref": "refs/heads/main"
}
}
}
[15:38:46.852] Task URL: https://cr-buildbucket.appspot.com/build/8741518306959680321
[15:38:46.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:2:0) after 4m35s
[15:38:47.790] Received PubSub notification, asking Buildbucket for the build status
[15:38:47.809] Build status: SCHEDULED
[15:38:50.556] Received PubSub notification, asking Buildbucket for the build status
[15:38:50.580] Build status: STARTED
[15:43:21.964] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:2:0)
[15:43:21.992] Build status: STARTED
[15:43:21.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:5:0) after 2m44s
[15:46:06.184] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:5:0)
[15:46:06.204] Build status: STARTED
[15:46:06.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:6:0) after 7m50s
[15:53:56.244] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:6:0)
[15:53:56.264] Build status: STARTED
[15:53:56.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:7:0) after 3m5s
[15:57:01.248] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:7:0)
[15:57:01.276] Build status: STARTED
[15:57:01.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:8:0) after 5m51s
[16:02:52.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:8:0)
[16:02:52.285] Build status: STARTED
[16:02:52.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:9:0) after 1m34s
[16:04:26.295] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:9:0)
[16:04:26.327] Build status: STARTED
[16:04:26.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:10:0) after 7m50s
[16:12:16.447] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:10:0)
[16:12:16.474] Build status: STARTED
[16:12:16.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:11:0) after 3m34s
[16:15:50.559] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:11:0)
[16:15:50.580] Build status: STARTED
[16:15:50.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:12:0) after 6m43s
[16:22:33.654] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:12:0)
[16:22:33.708] Build status: STARTED
[16:22:33.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:13:0) after 6m45s
[16:29:18.871] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:13:0)
[16:29:18.897] Build status: STARTED
[16:29:18.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:14:0) after 4m2s
[16:33:20.915] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:14:0)
[16:33:20.933] Build status: STARTED
[16:33:20.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:15:0) after 6m2s
[16:39:22.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:15:0)
[16:39:22.999] Build status: STARTED
[16:39:22.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:16:0) after 2m51s
[16:42:14.185] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:16:0)
[16:42:14.222] Build status: STARTED
[16:42:14.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:17:0) after 5m27s
[16:47:41.299] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:17:0)
[16:47:41.352] Build status: STARTED
[16:47:41.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:18:0) after 8m36s
[16:56:17.385] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:18:0)
[16:56:17.408] Build status: STARTED
[16:56:17.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:19:0) after 7m40s
[17:03:57.548] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:19:0)
[17:03:57.571] Build status: STARTED
[17:03:57.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8906948368892706432:20:0) after 6m17s
[17:07:06.777] Received PubSub notification, asking Buildbucket for the build status
[17:07:06.797] Build:
{
"id": "8741518306959680321",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-24T15:38:46.465155983Z",
"startTime": "2024-07-24T15:38:50.322936607Z",
"endTime": "2024-07-24T17:07:03.138311702Z",
"updateTime": "2024-07-24T17:07:03.138311702Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4e28d30e335e6e075f4624ae8d5782fef6d3f1ed",
"ref": "refs/heads/main"
}
}
}
[17:07:06.797] Invocation finished in 1h28m21.558441367s with status SUCCEEDED