[14:34:08.291] New invocation is queued and will start shortly
[14:34:08.291] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[14:34:09.370] Starting the invocation (attempt 1)
[14:34:09.397] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747"
[14:34:09.397] Reconstructed gitiles commit from tags
[14:34:09.397] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:34:09.397] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:34:09.398] Buildbucket request:
{
"requestId": "8894359455848535344",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cfc326c012f339f7df87694f9100dcec0f0b3116bf9410c0a53e9b5795387101/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894359455848535344",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d25cd98ac568ec313a50c90acefc83fd972626abca4e62b3d12c9492f117fbe3/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "53e9eee0e2c9587fc7a1e7b5f64ba2a935f58e0a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/53e9eee0e2c9587fc7a1e7b5f64ba2a935f58e0a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d2b44858-f083-4f27-b1d5-27d574f52227",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7b5263a88eee062149a6108a1d6837e6da372fdc3098650765641d212cfb743f/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "b97c447dac892276eaff1ae6d07e3f986373a690"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b97c447dac892276eaff1ae6d07e3f986373a690",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "cbbaf088-d823-483f-a9cb-1bcaf13ed259",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "221b7ed3b65d966ff686f0d75b95375f29982c9fe89db4731d02ec928d5a7ad8/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f4081711f0884ec7afe93577e118ecc89cb7b1cf"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f4081711f0884ec7afe93577e118ecc89cb7b1cf",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5d03d8ea-d5da-4529-aea8-ff39de3840dd",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6936e5356d5c5f3d0e12c8bb88cfe19c9224ffb6ad225fc764a407c40706a5ca/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cb4433b677a06ecbb3112f39d24b28f19b0d2626"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cb4433b677a06ecbb3112f39d24b28f19b0d2626",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "033f2f47-f94c-4761-93a6-2f3dc890f1b1",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b2c0d574d21e3ceb0f51fa45b5f96d8d701ac5735b1ee71ed69b78fa84979526/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "740861d69c2d2988ed69bc264df73bc5ae9d9e49"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/740861d69c2d2988ed69bc264df73bc5ae9d9e49",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2f4b3d5b-08bb-48a4-b291-6d0c08b99455",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "41655780ba521c882bdf101db66debb97ad90f387e68712a3847a71a4f3a1457/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cc1a2ea61e3f8e790125b10d9ec4e7d179156ddf"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cc1a2ea61e3f8e790125b10d9ec4e7d179156ddf",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "df20d81b-eb49-4d5c-822d-8cdb05cbc37f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cfc326c012f339f7df87694f9100dcec0f0b3116bf9410c0a53e9b5795387101/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "edcfb5714bb901a1b51c5a0c3e153372e80037ea",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ce7728e8-3200-4366-bcb5-661573076af9",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894359455848535344"
},
{
"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"
}
}
[14:34:09.789] Scheduled build:
{
"id": "8728929393967496625",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-10T14:34:09.457618224Z",
"updateTime": "2024-12-10T14:34:09.457618224Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747",
"ref": "refs/heads/main"
}
}
}
[14:34:09.789] Task URL: https://cr-buildbucket.appspot.com/build/8728929393967496625
[14:34:09.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:2:0) after 3m52s
[14:34:10.815] Received PubSub notification, asking Buildbucket for the build status
[14:34:10.835] Build status: SCHEDULED
[14:34:17.804] Received PubSub notification, asking Buildbucket for the build status
[14:34:17.831] Build status: STARTED
[14:38:01.846] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:2:0)
[14:38:02.001] Build status: STARTED
[14:38:02.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:5:0) after 1m57s
[14:39:59.019] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:5:0)
[14:39:59.106] Build status: STARTED
[14:39:59.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:6:0) after 8m11s
[14:48:10.173] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:6:0)
[14:48:10.459] Build status: STARTED
[14:48:10.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:7:0) after 5m25s
[14:53:35.629] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:7:0)
[14:53:36.158] Build status: STARTED
[14:53:36.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:8:0) after 5m48s
[14:59:24.156] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:8:0)
[14:59:24.189] Build status: STARTED
[14:59:24.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:9:0) after 5m8s
[15:04:32.306] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:9:0)
[15:04:32.394] Build status: STARTED
[15:04:32.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:10:0) after 8m20s
[15:12:52.363] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:10:0)
[15:12:52.391] Build status: STARTED
[15:12:52.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:11:0) after 9m15s
[15:22:07.569] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:11:0)
[15:22:07.591] Build status: STARTED
[15:22:07.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:12:0) after 5m1s
[15:27:08.612] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:12:0)
[15:27:08.633] Build status: STARTED
[15:27:08.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:13:0) after 3m28s
[15:30:36.730] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:13:0)
[15:30:36.792] Build status: STARTED
[15:30:36.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:14:0) after 9m27s
[15:40:03.850] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:14:0)
[15:40:03.867] Build status: STARTED
[15:40:03.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:15:0) after 6m54s
[15:46:57.885] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:15:0)
[15:46:57.903] Build status: STARTED
[15:46:57.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:16:0) after 1m19s
[15:48:16.919] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:16:0)
[15:48:17.065] Build status: STARTED
[15:48:17.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:17:0) after 8m10s
[15:56:27.084] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:17:0)
[15:56:27.116] Build status: STARTED
[15:56:27.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:18:0) after 8m23s
[16:04:50.150] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:18:0)
[16:04:50.167] Build status: STARTED
[16:04:50.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:19:0) after 3m1s
[16:07:51.273] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:19:0)
[16:07:51.298] Build status: STARTED
[16:07:51.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:20:0) after 6m23s
[16:14:14.316] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:20:0)
[16:14:14.337] Build status: STARTED
[16:14:14.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:21:0) after 1m58s
[16:16:12.541] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:21:0)
[16:16:12.569] Build status: STARTED
[16:16:12.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:22:0) after 1m52s
[16:18:04.595] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:22:0)
[16:18:04.619] Build status: STARTED
[16:18:04.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:23:0) after 9m8s
[16:27:12.740] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:23:0)
[16:27:12.796] Build status: STARTED
[16:27:12.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:24:0) after 5m46s
[16:32:58.820] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:24:0)
[16:32:58.839] Build status: STARTED
[16:32:58.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:25:0) after 6m19s
[16:39:17.893] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:25:0)
[16:39:17.920] Build status: STARTED
[16:39:17.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:26:0) after 1m41s
[16:40:59.065] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:26:0)
[16:40:59.088] Build status: STARTED
[16:40:59.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:27:0) after 6m55s
[16:47:54.087] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:27:0)
[16:47:54.270] Build status: STARTED
[16:47:54.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:28:0) after 6m11s
[16:54:05.285] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:28:0)
[16:54:05.304] Build status: STARTED
[16:54:05.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:29:0) after 9m1s
[17:03:06.447] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:29:0)
[17:03:06.467] Build status: STARTED
[17:03:06.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:30:0) after 2m6s
[17:05:12.485] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:30:0)
[17:05:12.508] Build status: STARTED
[17:05:12.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:31:0) after 9m46s
[17:14:58.527] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:31:0)
[17:14:58.549] Build status: STARTED
[17:14:58.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:32:0) after 8m3s
[17:23:01.660] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:32:0)
[17:23:01.690] Build status: STARTED
[17:23:01.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894359455848535344:33:0) after 2m50s
[17:24:01.648] Received PubSub notification, asking Buildbucket for the build status
[17:24:04.920] Build:
{
"id": "8728929393967496625",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-10T14:34:09.457618224Z",
"startTime": "2024-12-10T14:34:17.005696897Z",
"endTime": "2024-12-10T17:24:01.155736791Z",
"updateTime": "2024-12-10T17:24:01.155736791Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f8a1f42dd5e2f57e4b0bdd8102c4f6d82e869747",
"ref": "refs/heads/main"
}
}
}
[17:24:04.920] Invocation finished in 2h49m56.639968401s with status SUCCEEDED