[19:05:07.598] New invocation is queued and will start shortly
[19:05:09.006] Starting the invocation (attempt 1)
[19:05:09.035] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/63cc2e390db57cbc400b519771b7005eab1fc76a"
[19:05:09.035] Popped gitiles commit info from properties and tags
[19:05:09.035] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:05:09.035] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:05:09.036] Buildbucket request:
{
"requestId": "8872055552992884576",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872055552992884576",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a2899c457ecac9f2511fa08926bcf1c22eee1d14"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a2899c457ecac9f2511fa08926bcf1c22eee1d14",
"title": "a2899c457ecac9f2511fa08926bcf1c22eee1d14",
"url": "https://llvm.googlesource.com/llvm-project/+/a2899c457ecac9f2511fa08926bcf1c22eee1d14"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "41c9510d7262fbdcb7b1332abbb088217fb12703"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@41c9510d7262fbdcb7b1332abbb088217fb12703",
"title": "41c9510d7262fbdcb7b1332abbb088217fb12703",
"url": "https://llvm.googlesource.com/llvm-project/+/41c9510d7262fbdcb7b1332abbb088217fb12703"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a3607080eade5f8f4a734b9532e99294322783a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a3607080eade5f8f4a734b9532e99294322783a",
"title": "3a3607080eade5f8f4a734b9532e99294322783a",
"url": "https://llvm.googlesource.com/llvm-project/+/3a3607080eade5f8f4a734b9532e99294322783a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7350112c40d65bcbdf76e29a8edd2fb5643a4cf1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7350112c40d65bcbdf76e29a8edd2fb5643a4cf1",
"title": "7350112c40d65bcbdf76e29a8edd2fb5643a4cf1",
"url": "https://llvm.googlesource.com/llvm-project/+/7350112c40d65bcbdf76e29a8edd2fb5643a4cf1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b811d4d2f09bce24a92e11f7aed494cf02ea8a5c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b811d4d2f09bce24a92e11f7aed494cf02ea8a5c",
"title": "b811d4d2f09bce24a92e11f7aed494cf02ea8a5c",
"url": "https://llvm.googlesource.com/llvm-project/+/b811d4d2f09bce24a92e11f7aed494cf02ea8a5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47794880f90a57c47474c17fbe330fadf296d263"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47794880f90a57c47474c17fbe330fadf296d263",
"title": "47794880f90a57c47474c17fbe330fadf296d263",
"url": "https://llvm.googlesource.com/llvm-project/+/47794880f90a57c47474c17fbe330fadf296d263"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "059e49ceaa53e281e00963a1d39d43000450e844"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@059e49ceaa53e281e00963a1d39d43000450e844",
"title": "059e49ceaa53e281e00963a1d39d43000450e844",
"url": "https://llvm.googlesource.com/llvm-project/+/059e49ceaa53e281e00963a1d39d43000450e844"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5c401331d73f18bbd83929db20724282b322d1f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5c401331d73f18bbd83929db20724282b322d1f4",
"title": "5c401331d73f18bbd83929db20724282b322d1f4",
"url": "https://llvm.googlesource.com/llvm-project/+/5c401331d73f18bbd83929db20724282b322d1f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4db8b64850fe8e8ceda91f287cf0b1d6223e953b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4db8b64850fe8e8ceda91f287cf0b1d6223e953b",
"title": "4db8b64850fe8e8ceda91f287cf0b1d6223e953b",
"url": "https://llvm.googlesource.com/llvm-project/+/4db8b64850fe8e8ceda91f287cf0b1d6223e953b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4941319cba19d7691baa6ec783c84be4d847637"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4941319cba19d7691baa6ec783c84be4d847637",
"title": "f4941319cba19d7691baa6ec783c84be4d847637",
"url": "https://llvm.googlesource.com/llvm-project/+/f4941319cba19d7691baa6ec783c84be4d847637"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ddd4974297bf8efdb67f2c03c2ed7a2328dbb40b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ddd4974297bf8efdb67f2c03c2ed7a2328dbb40b",
"title": "ddd4974297bf8efdb67f2c03c2ed7a2328dbb40b",
"url": "https://llvm.googlesource.com/llvm-project/+/ddd4974297bf8efdb67f2c03c2ed7a2328dbb40b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "63cc2e390db57cbc400b519771b7005eab1fc76a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@63cc2e390db57cbc400b519771b7005eab1fc76a",
"title": "63cc2e390db57cbc400b519771b7005eab1fc76a",
"url": "https://llvm.googlesource.com/llvm-project/+/63cc2e390db57cbc400b519771b7005eab1fc76a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "63cc2e390db57cbc400b519771b7005eab1fc76a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872055552992884576"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:05:09.480] Scheduled build:
{
"id": "8706625490757395265",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-13T19:05:09.104087587Z",
"updateTime": "2025-08-13T19:05:09.104087587Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "63cc2e390db57cbc400b519771b7005eab1fc76a",
"ref": "refs/heads/main"
}
}
}
[19:05:09.480] Task URL: https://cr-buildbucket.appspot.com/build/8706625490757395265
[19:05:09.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:2:0) after 5m32s
[19:05:10.449] Received PubSub notification, asking Buildbucket for the build status
[19:05:10.556] Build status: SCHEDULED
[19:10:41.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:2:0)
[19:10:41.741] Build status: SCHEDULED
[19:10:41.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:4:0) after 1m48s
[19:12:29.759] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:4:0)
[19:12:29.829] Build status: SCHEDULED
[19:12:29.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:5:0) after 8m18s
[19:20:47.895] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:5:0)
[19:20:47.983] Build status: SCHEDULED
[19:20:47.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:6:0) after 2m55s
[19:23:43.058] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:6:0)
[19:23:43.093] Build status: SCHEDULED
[19:23:43.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:7:0) after 2m38s
[19:26:21.105] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:7:0)
[19:26:21.125] Build status: SCHEDULED
[19:26:21.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:8:0) after 9m53s
[19:32:53.716] Received PubSub notification, asking Buildbucket for the build status
[19:32:53.768] Build status: STARTED
[19:36:14.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:8:0)
[19:36:14.227] Build status: STARTED
[19:36:14.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:10:0) after 4m53s
[19:41:07.263] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:10:0)
[19:41:07.281] Build status: STARTED
[19:41:07.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:11:0) after 6m4s
[19:47:11.303] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:11:0)
[19:47:11.321] Build status: STARTED
[19:47:11.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:12:0) after 8m59s
[19:56:10.342] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:12:0)
[19:56:10.377] Build status: STARTED
[19:56:10.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:13:0) after 6m38s
[20:02:48.446] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:13:0)
[20:02:48.468] Build status: STARTED
[20:02:48.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:14:0) after 1m18s
[20:04:06.511] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:14:0)
[20:04:06.540] Build status: STARTED
[20:04:06.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:15:0) after 5m7s
[20:09:13.575] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:15:0)
[20:09:13.600] Build status: STARTED
[20:09:13.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:16:0) after 4m58s
[20:14:11.615] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:16:0)
[20:14:11.631] Build status: STARTED
[20:14:11.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:17:0) after 8m41s
[20:22:52.697] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:17:0)
[20:22:52.740] Build status: STARTED
[20:22:52.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:18:0) after 1m30s
[20:24:22.758] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:18:0)
[20:24:22.782] Build status: STARTED
[20:24:22.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:19:0) after 7m39s
[20:32:01.827] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:19:0)
[20:32:01.858] Build status: STARTED
[20:32:01.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:20:0) after 4m50s
[20:36:51.911] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:20:0)
[20:36:51.931] Build status: STARTED
[20:36:51.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:21:0) after 1m54s
[20:38:45.995] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:21:0)
[20:38:46.016] Build status: STARTED
[20:38:46.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:22:0) after 7m27s
[20:46:13.127] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:22:0)
[20:46:13.144] Build status: STARTED
[20:46:13.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:23:0) after 9m46s
[20:55:59.238] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:23:0)
[20:55:59.259] Build status: STARTED
[20:55:59.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:24:0) after 1m50s
[20:57:49.275] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:24:0)
[20:57:49.295] Build status: STARTED
[20:57:49.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:25:0) after 2m44s
[21:00:33.358] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:25:0)
[21:00:33.386] Build status: STARTED
[21:00:33.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:26:0) after 6m51s
[21:07:24.407] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:26:0)
[21:07:24.424] Build status: STARTED
[21:07:24.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:27:0) after 8m27s
[21:15:51.486] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:27:0)
[21:15:51.516] Build status: STARTED
[21:15:51.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8872055552992884576:28:0) after 6m21s
[21:16:59.748] Received PubSub notification, asking Buildbucket for the build status
[21:16:59.775] Build:
{
"id": "8706625490757395265",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-13T19:05:09.104087587Z",
"startTime": "2025-08-13T19:32:52.417195910Z",
"endTime": "2025-08-13T21:16:58.645784297Z",
"updateTime": "2025-08-13T21:16:58.645784297Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "63cc2e390db57cbc400b519771b7005eab1fc76a",
"ref": "refs/heads/main"
}
}
}
[21:16:59.775] Invocation finished in 2h11m52.185514718s with status FAILED