[17:39:50.923] New invocation is queued and will start shortly
[17:39:50.923] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[17:39:51.991] Starting the invocation (attempt 1)
[17:39:52.027] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/17b3dd03a05dfa938aacd57027189271a62e2fda"
[17:39:52.027] Reconstructed gitiles commit from tags
[17:39:52.027] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:39:52.027] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:39:52.027] Buildbucket request:
{
"requestId": "8893713593186385664",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "75fc69cd7d8b7fa61e36e07975efaf7607fa8181ce336e7a7ed4123780cf560e/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "663470f999511cd24561662e8ce06edaab906ae7",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893713593186385664",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "099a14d5fe086367984de272e148b87627ea93336f98cfe8264e01cda108567e/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "47ed12c30a749859a459e455ac19386317f2b9f4",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "70c5887958623dee20273ec04999b69fe3e470da"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/70c5887958623dee20273ec04999b69fe3e470da",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "a0afd41c-9035-4629-8d05-f54124a2ed41",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "75fc69cd7d8b7fa61e36e07975efaf7607fa8181ce336e7a7ed4123780cf560e/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "663470f999511cd24561662e8ce06edaab906ae7",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "17b3dd03a05dfa938aacd57027189271a62e2fda"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/17b3dd03a05dfa938aacd57027189271a62e2fda",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5a2deccc-c05f-45c1-b962-bdeba4d57799",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "17b3dd03a05dfa938aacd57027189271a62e2fda"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "17b3dd03a05dfa938aacd57027189271a62e2fda",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893713593186385664"
},
{
"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"
}
}
[17:39:52.401] Scheduled build:
{
"id": "8728283531303468529",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-17T17:39:52.092970289Z",
"updateTime": "2024-12-17T17:39:52.092970289Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "17b3dd03a05dfa938aacd57027189271a62e2fda",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:39:52.401] Task URL: https://cr-buildbucket.appspot.com/build/8728283531303468529
[17:39:52.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:2:0) after 4m18s
[17:39:53.368] Received PubSub notification, asking Buildbucket for the build status
[17:39:53.386] Build status: SCHEDULED
[17:39:58.048] Received PubSub notification, asking Buildbucket for the build status
[17:39:58.124] Build status: STARTED
[17:44:10.482] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:2:0)
[17:44:10.510] Build status: STARTED
[17:44:10.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:5:0) after 2m19s
[17:46:29.586] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:5:0)
[17:46:29.611] Build status: STARTED
[17:46:29.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:6:0) after 3m24s
[17:49:53.749] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:6:0)
[17:49:53.770] Build status: STARTED
[17:49:53.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:7:0) after 7m48s
[17:57:41.786] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:7:0)
[17:57:41.955] Build status: STARTED
[17:57:41.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:8:0) after 4m51s
[18:02:32.970] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:8:0)
[18:02:33.012] Build status: STARTED
[18:02:33.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:9:0) after 3m41s
[18:06:14.071] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:9:0)
[18:06:14.102] Build status: STARTED
[18:06:14.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:10:0) after 5m44s
[18:11:58.117] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:10:0)
[18:11:58.135] Build status: STARTED
[18:11:58.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:11:0) after 1m18s
[18:13:16.150] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:11:0)
[18:13:16.170] Build status: STARTED
[18:13:16.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:12:0) after 7m35s
[18:20:51.258] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:12:0)
[18:20:51.314] Build status: STARTED
[18:20:51.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:13:0) after 7m5s
[18:27:56.329] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:13:0)
[18:27:56.349] Build status: STARTED
[18:27:56.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:14:0) after 1m12s
[18:29:08.430] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:14:0)
[18:29:08.457] Build status: STARTED
[18:29:08.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:15:0) after 3m10s
[18:32:18.513] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:15:0)
[18:32:18.530] Build status: STARTED
[18:32:18.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:16:0) after 3m21s
[18:35:39.609] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:16:0)
[18:35:39.629] Build status: STARTED
[18:35:39.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:17:0) after 7m15s
[18:42:54.648] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:17:0)
[18:42:54.666] Build status: STARTED
[18:42:54.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:18:0) after 6m40s
[18:49:35.539] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:18:0)
[18:49:35.609] Build status: STARTED
[18:49:35.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:19:0) after 8m56s
[18:58:31.812] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:19:0)
[18:58:31.832] Build status: STARTED
[18:58:31.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:20:0) after 4m28s
[19:02:59.807] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:20:0)
[19:02:59.853] Build status: STARTED
[19:02:59.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:21:0) after 8m32s
[19:11:31.869] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:21:0)
[19:11:31.889] Build status: STARTED
[19:11:31.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:22:0) after 3m1s
[19:14:32.949] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:22:0)
[19:14:32.971] Build status: STARTED
[19:14:32.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:23:0) after 4m15s
[19:18:47.992] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:23:0)
[19:18:48.108] Build status: STARTED
[19:18:48.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:24:0) after 8m38s
[19:27:26.275] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:24:0)
[19:27:26.291] Build status: STARTED
[19:27:26.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:25:0) after 9m15s
[19:36:41.307] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:25:0)
[19:36:41.330] Build status: STARTED
[19:36:41.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:26:0) after 2m8s
[19:38:49.381] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:26:0)
[19:38:49.404] Build status: STARTED
[19:38:49.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:27:0) after 6m27s
[19:45:16.411] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:27:0)
[19:45:16.428] Build status: STARTED
[19:45:16.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:28:0) after 3m14s
[19:48:30.445] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:28:0)
[19:48:30.469] Build status: STARTED
[19:48:30.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:29:0) after 2m18s
[19:50:48.520] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:29:0)
[19:50:48.541] Build status: STARTED
[19:50:48.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:30:0) after 3m31s
[19:54:19.585] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:30:0)
[19:54:19.607] Build status: STARTED
[19:54:19.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:31:0) after 3m11s
[19:57:30.633] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:31:0)
[19:57:30.651] Build status: STARTED
[19:57:30.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:32:0) after 8m27s
[20:05:57.675] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:32:0)
[20:05:57.697] Build status: STARTED
[20:05:57.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:33:0) after 1m2s
[20:06:59.699] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:33:0)
[20:06:59.724] Build status: STARTED
[20:06:59.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:34:0) after 7m8s
[20:14:07.821] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:34:0)
[20:14:07.846] Build status: STARTED
[20:14:07.846] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:35:0) after 4m42s
[20:18:49.828] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:35:0)
[20:18:49.845] Build status: STARTED
[20:18:49.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:36:0) after 8m22s
[20:27:11.864] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:36:0)
[20:27:11.884] Build status: STARTED
[20:27:11.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:37:0) after 5m27s
[20:32:38.909] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:37:0)
[20:32:38.972] Build status: STARTED
[20:32:38.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:38:0) after 6m48s
[20:39:26.992] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:38:0)
[20:39:27.009] Build status: STARTED
[20:39:27.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8893713593186385664:39:0) after 8m51s
[20:42:28.080] Received PubSub notification, asking Buildbucket for the build status
[20:42:28.099] Build:
{
"id": "8728283531303468529",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-17T17:39:52.092970289Z",
"startTime": "2024-12-17T17:39:57.865698303Z",
"endTime": "2024-12-17T20:42:26.945551848Z",
"updateTime": "2024-12-17T20:42:26.945551848Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "17b3dd03a05dfa938aacd57027189271a62e2fda",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:42:28.099] Invocation finished in 3h2m37.185926869s with status SUCCEEDED