[02:57:53.150] New invocation is queued and will start shortly
[02:57:53.150] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[02:57:54.736] Starting the invocation (attempt 1)
[02:57:54.778] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8fc68879badc2dc83e8b9a575992af285d4a1057"
[02:57:54.778] Reconstructed gitiles commit from tags
[02:57:54.778] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:57:54.778] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:57:54.778] Buildbucket request:
{
"requestId": "8913972204994869120",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b9fe5a8e495b8dbc462ba6f5241cfd2ff49cecf97db11b3c5b59fafc01d8a806/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "876932346430dbdb3f2f959e5ce360df11e01a62",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913972204994869120",
"job": "fuchsia/clang_toolchain.prod.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b9fe5a8e495b8dbc462ba6f5241cfd2ff49cecf97db11b3c5b59fafc01d8a806/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "876932346430dbdb3f2f959e5ce360df11e01a62",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8fc68879badc2dc83e8b9a575992af285d4a1057"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8fc68879badc2dc83e8b9a575992af285d4a1057",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "999b8f6c-fe24-4983-8efc-d405895adab4",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8fc68879badc2dc83e8b9a575992af285d4a1057"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8fc68879badc2dc83e8b9a575992af285d4a1057",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913972204994869120"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.prod.core.arm64-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"
}
}
[02:57:55.222] Scheduled build:
{
"id": "8748542142584977857",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-08T02:57:54.827999433Z",
"updateTime": "2024-05-08T02:57:54.827999433Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8fc68879badc2dc83e8b9a575992af285d4a1057",
"ref": "refs/heads/main"
}
}
}
[02:57:55.222] Task URL: https://cr-buildbucket.appspot.com/build/8748542142584977857
[02:57:55.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:2:0) after 8m40s
[02:57:56.148] Received PubSub notification, asking Buildbucket for the build status
[02:57:56.173] Build status: SCHEDULED
[02:58:01.070] Received PubSub notification, asking Buildbucket for the build status
[02:58:01.105] Build status: STARTED
[03:06:35.356] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:2:0)
[03:06:35.465] Build status: STARTED
[03:06:35.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:5:0) after 7m13s
[03:13:48.518] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:5:0)
[03:13:48.546] Build status: STARTED
[03:13:48.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:6:0) after 9m37s
[03:23:25.597] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:6:0)
[03:23:25.636] Build status: STARTED
[03:23:25.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:7:0) after 8m14s
[03:31:39.875] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:7:0)
[03:31:39.906] Build status: STARTED
[03:31:39.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:8:0) after 6m23s
[03:38:03.064] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:8:0)
[03:38:03.109] Build status: STARTED
[03:38:03.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:9:0) after 9m18s
[03:47:21.402] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:9:0)
[03:47:21.421] Build status: STARTED
[03:47:21.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:10:0) after 1m51s
[03:49:12.600] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:10:0)
[03:49:12.619] Build status: STARTED
[03:49:12.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:11:0) after 6m5s
[03:55:18.012] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:11:0)
[03:55:18.041] Build status: STARTED
[03:55:18.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:12:0) after 3m32s
[03:58:50.060] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:12:0)
[03:58:50.138] Build status: STARTED
[03:58:50.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:13:0) after 4m51s
[04:03:41.771] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:13:0)
[04:03:41.791] Build status: STARTED
[04:03:41.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:14:0) after 8m27s
[04:12:09.128] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:14:0)
[04:12:09.170] Build status: STARTED
[04:12:09.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:15:0) after 5m1s
[04:17:10.305] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:15:0)
[04:17:10.324] Build status: STARTED
[04:17:10.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:16:0) after 8m47s
[04:25:58.043] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:16:0)
[04:25:58.068] Build status: STARTED
[04:25:58.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:17:0) after 4m44s
[04:30:42.323] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:17:0)
[04:30:42.341] Build status: STARTED
[04:30:42.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:18:0) after 4m43s
[04:35:25.563] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:18:0)
[04:35:25.584] Build status: STARTED
[04:35:25.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:19:0) after 5m5s
[04:40:30.766] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:19:0)
[04:40:30.790] Build status: STARTED
[04:40:30.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:20:0) after 2m41s
[04:43:12.007] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:20:0)
[04:43:12.065] Build status: STARTED
[04:43:12.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:21:0) after 6m54s
[04:50:06.281] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:21:0)
[04:50:06.307] Build status: STARTED
[04:50:06.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:22:0) after 1m44s
[04:51:50.364] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:22:0)
[04:51:50.494] Build status: STARTED
[04:51:50.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:23:0) after 3m48s
[04:55:38.599] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:23:0)
[04:55:38.643] Build status: STARTED
[04:55:38.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:24:0) after 6m54s
[05:02:33.265] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:24:0)
[05:02:33.401] Build status: STARTED
[05:02:33.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:25:0) after 9m37s
[05:12:10.420] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:25:0)
[05:12:10.444] Build status: STARTED
[05:12:10.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:26:0) after 1m26s
[05:13:36.590] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:26:0)
[05:13:36.610] Build status: STARTED
[05:13:36.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:27:0) after 2m51s
[05:16:27.639] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:27:0)
[05:16:27.664] Build status: STARTED
[05:16:27.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:28:0) after 9m31s
[05:25:59.017] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:28:0)
[05:25:59.066] Build status: STARTED
[05:25:59.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-debug:8913972204994869120:29:0) after 8m8s
[05:30:02.779] Received PubSub notification, asking Buildbucket for the build status
[05:30:02.805] Build:
{
"id": "8748542142584977857",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-08T02:57:54.827999433Z",
"startTime": "2024-05-08T02:58:00.791727969Z",
"endTime": "2024-05-08T05:30:02.253809974Z",
"updateTime": "2024-05-08T05:30:02.253809974Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8fc68879badc2dc83e8b9a575992af285d4a1057",
"ref": "refs/heads/main"
}
}
}
[05:30:02.805] Invocation finished in 2h32m9.660372358s with status SUCCEEDED