[20:20:15.367] New invocation is queued and will start shortly
[20:20:15.367] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[20:20:18.071] Starting the invocation (attempt 1)
[20:20:18.113] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e28c393bd1c1f22f229d156b0b8283746cdac322"
[20:20:18.113] Reconstructed gitiles commit from tags
[20:20:18.113] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:20:18.114] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:20:18.114] Buildbucket request:
{
"requestId": "8930576466562853664",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "bf742d076ced8a6ed2b2338e0baf0946a6a7a168663cfdeaf75d6e8cd83d215d/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89ff9d1e18cb4770cfa222613dfc20bf9d70fc32",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8930576466562853664",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "006c738f2131e758598d6d12447cbf318aa4e260b23665d3999d33648e902f49/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "28f95b0995b68d594cf20043f9ae80745f68e7af",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c3851a987be66ffd78cb9b25a6b6f912104099dd"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c3851a987be66ffd78cb9b25a6b6f912104099dd",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "98651a94-68cd-4065-82c9-3042d51c9348",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6eed859abd541071e7745f0e75c2fa3ce79abe5a7f01fa6a7a75c417b737e5f5/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "28f95b0995b68d594cf20043f9ae80745f68e7af",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5aa2c65abdd1e3cb73640e088d36a86e98be2a78"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5aa2c65abdd1e3cb73640e088d36a86e98be2a78",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "b43e9bf7-c56e-41dd-8478-8fde315692ec",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "bf742d076ced8a6ed2b2338e0baf0946a6a7a168663cfdeaf75d6e8cd83d215d/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "89ff9d1e18cb4770cfa222613dfc20bf9d70fc32",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e28c393bd1c1f22f229d156b0b8283746cdac322"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e28c393bd1c1f22f229d156b0b8283746cdac322",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c4e45f87-0c7a-4b50-af33-76cbe54dbd8c",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e28c393bd1c1f22f229d156b0b8283746cdac322"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e28c393bd1c1f22f229d156b0b8283746cdac322",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8930576466562853664"
},
{
"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"
}
}
[20:20:18.645] Scheduled build:
{
"id": "8765146402916914929",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-06T20:20:18.205991107Z",
"updateTime": "2023-11-06T20:20:18.205991107Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e28c393bd1c1f22f229d156b0b8283746cdac322",
"ref": "refs/heads/main"
}
}
}
[20:20:18.645] Task URL: https://cr-buildbucket.appspot.com/build/8765146402916914929
[20:20:18.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:2:0) after 5m12s
[20:20:19.626] Received PubSub notification, asking Buildbucket for the build status
[20:20:19.646] Build status: SCHEDULED
[20:20:20.408] Received PubSub notification, asking Buildbucket for the build status
[20:20:20.477] Build status: STARTED
[20:25:30.659] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:2:0)
[20:25:30.684] Build status: STARTED
[20:25:30.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:5:0) after 6m1s
[20:31:31.675] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:5:0)
[20:31:31.700] Build status: STARTED
[20:31:31.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:6:0) after 9m43s
[20:41:14.764] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:6:0)
[20:41:14.797] Build status: STARTED
[20:41:14.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:7:0) after 1m12s
[20:42:26.813] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:7:0)
[20:42:26.914] Build status: STARTED
[20:42:26.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:8:0) after 7m39s
[20:50:06.018] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:8:0)
[20:50:06.061] Build status: STARTED
[20:50:06.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:9:0) after 7m27s
[20:57:33.089] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:9:0)
[20:57:33.125] Build status: STARTED
[20:57:33.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:10:0) after 7m16s
[21:04:49.149] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:10:0)
[21:04:49.168] Build status: STARTED
[21:04:49.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:11:0) after 6m14s
[21:11:03.136] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:11:0)
[21:11:03.175] Build status: STARTED
[21:11:03.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:12:0) after 5m36s
[21:16:39.216] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:12:0)
[21:16:39.240] Build status: STARTED
[21:16:39.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:13:0) after 6m23s
[21:23:02.217] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:13:0)
[21:23:02.240] Build status: STARTED
[21:23:02.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:14:0) after 5m0s
[21:28:02.300] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:14:0)
[21:28:02.326] Build status: STARTED
[21:28:02.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:15:0) after 9m6s
[21:37:08.395] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:15:0)
[21:37:08.416] Build status: STARTED
[21:37:08.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:16:0) after 7m19s
[21:44:27.512] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:16:0)
[21:44:27.616] Build status: STARTED
[21:44:27.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:17:0) after 3m19s
[21:47:46.695] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:17:0)
[21:47:46.723] Build status: STARTED
[21:47:46.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:18:0) after 3m53s
[21:51:39.870] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:18:0)
[21:51:39.888] Build status: STARTED
[21:51:39.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:19:0) after 7m17s
[21:58:56.914] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:19:0)
[21:58:56.937] Build status: STARTED
[21:58:56.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:20:0) after 9m0s
[22:07:56.943] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:20:0)
[22:07:56.965] Build status: STARTED
[22:07:56.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:21:0) after 7m14s
[22:15:10.985] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:21:0)
[22:15:11.007] Build status: STARTED
[22:15:11.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930576466562853664:22:0) after 5m18s
[22:18:20.320] Received PubSub notification, asking Buildbucket for the build status
[22:18:20.344] Build:
{
"id": "8765146402916914929",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-06T20:20:18.205991107Z",
"startTime": "2023-11-06T20:20:19.338105Z",
"endTime": "2023-11-06T22:18:19.400742Z",
"updateTime": "2023-11-06T22:18:19.400742Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e28c393bd1c1f22f229d156b0b8283746cdac322",
"ref": "refs/heads/main"
}
}
}
[22:18:20.344] Invocation finished in 1h58m5.00037335s with status SUCCEEDED