[15:16:25.304] New invocation is queued and will start shortly
[15:16:27.158] Starting the invocation (attempt 1)
[15:16:27.190] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1121034dd1c43b503f9a9a81c841fabd6f07d846"
[15:16:27.190] Popped gitiles commit info from properties and tags
[15:16:27.190] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:16:27.190] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:16:27.191] Buildbucket request:
{
"requestId": "8875422029619037920",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875422029619037920",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6190d407e09c01a85be860d82ca39fa8509e473d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6190d407e09c01a85be860d82ca39fa8509e473d",
"title": "6190d407e09c01a85be860d82ca39fa8509e473d",
"url": "https://llvm.googlesource.com/llvm-project/+/6190d407e09c01a85be860d82ca39fa8509e473d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "747496269a449dec63090a1c99375867390fa313"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@747496269a449dec63090a1c99375867390fa313",
"title": "747496269a449dec63090a1c99375867390fa313",
"url": "https://llvm.googlesource.com/llvm-project/+/747496269a449dec63090a1c99375867390fa313"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3277f623440f919767fa024c27246cdd70477a48"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3277f623440f919767fa024c27246cdd70477a48",
"title": "3277f623440f919767fa024c27246cdd70477a48",
"url": "https://llvm.googlesource.com/llvm-project/+/3277f623440f919767fa024c27246cdd70477a48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea62de5b1dc01587afb95100e489dcf8abd46237"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea62de5b1dc01587afb95100e489dcf8abd46237",
"title": "ea62de5b1dc01587afb95100e489dcf8abd46237",
"url": "https://llvm.googlesource.com/llvm-project/+/ea62de5b1dc01587afb95100e489dcf8abd46237"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a1a11f7096d7ff95bd192ded276459adae04159"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a1a11f7096d7ff95bd192ded276459adae04159",
"title": "1a1a11f7096d7ff95bd192ded276459adae04159",
"url": "https://llvm.googlesource.com/llvm-project/+/1a1a11f7096d7ff95bd192ded276459adae04159"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "acb4fff866f95762b53560bcf7b3a3667e7a41fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@acb4fff866f95762b53560bcf7b3a3667e7a41fd",
"title": "acb4fff866f95762b53560bcf7b3a3667e7a41fd",
"url": "https://llvm.googlesource.com/llvm-project/+/acb4fff866f95762b53560bcf7b3a3667e7a41fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c80fa2364beeca4ad75125afa29de3e20b63fbd3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c80fa2364beeca4ad75125afa29de3e20b63fbd3",
"title": "c80fa2364beeca4ad75125afa29de3e20b63fbd3",
"url": "https://llvm.googlesource.com/llvm-project/+/c80fa2364beeca4ad75125afa29de3e20b63fbd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa859ed8c6bf1a225c3d88d3c90c63a27230b34c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa859ed8c6bf1a225c3d88d3c90c63a27230b34c",
"title": "fa859ed8c6bf1a225c3d88d3c90c63a27230b34c",
"url": "https://llvm.googlesource.com/llvm-project/+/fa859ed8c6bf1a225c3d88d3c90c63a27230b34c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "45d679218aebdac5c9818be211d8e3a517c944c3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@45d679218aebdac5c9818be211d8e3a517c944c3",
"title": "45d679218aebdac5c9818be211d8e3a517c944c3",
"url": "https://llvm.googlesource.com/llvm-project/+/45d679218aebdac5c9818be211d8e3a517c944c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d3d8ef7e416ce672d89674072b094f70b88497db"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d3d8ef7e416ce672d89674072b094f70b88497db",
"title": "d3d8ef7e416ce672d89674072b094f70b88497db",
"url": "https://llvm.googlesource.com/llvm-project/+/d3d8ef7e416ce672d89674072b094f70b88497db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "543f94831245497b675dadb6a20ebc309d289465"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@543f94831245497b675dadb6a20ebc309d289465",
"title": "543f94831245497b675dadb6a20ebc309d289465",
"url": "https://llvm.googlesource.com/llvm-project/+/543f94831245497b675dadb6a20ebc309d289465"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c2182a132c709316f7795197978a610a9dfdeae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c2182a132c709316f7795197978a610a9dfdeae",
"title": "7c2182a132c709316f7795197978a610a9dfdeae",
"url": "https://llvm.googlesource.com/llvm-project/+/7c2182a132c709316f7795197978a610a9dfdeae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "599b9def29a841173cb4b748a07523a933b30ea9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@599b9def29a841173cb4b748a07523a933b30ea9",
"title": "599b9def29a841173cb4b748a07523a933b30ea9",
"url": "https://llvm.googlesource.com/llvm-project/+/599b9def29a841173cb4b748a07523a933b30ea9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "17d6aa01ec0c843b636cde0bc7e0903523c144aa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@17d6aa01ec0c843b636cde0bc7e0903523c144aa",
"title": "17d6aa01ec0c843b636cde0bc7e0903523c144aa",
"url": "https://llvm.googlesource.com/llvm-project/+/17d6aa01ec0c843b636cde0bc7e0903523c144aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5f2e88a1254ee392c24a1963e08d76e771ba7aea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5f2e88a1254ee392c24a1963e08d76e771ba7aea",
"title": "5f2e88a1254ee392c24a1963e08d76e771ba7aea",
"url": "https://llvm.googlesource.com/llvm-project/+/5f2e88a1254ee392c24a1963e08d76e771ba7aea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6aa33ee971f6e561269c65dcee74cca2185627c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6aa33ee971f6e561269c65dcee74cca2185627c0",
"title": "6aa33ee971f6e561269c65dcee74cca2185627c0",
"url": "https://llvm.googlesource.com/llvm-project/+/6aa33ee971f6e561269c65dcee74cca2185627c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b7c4ac2db4cdd99203b836bd94b3392fd7536de5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b7c4ac2db4cdd99203b836bd94b3392fd7536de5",
"title": "b7c4ac2db4cdd99203b836bd94b3392fd7536de5",
"url": "https://llvm.googlesource.com/llvm-project/+/b7c4ac2db4cdd99203b836bd94b3392fd7536de5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1121034dd1c43b503f9a9a81c841fabd6f07d846"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1121034dd1c43b503f9a9a81c841fabd6f07d846",
"title": "1121034dd1c43b503f9a9a81c841fabd6f07d846",
"url": "https://llvm.googlesource.com/llvm-project/+/1121034dd1c43b503f9a9a81c841fabd6f07d846"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1121034dd1c43b503f9a9a81c841fabd6f07d846",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875422029619037920"
},
{
"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"
}
}
[15:16:28.101] Scheduled build:
{
"id": "8709991966837326993",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-07T15:16:27.330339159Z",
"updateTime": "2025-07-07T15:16:27.330339159Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1121034dd1c43b503f9a9a81c841fabd6f07d846",
"ref": "refs/heads/main"
}
}
}
[15:16:28.101] Task URL: https://cr-buildbucket.appspot.com/build/8709991966837326993
[15:16:28.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:2:0) after 5m21s
[15:16:29.043] Received PubSub notification, asking Buildbucket for the build status
[15:16:29.072] Build status: SCHEDULED
[15:21:49.266] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:2:0)
[15:21:49.293] Build status: SCHEDULED
[15:21:49.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:4:0) after 4m32s
[15:26:21.315] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:4:0)
[15:26:21.336] Build status: SCHEDULED
[15:26:21.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:5:0) after 4m7s
[15:30:28.353] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:5:0)
[15:30:28.374] Build status: SCHEDULED
[15:30:28.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:6:0) after 4m8s
[15:34:36.498] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:6:0)
[15:34:36.523] Build status: SCHEDULED
[15:34:36.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:7:0) after 9m10s
[15:43:46.619] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:7:0)
[15:43:46.646] Build status: SCHEDULED
[15:43:46.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:8:0) after 3m59s
[15:47:45.673] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:8:0)
[15:47:45.706] Build status: SCHEDULED
[15:47:45.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:9:0) after 9m17s
[15:54:03.138] Received PubSub notification, asking Buildbucket for the build status
[15:54:03.167] Build status: STARTED
[15:57:02.682] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:9:0)
[15:57:02.701] Build status: STARTED
[15:57:02.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:11:0) after 8m0s
[16:05:02.754] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:11:0)
[16:05:02.773] Build status: STARTED
[16:05:02.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:12:0) after 7m11s
[16:12:13.791] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:12:0)
[16:12:13.868] Build status: STARTED
[16:12:13.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:13:0) after 3m35s
[16:15:48.853] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:13:0)
[16:15:48.877] Build status: STARTED
[16:15:48.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:14:0) after 3m0s
[16:18:48.904] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:14:0)
[16:18:48.927] Build status: STARTED
[16:18:48.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:15:0) after 2m46s
[16:21:35.046] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:15:0)
[16:21:35.201] Build status: STARTED
[16:21:35.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:16:0) after 4m27s
[16:26:02.229] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:16:0)
[16:26:02.248] Build status: STARTED
[16:26:02.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:17:0) after 5m15s
[16:31:17.343] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:17:0)
[16:31:17.359] Build status: STARTED
[16:31:17.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:18:0) after 4m39s
[16:35:56.537] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:18:0)
[16:35:56.557] Build status: STARTED
[16:35:56.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:19:0) after 3m11s
[16:39:07.548] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:19:0)
[16:39:07.573] Build status: STARTED
[16:39:07.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:20:0) after 1m37s
[16:40:44.756] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:20:0)
[16:40:44.897] Build status: STARTED
[16:40:44.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:21:0) after 6m30s
[16:47:14.933] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:21:0)
[16:47:14.959] Build status: STARTED
[16:47:14.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:22:0) after 6m53s
[16:54:08.111] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:22:0)
[16:54:08.131] Build status: STARTED
[16:54:08.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:23:0) after 3m27s
[16:57:35.200] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:23:0)
[16:57:35.219] Build status: STARTED
[16:57:35.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:24:0) after 5m48s
[17:03:23.237] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:24:0)
[17:03:23.258] Build status: STARTED
[17:03:23.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875422029619037920:25:0) after 9m33s
[17:11:06.438] Received PubSub notification, asking Buildbucket for the build status
[17:11:06.461] Build:
{
"id": "8709991966837326993",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-07T15:16:27.330339159Z",
"startTime": "2025-07-07T15:54:02.765661130Z",
"endTime": "2025-07-07T17:11:06.075164595Z",
"updateTime": "2025-07-07T17:11:06.075164595Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1121034dd1c43b503f9a9a81c841fabd6f07d846",
"ref": "refs/heads/main"
}
}
}
[17:11:06.461] Invocation finished in 1h54m41.167863825s with status SUCCEEDED