[16:07:26.089] New invocation is queued and will start shortly
[16:07:26.089] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[16:07:27.160] Starting the invocation (attempt 1)
[16:07:27.186] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/18933c6d7e06d162c17b6ec08a5e7c508236265f"
[16:07:27.186] Reconstructed gitiles commit from tags
[16:07:27.186] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:07:27.186] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:07:27.186] Buildbucket request:
{
"requestId": "8933491475619731904",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "0b69a9fe4951f3c8150857593792381ac3a7a9936ce3188497b3302bb9b92d4c/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5eba32c075fd8e12ab9f1cbbecac5af30b5c59e4",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8933491475619731904",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7c89f84447da0ef66d177097cd0513e5be7a83174afd64cbb208bc1d60215655/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f79c52944a4e95d85c94f2dd9b58d31226cda608",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f722db02d359e29ca001b78197ee1a275f8c3d7c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f722db02d359e29ca001b78197ee1a275f8c3d7c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "1da68bf2-e6c3-4e4f-bc87-6f4424093900",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7667a13f5b0221f905655d45687b0924dcd207d49d00dd860d79895a33b0cab2/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5eba32c075fd8e12ab9f1cbbecac5af30b5c59e4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ca611affd3e5dfe00e6ebe0488994bf93c2d135c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ca611affd3e5dfe00e6ebe0488994bf93c2d135c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c7c7a1be-f6b6-4801-a86f-f6b0eed78bcc",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f1e06ffdb98b05968b0409c287935e94023e426668a84fb92e5ced9d1f54a847/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5eba32c075fd8e12ab9f1cbbecac5af30b5c59e4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "32d16b64d3125e76f65d7d88a302a33618eb0e6e"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/32d16b64d3125e76f65d7d88a302a33618eb0e6e",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7ad38d87-f7bb-4da2-aca4-56d2cc644520",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "0b69a9fe4951f3c8150857593792381ac3a7a9936ce3188497b3302bb9b92d4c/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5eba32c075fd8e12ab9f1cbbecac5af30b5c59e4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "18933c6d7e06d162c17b6ec08a5e7c508236265f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/18933c6d7e06d162c17b6ec08a5e7c508236265f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "4a9a0877-aba3-4009-8bab-eba1cda2defe",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "18933c6d7e06d162c17b6ec08a5e7c508236265f"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "18933c6d7e06d162c17b6ec08a5e7c508236265f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8933491475619731904"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:07:27.699] Scheduled build:
{
"id": "8768061413747550689",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-05T16:07:27.244934997Z",
"updateTime": "2023-10-05T16:07:27.244934997Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "18933c6d7e06d162c17b6ec08a5e7c508236265f",
"ref": "refs/heads/main"
}
}
}
[16:07:27.699] Task URL: https://cr-buildbucket.appspot.com/build/8768061413747550689
[16:07:27.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:2:0) after 7m43s
[16:07:28.064] Received PubSub notification, asking Buildbucket for the build status
[16:07:28.102] Build status: SCHEDULED
[16:08:39.819] Received PubSub notification, asking Buildbucket for the build status
[16:08:39.910] Build status: STARTED
[16:15:10.717] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:2:0)
[16:15:10.762] Build status: STARTED
[16:15:10.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:5:0) after 2m17s
[16:17:27.856] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:5:0)
[16:17:28.024] Build status: STARTED
[16:17:28.024] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:6:0) after 2m45s
[16:20:13.047] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:6:0)
[16:20:13.080] Build status: STARTED
[16:20:13.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:7:0) after 4m58s
[16:25:11.117] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:7:0)
[16:25:11.208] Build status: STARTED
[16:25:11.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:8:0) after 3m5s
[16:28:16.257] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:8:0)
[16:28:16.351] Build status: STARTED
[16:28:16.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:9:0) after 3m13s
[16:31:29.408] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:9:0)
[16:31:29.431] Build status: STARTED
[16:31:29.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:10:0) after 2m10s
[16:33:39.565] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:10:0)
[16:33:39.640] Build status: STARTED
[16:33:39.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:11:0) after 2m28s
[16:36:07.671] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:11:0)
[16:36:07.709] Build status: STARTED
[16:36:07.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:12:0) after 8m30s
[16:44:37.784] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:12:0)
[16:44:37.825] Build status: STARTED
[16:44:37.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:13:0) after 3m13s
[16:47:50.821] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:13:0)
[16:47:50.843] Build status: STARTED
[16:47:50.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:14:0) after 4m45s
[16:52:35.924] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:14:0)
[16:52:35.973] Build status: STARTED
[16:52:35.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:15:0) after 9m23s
[17:01:59.023] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:15:0)
[17:01:59.045] Build status: STARTED
[17:01:59.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:16:0) after 8m50s
[17:10:49.066] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:16:0)
[17:10:49.086] Build status: STARTED
[17:10:49.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:17:0) after 3m0s
[17:13:49.104] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:17:0)
[17:13:49.123] Build status: STARTED
[17:13:49.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:18:0) after 2m37s
[17:16:26.238] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:18:0)
[17:16:26.304] Build status: STARTED
[17:16:26.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:19:0) after 2m58s
[17:19:24.398] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:19:0)
[17:19:24.431] Build status: STARTED
[17:19:24.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:20:0) after 9m30s
[17:28:54.735] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:20:0)
[17:28:54.833] Build status: STARTED
[17:28:54.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:21:0) after 4m58s
[17:33:53.394] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:21:0)
[17:33:53.412] Build status: STARTED
[17:33:53.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:22:0) after 9m16s
[17:43:09.427] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:22:0)
[17:43:09.451] Build status: STARTED
[17:43:09.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:23:0) after 4m45s
[17:47:54.529] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:23:0)
[17:47:54.554] Build status: STARTED
[17:47:54.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:24:0) after 3m27s
[17:51:21.647] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:24:0)
[17:51:21.679] Build status: STARTED
[17:51:21.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:25:0) after 4m48s
[17:56:09.696] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:25:0)
[17:56:09.830] Build status: STARTED
[17:56:09.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:26:0) after 4m11s
[18:00:21.282] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:26:0)
[18:00:22.064] Build status: STARTED
[18:00:22.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:27:0) after 2m31s
[18:02:53.129] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:27:0)
[18:02:53.244] Build status: STARTED
[18:02:53.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:28:0) after 5m56s
[18:08:49.637] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:28:0)
[18:08:49.654] Build status: STARTED
[18:08:49.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8933491475619731904:29:0) after 5m41s
[18:10:57.127] Received PubSub notification, asking Buildbucket for the build status
[18:10:57.193] Build:
{
"id": "8768061413747550689",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-05T16:07:27.244934997Z",
"startTime": "2023-10-05T16:08:38.950696Z",
"endTime": "2023-10-05T18:10:56.682955527Z",
"updateTime": "2023-10-05T18:10:56.682955527Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "18933c6d7e06d162c17b6ec08a5e7c508236265f",
"ref": "refs/heads/main"
}
}
}
[18:10:57.193] Invocation finished in 2h3m31.118460535s with status SUCCEEDED