[11:27:46.883] New invocation is queued and will start shortly
[11:27:47.999] Starting the invocation (attempt 1)
[11:27:48.023] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e086d7b1464ad091ae849cb907f8647c8439cb66"
[11:27:48.023] Popped gitiles commit info from properties and tags
[11:27:48.023] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:27:48.024] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:27:48.024] Buildbucket request:
{
"requestId": "8881778202072207856",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8881778202072207856",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5afe9c72e4bea2ea38beb1cb0d3a3edc9a958414"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5afe9c72e4bea2ea38beb1cb0d3a3edc9a958414",
"title": "5afe9c72e4bea2ea38beb1cb0d3a3edc9a958414",
"url": "https://llvm.googlesource.com/llvm-project/+/5afe9c72e4bea2ea38beb1cb0d3a3edc9a958414"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6ba1a62a6c512e32bf85f21b59b2c8e507d1a72e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6ba1a62a6c512e32bf85f21b59b2c8e507d1a72e",
"title": "6ba1a62a6c512e32bf85f21b59b2c8e507d1a72e",
"url": "https://llvm.googlesource.com/llvm-project/+/6ba1a62a6c512e32bf85f21b59b2c8e507d1a72e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0c4876eede8e68de22dc5296b037556c7cca981"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0c4876eede8e68de22dc5296b037556c7cca981",
"title": "a0c4876eede8e68de22dc5296b037556c7cca981",
"url": "https://llvm.googlesource.com/llvm-project/+/a0c4876eede8e68de22dc5296b037556c7cca981"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6ae4030d4cfc1b994be8e100ef72707ff570c89d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6ae4030d4cfc1b994be8e100ef72707ff570c89d",
"title": "6ae4030d4cfc1b994be8e100ef72707ff570c89d",
"url": "https://llvm.googlesource.com/llvm-project/+/6ae4030d4cfc1b994be8e100ef72707ff570c89d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2085119887397c4333d70e32a543fe32116756ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2085119887397c4333d70e32a543fe32116756ce",
"title": "2085119887397c4333d70e32a543fe32116756ce",
"url": "https://llvm.googlesource.com/llvm-project/+/2085119887397c4333d70e32a543fe32116756ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "32059ce1210da09ed3abfe3ff257b11897251650"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@32059ce1210da09ed3abfe3ff257b11897251650",
"title": "32059ce1210da09ed3abfe3ff257b11897251650",
"url": "https://llvm.googlesource.com/llvm-project/+/32059ce1210da09ed3abfe3ff257b11897251650"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cebf86eb1de163faaf5f9781f6bbded70dc1f9f0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cebf86eb1de163faaf5f9781f6bbded70dc1f9f0",
"title": "cebf86eb1de163faaf5f9781f6bbded70dc1f9f0",
"url": "https://llvm.googlesource.com/llvm-project/+/cebf86eb1de163faaf5f9781f6bbded70dc1f9f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5147b83ee684470a8c903e2f05561abfb644ab28"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5147b83ee684470a8c903e2f05561abfb644ab28",
"title": "5147b83ee684470a8c903e2f05561abfb644ab28",
"url": "https://llvm.googlesource.com/llvm-project/+/5147b83ee684470a8c903e2f05561abfb644ab28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0b6d71fe10d46741a6f50c17b3fc795fd82e27b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0b6d71fe10d46741a6f50c17b3fc795fd82e27b7",
"title": "0b6d71fe10d46741a6f50c17b3fc795fd82e27b7",
"url": "https://llvm.googlesource.com/llvm-project/+/0b6d71fe10d46741a6f50c17b3fc795fd82e27b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "475531b884a1a203af6367df35f1722fe2383e06"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@475531b884a1a203af6367df35f1722fe2383e06",
"title": "475531b884a1a203af6367df35f1722fe2383e06",
"url": "https://llvm.googlesource.com/llvm-project/+/475531b884a1a203af6367df35f1722fe2383e06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cf17ee1d3a7ec78dbd922b3eb3944ac49cb78737"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cf17ee1d3a7ec78dbd922b3eb3944ac49cb78737",
"title": "cf17ee1d3a7ec78dbd922b3eb3944ac49cb78737",
"url": "https://llvm.googlesource.com/llvm-project/+/cf17ee1d3a7ec78dbd922b3eb3944ac49cb78737"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec1016f7ef9ff97ecef6e2e84a55d36d7bfbe803"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec1016f7ef9ff97ecef6e2e84a55d36d7bfbe803",
"title": "ec1016f7ef9ff97ecef6e2e84a55d36d7bfbe803",
"url": "https://llvm.googlesource.com/llvm-project/+/ec1016f7ef9ff97ecef6e2e84a55d36d7bfbe803"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd87127f4e579d9c13480b40a79860d19a5891f1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd87127f4e579d9c13480b40a79860d19a5891f1",
"title": "dd87127f4e579d9c13480b40a79860d19a5891f1",
"url": "https://llvm.googlesource.com/llvm-project/+/dd87127f4e579d9c13480b40a79860d19a5891f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "be82be281d92091af98f2d27f2a8dad7bc160a62"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@be82be281d92091af98f2d27f2a8dad7bc160a62",
"title": "be82be281d92091af98f2d27f2a8dad7bc160a62",
"url": "https://llvm.googlesource.com/llvm-project/+/be82be281d92091af98f2d27f2a8dad7bc160a62"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "12a4ec6b1af8a50d31ee91093666e0fa455a4c35"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@12a4ec6b1af8a50d31ee91093666e0fa455a4c35",
"title": "12a4ec6b1af8a50d31ee91093666e0fa455a4c35",
"url": "https://llvm.googlesource.com/llvm-project/+/12a4ec6b1af8a50d31ee91093666e0fa455a4c35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "73d90ec8257488deaf6cc9b00dc778b109d5dfc0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@73d90ec8257488deaf6cc9b00dc778b109d5dfc0",
"title": "73d90ec8257488deaf6cc9b00dc778b109d5dfc0",
"url": "https://llvm.googlesource.com/llvm-project/+/73d90ec8257488deaf6cc9b00dc778b109d5dfc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e086d7b1464ad091ae849cb907f8647c8439cb66"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e086d7b1464ad091ae849cb907f8647c8439cb66",
"title": "e086d7b1464ad091ae849cb907f8647c8439cb66",
"url": "https://llvm.googlesource.com/llvm-project/+/e086d7b1464ad091ae849cb907f8647c8439cb66"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e086d7b1464ad091ae849cb907f8647c8439cb66",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8881778202072207856"
},
{
"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"
}
}
[11:27:48.396] Scheduled build:
{
"id": "8716348140169479009",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-28T11:27:48.072299786Z",
"updateTime": "2025-04-28T11:27:48.072299786Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e086d7b1464ad091ae849cb907f8647c8439cb66",
"ref": "refs/heads/main"
}
}
}
[11:27:48.396] Task URL: https://cr-buildbucket.appspot.com/build/8716348140169479009
[11:27:48.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:2:0) after 6m20s
[11:27:49.390] Received PubSub notification, asking Buildbucket for the build status
[11:27:49.416] Build status: SCHEDULED
[11:34:08.464] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:2:0)
[11:34:08.497] Build status: SCHEDULED
[11:34:08.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:4:0) after 3m29s
[11:37:37.728] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:4:0)
[11:37:37.747] Build status: SCHEDULED
[11:37:37.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:5:0) after 8m20s
[11:45:57.794] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:5:0)
[11:45:57.885] Build status: SCHEDULED
[11:45:57.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:6:0) after 3m58s
[11:46:32.989] Received PubSub notification, asking Buildbucket for the build status
[11:46:33.017] Build status: STARTED
[11:49:55.956] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:6:0)
[11:49:56.098] Build status: STARTED
[11:49:56.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:8:0) after 3m25s
[11:53:21.084] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:8:0)
[11:53:21.101] Build status: STARTED
[11:53:21.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:9:0) after 6m49s
[12:00:10.203] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:9:0)
[12:00:10.248] Build status: STARTED
[12:00:10.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:10:0) after 1m33s
[12:01:43.346] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:10:0)
[12:01:43.369] Build status: STARTED
[12:01:43.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:11:0) after 3m20s
[12:05:03.757] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:11:0)
[12:05:03.799] Build status: STARTED
[12:05:03.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:12:0) after 5m24s
[12:10:27.814] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:12:0)
[12:10:27.843] Build status: STARTED
[12:10:27.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:13:0) after 2m39s
[12:13:06.862] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:13:0)
[12:13:06.885] Build status: STARTED
[12:13:06.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:14:0) after 1m49s
[12:14:56.013] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:14:0)
[12:14:56.061] Build status: STARTED
[12:14:56.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:15:0) after 8m18s
[12:23:14.136] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:15:0)
[12:23:14.156] Build status: STARTED
[12:23:14.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:16:0) after 5m54s
[12:29:08.411] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:16:0)
[12:29:08.435] Build status: STARTED
[12:29:08.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:17:0) after 9m28s
[12:38:36.489] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:17:0)
[12:38:36.505] Build status: STARTED
[12:38:36.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:18:0) after 5m38s
[12:44:14.635] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:18:0)
[12:44:14.656] Build status: STARTED
[12:44:14.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:19:0) after 4m59s
[12:49:13.772] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:19:0)
[12:49:13.792] Build status: STARTED
[12:49:13.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:20:0) after 4m21s
[12:53:34.890] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:20:0)
[12:53:35.105] Build status: STARTED
[12:53:35.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:21:0) after 1m41s
[12:55:16.086] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:21:0)
[12:55:16.106] Build status: STARTED
[12:55:16.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:22:0) after 4m19s
[12:59:35.120] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:22:0)
[12:59:35.136] Build status: STARTED
[12:59:35.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:23:0) after 7m25s
[13:07:00.157] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:23:0)
[13:07:00.179] Build status: STARTED
[13:07:00.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:24:0) after 6m25s
[13:13:25.224] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:24:0)
[13:13:25.244] Build status: STARTED
[13:13:25.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:25:0) after 1m30s
[13:14:55.260] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:25:0)
[13:14:55.280] Build status: STARTED
[13:14:55.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:26:0) after 2m37s
[13:17:32.413] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:26:0)
[13:17:32.431] Build status: STARTED
[13:17:32.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881778202072207856:27:0) after 9m42s
[13:22:09.249] Received PubSub notification, asking Buildbucket for the build status
[13:22:09.273] Build:
{
"id": "8716348140169479009",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-28T11:27:48.072299786Z",
"startTime": "2025-04-28T11:46:32.703299993Z",
"endTime": "2025-04-28T13:22:08.733084222Z",
"updateTime": "2025-04-28T13:22:08.733084222Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e086d7b1464ad091ae849cb907f8647c8439cb66",
"ref": "refs/heads/main"
}
}
}
[13:22:09.273] Invocation finished in 1h54m22.399423741s with status SUCCEEDED