[19:22:43.184] New invocation is queued and will start shortly
[19:22:43.184] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[19:22:44.269] Starting the invocation (attempt 1)
[19:22:44.300] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2d4acb086541577ac6ab3a140b9ceb9659ce7094"
[19:22:44.300] Reconstructed gitiles commit from tags
[19:22:44.300] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:22:44.300] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:22:44.301] Buildbucket request:
{
"requestId": "8914453826411674912",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a7d3449d6c507c60cc5e023c92bb266cab8ce253328fede97c777b53dfaf4056/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "74de26fefd932d4cbe9e317573d81976ae583a88",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914453826411674912",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "99aa4ba0abd76f88e5e0d0cc733b42df80c59c3cad9e707852309bb460deab89/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "74de26fefd932d4cbe9e317573d81976ae583a88",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1aeb64c8ec7b96b2301929d8a325a6e1d9ddaa2f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1aeb64c8ec7b96b2301929d8a325a6e1d9ddaa2f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7f1d38bd-762f-402b-9aa0-1f082b4c3776",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ca7aca3259b618f160dce1e9ed2c02c1599102b89da85a996761ce12dee2a8bd/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "74de26fefd932d4cbe9e317573d81976ae583a88",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e06d6ed1ef081eb9858da8066a6036c5dde432eb"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e06d6ed1ef081eb9858da8066a6036c5dde432eb",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "30bca5b3-0f69-4a8e-8dd1-34d8a03afb5c",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a7d3449d6c507c60cc5e023c92bb266cab8ce253328fede97c777b53dfaf4056/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "74de26fefd932d4cbe9e317573d81976ae583a88",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2d4acb086541577ac6ab3a140b9ceb9659ce7094"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2d4acb086541577ac6ab3a140b9ceb9659ce7094",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "6a9c00d1-ef20-414e-aab8-e799cf42502a",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2d4acb086541577ac6ab3a140b9ceb9659ce7094"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2d4acb086541577ac6ab3a140b9ceb9659ce7094",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914453826411674912"
},
{
"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"
}
}
[19:22:44.967] Scheduled build:
{
"id": "8749023764501816529",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-02T19:22:44.374538916Z",
"updateTime": "2024-05-02T19:22:44.374538916Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2d4acb086541577ac6ab3a140b9ceb9659ce7094",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:22:44.967] Task URL: https://cr-buildbucket.appspot.com/build/8749023764501816529
[19:22:44.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:2:0) after 3m10s
[19:22:45.905] Received PubSub notification, asking Buildbucket for the build status
[19:22:45.929] Build status: SCHEDULED
[19:24:43.195] Received PubSub notification, asking Buildbucket for the build status
[19:24:43.228] Build status: STARTED
[19:25:55.048] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:2:0)
[19:25:55.093] Build status: STARTED
[19:25:55.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:5:0) after 7m49s
[19:33:44.203] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:5:0)
[19:33:44.225] Build status: STARTED
[19:33:44.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:6:0) after 4m59s
[19:38:43.213] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:6:0)
[19:38:43.246] Build status: STARTED
[19:38:43.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:7:0) after 2m58s
[19:41:41.264] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:7:0)
[19:41:41.296] Build status: STARTED
[19:41:41.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:8:0) after 9m25s
[19:51:06.327] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:8:0)
[19:51:06.347] Build status: STARTED
[19:51:06.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:9:0) after 1m23s
[19:52:29.407] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:9:0)
[19:52:29.434] Build status: STARTED
[19:52:29.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:10:0) after 8m44s
[20:01:13.494] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:10:0)
[20:01:13.532] Build status: STARTED
[20:01:13.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:11:0) after 7m30s
[20:08:43.553] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:11:0)
[20:08:43.603] Build status: STARTED
[20:08:43.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:12:0) after 3m5s
[20:11:48.620] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:12:0)
[20:11:48.636] Build status: STARTED
[20:11:48.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:13:0) after 7m9s
[20:18:57.656] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:13:0)
[20:18:57.684] Build status: STARTED
[20:18:57.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:14:0) after 7m50s
[20:26:47.697] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:14:0)
[20:26:47.715] Build status: STARTED
[20:26:47.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:15:0) after 1m32s
[20:28:19.791] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:15:0)
[20:28:19.813] Build status: STARTED
[20:28:19.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:16:0) after 1m46s
[20:30:05.883] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:16:0)
[20:30:05.901] Build status: STARTED
[20:30:05.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:17:0) after 7m51s
[20:37:56.927] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:17:0)
[20:37:56.948] Build status: STARTED
[20:37:56.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:18:0) after 5m29s
[20:43:25.985] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:18:0)
[20:43:26.007] Build status: STARTED
[20:43:26.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:19:0) after 5m53s
[20:49:19.037] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:19:0)
[20:49:19.087] Build status: STARTED
[20:49:19.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:20:0) after 5m7s
[20:54:26.110] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:20:0)
[20:54:26.137] Build status: STARTED
[20:54:26.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:21:0) after 1m54s
[20:56:20.162] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:21:0)
[20:56:20.189] Build status: STARTED
[20:56:20.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:22:0) after 7m49s
[21:04:09.249] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:22:0)
[21:04:09.304] Build status: STARTED
[21:04:09.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:23:0) after 6m46s
[21:10:55.298] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:23:0)
[21:10:55.325] Build status: STARTED
[21:10:55.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:24:0) after 2m24s
[21:13:19.368] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:24:0)
[21:13:19.386] Build status: STARTED
[21:13:19.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:25:0) after 8m33s
[21:21:52.427] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:25:0)
[21:21:52.462] Build status: STARTED
[21:21:52.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:26:0) after 3m31s
[21:25:23.463] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:26:0)
[21:25:23.514] Build status: STARTED
[21:25:23.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:27:0) after 5m5s
[21:30:28.539] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:27:0)
[21:30:28.562] Build status: STARTED
[21:30:28.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:28:0) after 4m27s
[21:34:55.588] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:28:0)
[21:34:55.621] Build status: STARTED
[21:34:55.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:29:0) after 8m34s
[21:43:29.996] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:29:0)
[21:43:30.030] Build status: STARTED
[21:43:30.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:30:0) after 3m44s
[21:47:14.082] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:30:0)
[21:47:14.102] Build status: STARTED
[21:47:14.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:31:0) after 2m34s
[21:49:48.122] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:31:0)
[21:49:48.153] Build status: STARTED
[21:49:48.153] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:32:0) after 7m1s
[21:56:49.219] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:32:0)
[21:56:49.251] Build status: STARTED
[21:56:49.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8914453826411674912:33:0) after 8m15s
[22:04:03.224] Received PubSub notification, asking Buildbucket for the build status
[22:04:03.269] Build:
{
"id": "8749023764501816529",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-02T19:22:44.374538916Z",
"startTime": "2024-05-02T19:24:42.923270050Z",
"endTime": "2024-05-02T22:04:02.318295436Z",
"updateTime": "2024-05-02T22:04:02.318295436Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2d4acb086541577ac6ab3a140b9ceb9659ce7094",
"ref": "refs/heads/main"
}
},
"canary": true
}
[22:04:03.269] Invocation finished in 2h41m20.10001677s with status SUCCEEDED