[18:13:31.025] New invocation is queued and will start shortly
[18:13:32.171] Starting the invocation (attempt 1)
[18:13:32.199] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e14827f0828d14ef17ab76316e8449d1b76e2617"
[18:13:32.199] Popped gitiles commit info from properties and tags
[18:13:32.199] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:13:32.199] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:13:32.199] Buildbucket request:
{
"requestId": "8896157593051270848",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896157593051270848",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e660e6503ba14684bd460b7baaf3da7336d0f46e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e660e6503ba14684bd460b7baaf3da7336d0f46e",
"title": "e660e6503ba14684bd460b7baaf3da7336d0f46e",
"url": "https://llvm.googlesource.com/llvm-project/+/e660e6503ba14684bd460b7baaf3da7336d0f46e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e2368afbd0d9b7e8fb900f54c8d71787e44d5774"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e2368afbd0d9b7e8fb900f54c8d71787e44d5774",
"title": "e2368afbd0d9b7e8fb900f54c8d71787e44d5774",
"url": "https://llvm.googlesource.com/llvm-project/+/e2368afbd0d9b7e8fb900f54c8d71787e44d5774"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa9bcb4d9f47beaea0898d00f77971549603e25e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa9bcb4d9f47beaea0898d00f77971549603e25e",
"title": "fa9bcb4d9f47beaea0898d00f77971549603e25e",
"url": "https://llvm.googlesource.com/llvm-project/+/fa9bcb4d9f47beaea0898d00f77971549603e25e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ae023f3499dda3975e6379bc4c0a8d097ac18f60"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ae023f3499dda3975e6379bc4c0a8d097ac18f60",
"title": "ae023f3499dda3975e6379bc4c0a8d097ac18f60",
"url": "https://llvm.googlesource.com/llvm-project/+/ae023f3499dda3975e6379bc4c0a8d097ac18f60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba7cc955662cfebb614c6a37a7341ba6072a0b70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba7cc955662cfebb614c6a37a7341ba6072a0b70",
"title": "ba7cc955662cfebb614c6a37a7341ba6072a0b70",
"url": "https://llvm.googlesource.com/llvm-project/+/ba7cc955662cfebb614c6a37a7341ba6072a0b70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "81c2024311ab1f0a30c73df8d0957b86c5dac282"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@81c2024311ab1f0a30c73df8d0957b86c5dac282",
"title": "81c2024311ab1f0a30c73df8d0957b86c5dac282",
"url": "https://llvm.googlesource.com/llvm-project/+/81c2024311ab1f0a30c73df8d0957b86c5dac282"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0733f384142b02558b80b3e9a4633dc4d202a14b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0733f384142b02558b80b3e9a4633dc4d202a14b",
"title": "0733f384142b02558b80b3e9a4633dc4d202a14b",
"url": "https://llvm.googlesource.com/llvm-project/+/0733f384142b02558b80b3e9a4633dc4d202a14b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "81055ff070e128bff78c8fa2d8ffe4c92ae692a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@81055ff070e128bff78c8fa2d8ffe4c92ae692a6",
"title": "81055ff070e128bff78c8fa2d8ffe4c92ae692a6",
"url": "https://llvm.googlesource.com/llvm-project/+/81055ff070e128bff78c8fa2d8ffe4c92ae692a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "74046855981bad2847c8f03114efd731da4d216c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@74046855981bad2847c8f03114efd731da4d216c",
"title": "74046855981bad2847c8f03114efd731da4d216c",
"url": "https://llvm.googlesource.com/llvm-project/+/74046855981bad2847c8f03114efd731da4d216c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8f8dcedb007c21412956208e524ff245c0ba5f58"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8f8dcedb007c21412956208e524ff245c0ba5f58",
"title": "8f8dcedb007c21412956208e524ff245c0ba5f58",
"url": "https://llvm.googlesource.com/llvm-project/+/8f8dcedb007c21412956208e524ff245c0ba5f58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f342f94b258bbf31efa2a6dc458229832fb5c6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"title": "1f342f94b258bbf31efa2a6dc458229832fb5c6f",
"url": "https://llvm.googlesource.com/llvm-project/+/1f342f94b258bbf31efa2a6dc458229832fb5c6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6473a36edc571cf0734a2e8d4354e332efb170e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6473a36edc571cf0734a2e8d4354e332efb170e9",
"title": "6473a36edc571cf0734a2e8d4354e332efb170e9",
"url": "https://llvm.googlesource.com/llvm-project/+/6473a36edc571cf0734a2e8d4354e332efb170e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e14827f0828d14ef17ab76316e8449d1b76e2617"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e14827f0828d14ef17ab76316e8449d1b76e2617",
"title": "e14827f0828d14ef17ab76316e8449d1b76e2617",
"url": "https://llvm.googlesource.com/llvm-project/+/e14827f0828d14ef17ab76316e8449d1b76e2617"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e14827f0828d14ef17ab76316e8449d1b76e2617",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896157593051270848"
},
{
"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"
}
}
[18:13:32.908] Scheduled build:
{
"id": "8730727531022105617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-20T18:13:32.331146360Z",
"updateTime": "2024-11-20T18:13:32.331146360Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e14827f0828d14ef17ab76316e8449d1b76e2617",
"ref": "refs/heads/main"
}
}
}
[18:13:32.908] Task URL: https://cr-buildbucket.appspot.com/build/8730727531022105617
[18:13:32.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:2:0) after 3m25s
[18:13:33.804] Received PubSub notification, asking Buildbucket for the build status
[18:13:33.834] Build status: SCHEDULED
[18:13:37.981] Received PubSub notification, asking Buildbucket for the build status
[18:13:38.008] Build status: STARTED
[18:16:57.989] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:2:0)
[18:16:58.015] Build status: STARTED
[18:16:58.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:5:0) after 1m27s
[18:18:25.070] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:5:0)
[18:18:25.105] Build status: STARTED
[18:18:25.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:6:0) after 1m36s
[18:20:01.172] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:6:0)
[18:20:01.254] Build status: STARTED
[18:20:01.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:7:0) after 6m19s
[18:26:20.270] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:7:0)
[18:26:20.302] Build status: STARTED
[18:26:20.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:8:0) after 6m58s
[18:33:18.496] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:8:0)
[18:33:18.548] Build status: STARTED
[18:33:18.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:9:0) after 1m8s
[18:34:26.615] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:9:0)
[18:34:26.635] Build status: STARTED
[18:34:26.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:10:0) after 4m36s
[18:39:02.649] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:10:0)
[18:39:02.669] Build status: STARTED
[18:39:02.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:11:0) after 2m20s
[18:41:22.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:11:0)
[18:41:22.778] Build status: STARTED
[18:41:22.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:12:0) after 1m59s
[18:43:21.835] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:12:0)
[18:43:21.857] Build status: STARTED
[18:43:21.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:13:0) after 8m5s
[18:51:26.932] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:13:0)
[18:51:26.948] Build status: STARTED
[18:51:26.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:14:0) after 3m21s
[18:54:48.194] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:14:0)
[18:54:48.215] Build status: STARTED
[18:54:48.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:15:0) after 3m34s
[18:58:22.231] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:15:0)
[18:58:22.247] Build status: STARTED
[18:58:22.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:16:0) after 3m28s
[19:01:50.316] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:16:0)
[19:01:50.337] Build status: STARTED
[19:01:50.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:17:0) after 3m10s
[19:05:00.457] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:17:0)
[19:05:00.562] Build status: STARTED
[19:05:00.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:18:0) after 4m46s
[19:09:46.570] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:18:0)
[19:09:46.647] Build status: STARTED
[19:09:46.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:19:0) after 9m39s
[19:19:25.643] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:19:0)
[19:19:25.663] Build status: STARTED
[19:19:25.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:20:0) after 4m29s
[19:23:54.780] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:20:0)
[19:23:54.798] Build status: STARTED
[19:23:54.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:21:0) after 5m17s
[19:29:11.870] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:21:0)
[19:29:11.930] Build status: STARTED
[19:29:11.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:22:0) after 1m29s
[19:30:40.997] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:22:0)
[19:30:41.054] Build status: STARTED
[19:30:41.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:23:0) after 3m41s
[19:34:22.214] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:23:0)
[19:34:22.234] Build status: STARTED
[19:34:22.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:24:0) after 9m37s
[19:43:59.317] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:24:0)
[19:43:59.348] Build status: STARTED
[19:43:59.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:25:0) after 2m50s
[19:46:49.396] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:25:0)
[19:46:49.414] Build status: STARTED
[19:46:49.414] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8896157593051270848:26:0) after 6m15s
[19:50:02.238] Received PubSub notification, asking Buildbucket for the build status
[19:50:02.287] Build:
{
"id": "8730727531022105617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-20T18:13:32.331146360Z",
"startTime": "2024-11-20T18:13:37.734541248Z",
"endTime": "2024-11-20T19:50:01.798329866Z",
"updateTime": "2024-11-20T19:50:01.798329866Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e14827f0828d14ef17ab76316e8449d1b76e2617",
"ref": "refs/heads/main"
}
}
}
[19:50:02.287] Invocation finished in 1h36m31.274960879s with status SUCCEEDED