[14:57:04.424] New invocation is queued and will start shortly
[14:57:07.222] Starting the invocation (attempt 1)
[14:57:07.257] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c2ae5723b5418fa0f5901f2c21c2c905fa48a498"
[14:57:07.257] Popped gitiles commit info from properties and tags
[14:57:07.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:57:07.257] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:57:07.257] Buildbucket request:
{
"requestId": "8882308616340150064",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882308616340150064",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "587206a442ebb656f9d72e7e0cc5845ef3a2f7ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@587206a442ebb656f9d72e7e0cc5845ef3a2f7ed",
"title": "587206a442ebb656f9d72e7e0cc5845ef3a2f7ed",
"url": "https://llvm.googlesource.com/llvm-project/+/587206a442ebb656f9d72e7e0cc5845ef3a2f7ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47903e3372b8ab942f0d36f135edba5a8de07cf9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47903e3372b8ab942f0d36f135edba5a8de07cf9",
"title": "47903e3372b8ab942f0d36f135edba5a8de07cf9",
"url": "https://llvm.googlesource.com/llvm-project/+/47903e3372b8ab942f0d36f135edba5a8de07cf9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec3a90509d7db3b32d6102351c86470d9799dc9b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec3a90509d7db3b32d6102351c86470d9799dc9b",
"title": "ec3a90509d7db3b32d6102351c86470d9799dc9b",
"url": "https://llvm.googlesource.com/llvm-project/+/ec3a90509d7db3b32d6102351c86470d9799dc9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2b712693886a2a8339c0452f12f06b676e946d49"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b712693886a2a8339c0452f12f06b676e946d49",
"title": "2b712693886a2a8339c0452f12f06b676e946d49",
"url": "https://llvm.googlesource.com/llvm-project/+/2b712693886a2a8339c0452f12f06b676e946d49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2e145f11c0bcfa2052416d96d682c75f33971a8c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2e145f11c0bcfa2052416d96d682c75f33971a8c",
"title": "2e145f11c0bcfa2052416d96d682c75f33971a8c",
"url": "https://llvm.googlesource.com/llvm-project/+/2e145f11c0bcfa2052416d96d682c75f33971a8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "974a8ccb2b9f5b930ce47f65122b5a86481e57fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@974a8ccb2b9f5b930ce47f65122b5a86481e57fe",
"title": "974a8ccb2b9f5b930ce47f65122b5a86481e57fe",
"url": "https://llvm.googlesource.com/llvm-project/+/974a8ccb2b9f5b930ce47f65122b5a86481e57fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a5cdbef5f06904fab27219955604a2759e4dd482"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a5cdbef5f06904fab27219955604a2759e4dd482",
"title": "a5cdbef5f06904fab27219955604a2759e4dd482",
"url": "https://llvm.googlesource.com/llvm-project/+/a5cdbef5f06904fab27219955604a2759e4dd482"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dba8acde6d6a320dad42cdbfe7c8261938348e23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dba8acde6d6a320dad42cdbfe7c8261938348e23",
"title": "dba8acde6d6a320dad42cdbfe7c8261938348e23",
"url": "https://llvm.googlesource.com/llvm-project/+/dba8acde6d6a320dad42cdbfe7c8261938348e23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "616e8cc1fa0319819aa6978af0af9a3e4896103a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@616e8cc1fa0319819aa6978af0af9a3e4896103a",
"title": "616e8cc1fa0319819aa6978af0af9a3e4896103a",
"url": "https://llvm.googlesource.com/llvm-project/+/616e8cc1fa0319819aa6978af0af9a3e4896103a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9eb1ffcfe7cf8c9751afe436a6fcab9cb5b9c9b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9eb1ffcfe7cf8c9751afe436a6fcab9cb5b9c9b",
"title": "c9eb1ffcfe7cf8c9751afe436a6fcab9cb5b9c9b",
"url": "https://llvm.googlesource.com/llvm-project/+/c9eb1ffcfe7cf8c9751afe436a6fcab9cb5b9c9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cfeaa395970b7a2a2f0389d06a20d0970d591807"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cfeaa395970b7a2a2f0389d06a20d0970d591807",
"title": "cfeaa395970b7a2a2f0389d06a20d0970d591807",
"url": "https://llvm.googlesource.com/llvm-project/+/cfeaa395970b7a2a2f0389d06a20d0970d591807"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d20604e5b6792bd010dd4dfd36f3e836ae0fe7b2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d20604e5b6792bd010dd4dfd36f3e836ae0fe7b2",
"title": "d20604e5b6792bd010dd4dfd36f3e836ae0fe7b2",
"url": "https://llvm.googlesource.com/llvm-project/+/d20604e5b6792bd010dd4dfd36f3e836ae0fe7b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e87aa0c6ab7b9d1abbf86e8df84053cd4de92656"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e87aa0c6ab7b9d1abbf86e8df84053cd4de92656",
"title": "e87aa0c6ab7b9d1abbf86e8df84053cd4de92656",
"url": "https://llvm.googlesource.com/llvm-project/+/e87aa0c6ab7b9d1abbf86e8df84053cd4de92656"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "278062f119795373c5e43a62280b4b6f2bffbd48"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@278062f119795373c5e43a62280b4b6f2bffbd48",
"title": "278062f119795373c5e43a62280b4b6f2bffbd48",
"url": "https://llvm.googlesource.com/llvm-project/+/278062f119795373c5e43a62280b4b6f2bffbd48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d51b2785abf77978d9218a7b6fb5b8ec6c770c31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d51b2785abf77978d9218a7b6fb5b8ec6c770c31",
"title": "d51b2785abf77978d9218a7b6fb5b8ec6c770c31",
"url": "https://llvm.googlesource.com/llvm-project/+/d51b2785abf77978d9218a7b6fb5b8ec6c770c31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "980531cac0988e509425e64fbd279ee98e25307c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@980531cac0988e509425e64fbd279ee98e25307c",
"title": "980531cac0988e509425e64fbd279ee98e25307c",
"url": "https://llvm.googlesource.com/llvm-project/+/980531cac0988e509425e64fbd279ee98e25307c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c2ae5723b5418fa0f5901f2c21c2c905fa48a498"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c2ae5723b5418fa0f5901f2c21c2c905fa48a498",
"title": "c2ae5723b5418fa0f5901f2c21c2c905fa48a498",
"url": "https://llvm.googlesource.com/llvm-project/+/c2ae5723b5418fa0f5901f2c21c2c905fa48a498"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c2ae5723b5418fa0f5901f2c21c2c905fa48a498",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882308616340150064"
},
{
"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"
}
}
[14:57:07.741] Scheduled build:
{
"id": "8716878552642643681",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-22T14:57:07.320900150Z",
"updateTime": "2025-04-22T14:57:07.320900150Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c2ae5723b5418fa0f5901f2c21c2c905fa48a498",
"ref": "refs/heads/main"
}
}
}
[14:57:07.741] Task URL: https://cr-buildbucket.appspot.com/build/8716878552642643681
[14:57:07.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:2:0) after 3m8s
[14:57:08.615] Received PubSub notification, asking Buildbucket for the build status
[14:57:08.642] Build status: SCHEDULED
[15:00:15.772] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:2:0)
[15:00:15.799] Build status: SCHEDULED
[15:00:15.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:4:0) after 3m9s
[15:03:24.816] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:4:0)
[15:03:24.969] Build status: SCHEDULED
[15:03:24.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:5:0) after 1m48s
[15:05:13.081] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:5:0)
[15:05:13.112] Build status: SCHEDULED
[15:05:13.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:6:0) after 1m59s
[15:07:12.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:6:0)
[15:07:12.312] Build status: SCHEDULED
[15:07:12.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:7:0) after 3m54s
[15:11:06.376] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:7:0)
[15:11:06.397] Build status: SCHEDULED
[15:11:06.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:8:0) after 3m37s
[15:14:43.426] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:8:0)
[15:14:43.511] Build status: SCHEDULED
[15:14:43.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:9:0) after 2m26s
[15:17:09.532] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:9:0)
[15:17:09.559] Build status: SCHEDULED
[15:17:09.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:10:0) after 1m58s
[15:17:53.159] Received PubSub notification, asking Buildbucket for the build status
[15:17:53.202] Build status: STARTED
[15:19:07.713] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:10:0)
[15:19:07.729] Build status: STARTED
[15:19:07.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:12:0) after 3m5s
[15:22:12.763] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:12:0)
[15:22:12.790] Build status: STARTED
[15:22:12.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:13:0) after 2m44s
[15:24:56.995] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:13:0)
[15:24:57.010] Build status: STARTED
[15:24:57.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:14:0) after 6m38s
[15:31:35.144] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:14:0)
[15:31:35.185] Build status: STARTED
[15:31:35.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:15:0) after 5m6s
[15:36:41.162] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:15:0)
[15:36:41.178] Build status: STARTED
[15:36:41.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:16:0) after 5m3s
[15:41:44.168] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:16:0)
[15:41:44.189] Build status: STARTED
[15:41:44.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:17:0) after 4m48s
[15:46:32.289] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:17:0)
[15:46:32.309] Build status: STARTED
[15:46:32.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:18:0) after 6m49s
[15:53:21.429] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:18:0)
[15:53:21.477] Build status: STARTED
[15:53:21.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:19:0) after 7m1s
[16:00:22.565] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:19:0)
[16:00:22.668] Build status: STARTED
[16:00:22.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:20:0) after 3m5s
[16:03:27.683] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:20:0)
[16:03:27.703] Build status: STARTED
[16:03:27.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:21:0) after 2m38s
[16:06:05.724] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:21:0)
[16:06:05.742] Build status: STARTED
[16:06:05.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:22:0) after 8m6s
[16:14:11.881] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:22:0)
[16:14:11.911] Build status: STARTED
[16:14:11.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:23:0) after 1m59s
[16:16:10.934] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:23:0)
[16:16:10.950] Build status: STARTED
[16:16:10.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:24:0) after 4m4s
[16:20:14.976] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:24:0)
[16:20:15.078] Build status: STARTED
[16:20:15.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:25:0) after 7m36s
[16:27:51.115] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:25:0)
[16:27:51.140] Build status: STARTED
[16:27:51.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:26:0) after 1m48s
[16:29:39.298] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:26:0)
[16:29:39.387] Build status: STARTED
[16:29:39.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882308616340150064:27:0) after 8m35s
[16:36:53.433] Received PubSub notification, asking Buildbucket for the build status
[16:36:53.452] Build:
{
"id": "8716878552642643681",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-22T14:57:07.320900150Z",
"startTime": "2025-04-22T15:17:52.962503126Z",
"endTime": "2025-04-22T16:36:53.174078999Z",
"updateTime": "2025-04-22T16:36:53.174078999Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c2ae5723b5418fa0f5901f2c21c2c905fa48a498",
"ref": "refs/heads/main"
}
}
}
[16:36:53.452] Invocation finished in 1h39m49.041812664s with status SUCCEEDED