[14:00:22.133] New invocation is queued and will start shortly
[14:00:23.208] Starting the invocation (attempt 1)
[14:00:23.240] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f"
[14:00:23.240] Popped gitiles commit info from properties and tags
[14:00:23.240] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:00:23.240] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:00:23.241] Buildbucket request:
{
"requestId": "8869085026802976544",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8869085026802976544",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b0de4e67775869a9e0a7c95236335084165e90ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b0de4e67775869a9e0a7c95236335084165e90ce",
"title": "b0de4e67775869a9e0a7c95236335084165e90ce",
"url": "https://llvm.googlesource.com/llvm-project/+/b0de4e67775869a9e0a7c95236335084165e90ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "471bd1745ef044a7ee58a4947bf06a7f56660502"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@471bd1745ef044a7ee58a4947bf06a7f56660502",
"title": "471bd1745ef044a7ee58a4947bf06a7f56660502",
"url": "https://llvm.googlesource.com/llvm-project/+/471bd1745ef044a7ee58a4947bf06a7f56660502"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d27e663691f0dc8b42acd09cab8c6eb15489950"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d27e663691f0dc8b42acd09cab8c6eb15489950",
"title": "1d27e663691f0dc8b42acd09cab8c6eb15489950",
"url": "https://llvm.googlesource.com/llvm-project/+/1d27e663691f0dc8b42acd09cab8c6eb15489950"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd8767b10176c307b58af5d7aff63f59292115bf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd8767b10176c307b58af5d7aff63f59292115bf",
"title": "dd8767b10176c307b58af5d7aff63f59292115bf",
"url": "https://llvm.googlesource.com/llvm-project/+/dd8767b10176c307b58af5d7aff63f59292115bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0058cc81f14bc76d1c81ba3bd20d9e341e047277"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0058cc81f14bc76d1c81ba3bd20d9e341e047277",
"title": "0058cc81f14bc76d1c81ba3bd20d9e341e047277",
"url": "https://llvm.googlesource.com/llvm-project/+/0058cc81f14bc76d1c81ba3bd20d9e341e047277"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f0cf167a5eb36de2657669c68190517624a2cee9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f0cf167a5eb36de2657669c68190517624a2cee9",
"title": "f0cf167a5eb36de2657669c68190517624a2cee9",
"url": "https://llvm.googlesource.com/llvm-project/+/f0cf167a5eb36de2657669c68190517624a2cee9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a41660aaf40b0f3b119300a8d980be52c2c4feed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a41660aaf40b0f3b119300a8d980be52c2c4feed",
"title": "a41660aaf40b0f3b119300a8d980be52c2c4feed",
"url": "https://llvm.googlesource.com/llvm-project/+/a41660aaf40b0f3b119300a8d980be52c2c4feed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d0263f07d1ad35223b017e660725c0a093e89e74"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d0263f07d1ad35223b017e660725c0a093e89e74",
"title": "d0263f07d1ad35223b017e660725c0a093e89e74",
"url": "https://llvm.googlesource.com/llvm-project/+/d0263f07d1ad35223b017e660725c0a093e89e74"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e0a33cb599f8614b3d897ad2bd2f9fa8e1acbac5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0a33cb599f8614b3d897ad2bd2f9fa8e1acbac5",
"title": "e0a33cb599f8614b3d897ad2bd2f9fa8e1acbac5",
"url": "https://llvm.googlesource.com/llvm-project/+/e0a33cb599f8614b3d897ad2bd2f9fa8e1acbac5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "895cda70a95529fd22aac05eee7c34f7624996af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@895cda70a95529fd22aac05eee7c34f7624996af",
"title": "895cda70a95529fd22aac05eee7c34f7624996af",
"url": "https://llvm.googlesource.com/llvm-project/+/895cda70a95529fd22aac05eee7c34f7624996af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4452fbddc5c410f50557ea9f1ef6e1e83d236b1e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4452fbddc5c410f50557ea9f1ef6e1e83d236b1e",
"title": "4452fbddc5c410f50557ea9f1ef6e1e83d236b1e",
"url": "https://llvm.googlesource.com/llvm-project/+/4452fbddc5c410f50557ea9f1ef6e1e83d236b1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dc00abac0e79359a16d617f1c36b5a628fa5b8a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dc00abac0e79359a16d617f1c36b5a628fa5b8a1",
"title": "dc00abac0e79359a16d617f1c36b5a628fa5b8a1",
"url": "https://llvm.googlesource.com/llvm-project/+/dc00abac0e79359a16d617f1c36b5a628fa5b8a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "228e24028d35af81172f1bf9b49abcd226e76aae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@228e24028d35af81172f1bf9b49abcd226e76aae",
"title": "228e24028d35af81172f1bf9b49abcd226e76aae",
"url": "https://llvm.googlesource.com/llvm-project/+/228e24028d35af81172f1bf9b49abcd226e76aae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "00c051080c3b03f2f6a346605c485bb828579b8d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@00c051080c3b03f2f6a346605c485bb828579b8d",
"title": "00c051080c3b03f2f6a346605c485bb828579b8d",
"url": "https://llvm.googlesource.com/llvm-project/+/00c051080c3b03f2f6a346605c485bb828579b8d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "64d5e6c4b35be1840bfffe57a24db2b9d18d65fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@64d5e6c4b35be1840bfffe57a24db2b9d18d65fe",
"title": "64d5e6c4b35be1840bfffe57a24db2b9d18d65fe",
"url": "https://llvm.googlesource.com/llvm-project/+/64d5e6c4b35be1840bfffe57a24db2b9d18d65fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "92dcbf4092059b0c61865a3eac9520d7b5440951"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@92dcbf4092059b0c61865a3eac9520d7b5440951",
"title": "92dcbf4092059b0c61865a3eac9520d7b5440951",
"url": "https://llvm.googlesource.com/llvm-project/+/92dcbf4092059b0c61865a3eac9520d7b5440951"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f",
"title": "53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f",
"url": "https://llvm.googlesource.com/llvm-project/+/53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869085026802976544"
},
{
"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:00:23.709] Scheduled build:
{
"id": "8703654964915070481",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-15T14:00:23.306087307Z",
"updateTime": "2025-09-15T14:00:23.306087307Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f",
"ref": "refs/heads/main"
}
}
}
[14:00:23.709] Task URL: https://cr-buildbucket.appspot.com/build/8703654964915070481
[14:00:23.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:2:0) after 3m13s
[14:00:24.756] Received PubSub notification, asking Buildbucket for the build status
[14:00:24.784] Build status: SCHEDULED
[14:01:06.937] Received PubSub notification, asking Buildbucket for the build status
[14:01:06.965] Build status: STARTED
[14:03:37.083] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:2:0)
[14:03:37.108] Build status: STARTED
[14:03:37.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:5:0) after 6m0s
[14:09:37.313] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:5:0)
[14:09:37.350] Build status: STARTED
[14:09:37.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:6:0) after 3m19s
[14:12:56.392] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:6:0)
[14:12:56.435] Build status: STARTED
[14:12:56.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:7:0) after 5m39s
[14:18:35.459] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:7:0)
[14:18:35.478] Build status: STARTED
[14:18:35.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:8:0) after 1m48s
[14:20:23.492] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:8:0)
[14:20:23.511] Build status: STARTED
[14:20:23.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:9:0) after 4m53s
[14:25:16.596] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:9:0)
[14:25:16.617] Build status: STARTED
[14:25:16.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:10:0) after 3m31s
[14:28:47.712] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:10:0)
[14:28:47.741] Build status: STARTED
[14:28:47.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:11:0) after 5m41s
[14:34:28.759] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:11:0)
[14:34:28.782] Build status: STARTED
[14:34:28.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:12:0) after 2m24s
[14:36:52.798] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:12:0)
[14:36:52.819] Build status: STARTED
[14:36:52.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:13:0) after 8m42s
[14:45:34.906] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:13:0)
[14:45:34.930] Build status: STARTED
[14:45:34.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:14:0) after 1m39s
[14:47:13.947] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:14:0)
[14:47:13.969] Build status: STARTED
[14:47:13.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:15:0) after 7m52s
[14:55:06.029] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:15:0)
[14:55:06.129] Build status: STARTED
[14:55:06.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:16:0) after 8m48s
[15:03:54.188] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:16:0)
[15:03:54.213] Build status: STARTED
[15:03:54.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:17:0) after 7m0s
[15:10:54.255] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:17:0)
[15:10:54.270] Build status: STARTED
[15:10:54.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:18:0) after 1m26s
[15:12:20.389] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:18:0)
[15:12:20.409] Build status: STARTED
[15:12:20.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:19:0) after 6m41s
[15:19:01.476] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:19:0)
[15:19:01.493] Build status: STARTED
[15:19:01.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:20:0) after 4m3s
[15:23:04.522] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:20:0)
[15:23:04.540] Build status: STARTED
[15:23:04.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:21:0) after 7m7s
[15:30:11.558] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:21:0)
[15:30:11.602] Build status: STARTED
[15:30:11.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8869085026802976544:22:0) after 5m48s
[15:32:55.190] Received PubSub notification, asking Buildbucket for the build status
[15:32:55.208] Build:
{
"id": "8703654964915070481",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-15T14:00:23.306087307Z",
"startTime": "2025-09-15T14:01:06.434935792Z",
"endTime": "2025-09-15T15:32:54.405849394Z",
"updateTime": "2025-09-15T15:32:54.405849394Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53a4e4a77bd70731320bfa82ddbe6f88ee30ea6f",
"ref": "refs/heads/main"
}
}
}
[15:32:55.208] Invocation finished in 1h32m33.086044458s with status SUCCEEDED