[15:49:57.699] New invocation is queued and will start shortly
[15:49:57.699] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[15:49:58.763] Starting the invocation (attempt 1)
[15:49:58.799] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d"
[15:49:58.799] Reconstructed gitiles commit from tags
[15:49:58.799] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:49:58.799] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:49:58.803] Buildbucket request:
{
"requestId": "8913470645361438304",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9b19fdb7736edca21e2683f4d0a1fae3ecb32cb68563a94ca52ce412973180e5/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "17afc2c52a550d08c03a78a4bc899019b89384bd",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913470645361438304",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6cc30ab890a7ed4657cd6d7c9c36ee1bce871a70374d44fa8bfb52d08c28e917/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5bfa172e162cae0d98b5ebdf9948637eb43753e9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1a4b113a41266b94fe217e5fe90d91db15d2356b"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1a4b113a41266b94fe217e5fe90d91db15d2356b",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "63a05b61-ab41-4f74-85a9-4dee2a20f37e",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "03e421e773f4f57768eafbe83a607c7780e6e5e4421c5a1297ec948c264a050d/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "17afc2c52a550d08c03a78a4bc899019b89384bd",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ca1bd5995f6ed934f9187305190a5abfac049173"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ca1bd5995f6ed934f9187305190a5abfac049173",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "93c1b728-1464-452a-a8e6-74d1d8f114fc",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6900cea973fd9eddb1fb504e70e961cb27dad49a9c0458afd985507d0f01ca3d/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "17afc2c52a550d08c03a78a4bc899019b89384bd",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "b0b6c16b470a7d5d9c63765058cca0ebe07ad57d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b0b6c16b470a7d5d9c63765058cca0ebe07ad57d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "fafd21db-ba99-4eb4-bb07-b0d85901898a",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9b19fdb7736edca21e2683f4d0a1fae3ecb32cb68563a94ca52ce412973180e5/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "17afc2c52a550d08c03a78a4bc899019b89384bd",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e160ed2d-31d4-4965-9fb6-19c6df305163",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913470645361438304"
},
{
"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"
}
}
[15:49:59.306] Scheduled build:
{
"id": "8748040583450393857",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-13T15:49:58.891873303Z",
"updateTime": "2024-05-13T15:49:58.891873303Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d",
"ref": "refs/heads/main"
}
}
}
[15:49:59.306] Task URL: https://cr-buildbucket.appspot.com/build/8748040583450393857
[15:49:59.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:2:0) after 8m24s
[15:49:59.401] Received PubSub notification, asking Buildbucket for the build status
[15:49:59.418] Build status: SCHEDULED
[15:50:05.495] Received PubSub notification, asking Buildbucket for the build status
[15:50:05.518] Build status: STARTED
[15:58:23.332] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:2:0)
[15:58:23.359] Build status: STARTED
[15:58:23.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:5:0) after 7m32s
[16:05:55.433] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:5:0)
[16:05:55.474] Build status: STARTED
[16:05:55.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:6:0) after 1m26s
[16:07:21.550] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:6:0)
[16:07:21.587] Build status: STARTED
[16:07:21.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:7:0) after 5m8s
[16:12:29.653] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:7:0)
[16:12:29.722] Build status: STARTED
[16:12:29.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:8:0) after 9m56s
[16:22:25.836] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:8:0)
[16:22:25.865] Build status: STARTED
[16:22:25.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:9:0) after 1m56s
[16:24:21.903] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:9:0)
[16:24:21.940] Build status: STARTED
[16:24:21.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:10:0) after 3m18s
[16:27:39.959] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:10:0)
[16:27:40.002] Build status: STARTED
[16:27:40.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:11:0) after 7m36s
[16:35:16.018] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:11:0)
[16:35:16.040] Build status: STARTED
[16:35:16.040] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:12:0) after 6m7s
[16:41:23.068] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:12:0)
[16:41:23.139] Build status: STARTED
[16:41:23.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:13:0) after 7m44s
[16:49:07.269] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:13:0)
[16:49:07.323] Build status: STARTED
[16:49:07.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:14:0) after 7m50s
[16:56:57.421] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:14:0)
[16:56:57.471] Build status: STARTED
[16:56:57.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:15:0) after 1m17s
[16:58:14.497] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:15:0)
[16:58:14.520] Build status: STARTED
[16:58:14.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:16:0) after 3m48s
[17:02:02.637] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:16:0)
[17:02:02.663] Build status: STARTED
[17:02:02.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:17:0) after 2m24s
[17:04:26.731] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:17:0)
[17:04:26.752] Build status: STARTED
[17:04:26.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:18:0) after 8m55s
[17:13:21.807] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:18:0)
[17:13:21.826] Build status: STARTED
[17:13:21.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:19:0) after 6m57s
[17:20:18.843] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:19:0)
[17:20:18.868] Build status: STARTED
[17:20:18.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:20:0) after 1m15s
[17:21:33.939] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:20:0)
[17:21:33.963] Build status: STARTED
[17:21:33.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:21:0) after 2m59s
[17:24:33.061] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:21:0)
[17:24:33.107] Build status: STARTED
[17:24:33.107] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:22:0) after 3m4s
[17:27:37.135] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:22:0)
[17:27:37.165] Build status: STARTED
[17:27:37.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:23:0) after 5m4s
[17:32:41.252] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:23:0)
[17:32:41.285] Build status: STARTED
[17:32:41.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:24:0) after 6m19s
[17:39:00.425] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:24:0)
[17:39:00.484] Build status: STARTED
[17:39:00.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:25:0) after 3m42s
[17:42:42.546] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:25:0)
[17:42:42.571] Build status: STARTED
[17:42:42.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:26:0) after 2m48s
[17:45:30.596] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:26:0)
[17:45:30.621] Build status: STARTED
[17:45:30.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:27:0) after 4m57s
[17:50:27.638] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:27:0)
[17:50:27.657] Build status: STARTED
[17:50:27.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:28:0) after 7m17s
[17:57:44.699] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:28:0)
[17:57:44.717] Build status: STARTED
[17:57:44.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:29:0) after 7m38s
[18:05:22.744] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:29:0)
[18:05:22.769] Build status: STARTED
[18:05:22.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:30:0) after 5m59s
[18:11:21.784] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:30:0)
[18:11:21.873] Build status: STARTED
[18:11:21.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:31:0) after 8m13s
[18:19:34.943] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:31:0)
[18:19:34.977] Build status: STARTED
[18:19:34.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:32:0) after 9m53s
[18:29:28.078] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:32:0)
[18:29:28.099] Build status: STARTED
[18:29:28.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:33:0) after 9m22s
[18:38:50.117] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:33:0)
[18:38:50.197] Build status: STARTED
[18:38:50.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:34:0) after 6m22s
[18:45:12.262] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:34:0)
[18:45:12.379] Build status: STARTED
[18:45:12.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:35:0) after 3m36s
[18:48:48.503] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:35:0)
[18:48:48.523] Build status: STARTED
[18:48:48.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8913470645361438304:36:0) after 8m40s
[18:56:06.245] Received PubSub notification, asking Buildbucket for the build status
[18:56:06.305] Build:
{
"id": "8748040583450393857",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-13T15:49:58.891873303Z",
"startTime": "2024-05-13T15:50:05.095713189Z",
"endTime": "2024-05-13T18:56:05.485167781Z",
"updateTime": "2024-05-13T18:56:05.485167781Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c4a9a374749deb5f2a932a7d4ef9321be1b2ae5d",
"ref": "refs/heads/main"
}
}
}
[18:56:06.305] Invocation finished in 3h6m8.61951551s with status SUCCEEDED