[18:25:47.110] New invocation is queued and will start shortly
[18:25:47.110] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[18:25:49.019] Starting the invocation (attempt 1)
[18:25:49.047] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7dc84e225e11e37925db6f4f08269f447d2f2347"
[18:25:49.047] Reconstructed gitiles commit from tags
[18:25:49.047] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:25:49.047] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:25:49.048] Buildbucket request:
{
"requestId": "8911467708532532400",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a466b0720f20cda0c8680860691d2dfd424868a6e7c54b565b634b17e768d8c7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0ff2204729ac3df20bd741736c4370c77080a657",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8911467708532532400",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "57f21bfe1c4d16e5a336ba0474c5094a77f70a0bf431c33a8c5bc26779737a86/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0ff2204729ac3df20bd741736c4370c77080a657",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "492417278d986ddd8206b2b9bba626ce690ea244"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/492417278d986ddd8206b2b9bba626ce690ea244",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f433fa58-1aa3-49a0-b017-a2cb04398352",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cbcd1d6acfbdcf55faeba7f066ca3ecebd883b532b8f21df291be13d855ce6d5/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0ff2204729ac3df20bd741736c4370c77080a657",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "0a39c88e81dadca9f6ceef8e0b0be0ed692fe4fe"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0a39c88e81dadca9f6ceef8e0b0be0ed692fe4fe",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "390c4bb0-6392-4a69-a84a-a8b982643c4a",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f58c15771800e387d6204eca3f41fb7d0b42b3e73a76b8a7f71bcbd4ec1449c8/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0ff2204729ac3df20bd741736c4370c77080a657",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5ae5774fb0b5cac11af479b0905dfdd5255b4047"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5ae5774fb0b5cac11af479b0905dfdd5255b4047",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f2c9980d-10ea-4f71-ad07-c40e85d2d834",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "061d8280d9d60034e4d7b1b83a46886d088dae58a566f0706d13b82cf274bfbd/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0ff2204729ac3df20bd741736c4370c77080a657",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "0cb66a7bd52ee51a6b43c42fec22082b26365e37"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0cb66a7bd52ee51a6b43c42fec22082b26365e37",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e7e096d4-529e-4114-b533-38d32cff4b3c",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a466b0720f20cda0c8680860691d2dfd424868a6e7c54b565b634b17e768d8c7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0ff2204729ac3df20bd741736c4370c77080a657",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7dc84e225e11e37925db6f4f08269f447d2f2347"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7dc84e225e11e37925db6f4f08269f447d2f2347",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "dc54bf32-7a5a-4aec-91f1-70f9bee64cd7",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7dc84e225e11e37925db6f4f08269f447d2f2347"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7dc84e225e11e37925db6f4f08269f447d2f2347",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8911467708532532400"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-release"
},
{
"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"
}
}
[18:25:49.660] Scheduled build:
{
"id": "8746037645771055697",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-04T18:25:49.113671374Z",
"updateTime": "2024-06-04T18:25:49.113671374Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7dc84e225e11e37925db6f4f08269f447d2f2347",
"ref": "refs/heads/main"
}
}
}
[18:25:49.660] Task URL: https://cr-buildbucket.appspot.com/build/8746037645771055697
[18:25:49.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:2:0) after 1m44s
[18:25:50.622] Received PubSub notification, asking Buildbucket for the build status
[18:25:50.671] Build status: SCHEDULED
[18:26:32.034] Received PubSub notification, asking Buildbucket for the build status
[18:26:32.067] Build status: STARTED
[18:27:33.744] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:2:0)
[18:27:33.772] Build status: STARTED
[18:27:33.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:5:0) after 1m49s
[18:29:22.810] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:5:0)
[18:29:22.848] Build status: STARTED
[18:29:22.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:6:0) after 2m4s
[18:31:26.865] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:6:0)
[18:31:26.903] Build status: STARTED
[18:31:26.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:7:0) after 1m34s
[18:33:00.921] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:7:0)
[18:33:00.950] Build status: STARTED
[18:33:00.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:8:0) after 4m3s
[18:37:03.969] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:8:0)
[18:37:04.054] Build status: STARTED
[18:37:04.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:9:0) after 8m48s
[18:45:52.125] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:9:0)
[18:45:52.146] Build status: STARTED
[18:45:52.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:10:0) after 2m48s
[18:48:40.155] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:10:0)
[18:48:40.177] Build status: STARTED
[18:48:40.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:11:0) after 1m41s
[18:50:21.314] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:11:0)
[18:50:21.339] Build status: STARTED
[18:50:21.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:12:0) after 1m56s
[18:52:17.360] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:12:0)
[18:52:17.390] Build status: STARTED
[18:52:17.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:13:0) after 4m18s
[18:56:35.466] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:13:0)
[18:56:35.486] Build status: STARTED
[18:56:35.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:14:0) after 6m52s
[19:03:27.578] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:14:0)
[19:03:27.597] Build status: STARTED
[19:03:27.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:15:0) after 1m46s
[19:05:13.632] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:15:0)
[19:05:13.676] Build status: STARTED
[19:05:13.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:16:0) after 3m49s
[19:09:02.770] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:16:0)
[19:09:02.799] Build status: STARTED
[19:09:02.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:17:0) after 8m38s
[19:17:40.824] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:17:0)
[19:17:40.876] Build status: STARTED
[19:17:40.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:18:0) after 8m33s
[19:26:13.898] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:18:0)
[19:26:13.916] Build status: STARTED
[19:26:13.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:19:0) after 1m47s
[19:28:00.985] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:19:0)
[19:28:01.008] Build status: STARTED
[19:28:01.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:20:0) after 1m30s
[19:29:31.082] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:20:0)
[19:29:31.102] Build status: STARTED
[19:29:31.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:21:0) after 5m24s
[19:34:55.172] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:21:0)
[19:34:55.222] Build status: STARTED
[19:34:55.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:22:0) after 1m52s
[19:36:47.199] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:22:0)
[19:36:47.308] Build status: STARTED
[19:36:47.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:23:0) after 2m50s
[19:39:37.348] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:23:0)
[19:39:37.368] Build status: STARTED
[19:39:37.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:24:0) after 7m31s
[19:47:08.396] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:24:0)
[19:47:08.422] Build status: STARTED
[19:47:08.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:25:0) after 5m49s
[19:52:57.443] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:25:0)
[19:52:57.470] Build status: STARTED
[19:52:57.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:26:0) after 5m39s
[19:58:36.492] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:26:0)
[19:58:36.509] Build status: STARTED
[19:58:36.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:27:0) after 1m53s
[20:00:29.553] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:27:0)
[20:00:29.581] Build status: STARTED
[20:00:29.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:28:0) after 7m51s
[20:08:20.671] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:28:0)
[20:08:20.688] Build status: STARTED
[20:08:20.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:29:0) after 3m58s
[20:12:18.930] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:29:0)
[20:12:18.946] Build status: STARTED
[20:12:18.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:30:0) after 9m25s
[20:21:44.019] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:30:0)
[20:21:44.036] Build status: STARTED
[20:21:44.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:31:0) after 3m52s
[20:25:36.056] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:31:0)
[20:25:36.078] Build status: STARTED
[20:25:36.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:32:0) after 2m8s
[20:27:44.162] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:32:0)
[20:27:44.183] Build status: STARTED
[20:27:44.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:33:0) after 1m12s
[20:28:56.299] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:33:0)
[20:28:56.316] Build status: STARTED
[20:28:56.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:34:0) after 6m48s
[20:35:44.429] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:34:0)
[20:35:44.500] Build status: STARTED
[20:35:44.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:35:0) after 8m32s
[20:44:16.518] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:35:0)
[20:44:16.548] Build status: STARTED
[20:44:16.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:36:0) after 4m48s
[20:49:04.570] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:36:0)
[20:49:04.618] Build status: STARTED
[20:49:04.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:37:0) after 6m23s
[20:55:27.638] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:37:0)
[20:55:27.682] Build status: STARTED
[20:55:27.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8911467708532532400:38:0) after 9m40s
[21:03:21.136] Received PubSub notification, asking Buildbucket for the build status
[21:03:21.157] Build:
{
"id": "8746037645771055697",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-04T18:25:49.113671374Z",
"startTime": "2024-06-04T18:26:31.818772276Z",
"endTime": "2024-06-04T21:03:20.057610318Z",
"updateTime": "2024-06-04T21:03:20.057610318Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7dc84e225e11e37925db6f4f08269f447d2f2347",
"ref": "refs/heads/main"
}
}
}
[21:03:21.157] Invocation finished in 2h37m34.061631051s with status SUCCEEDED