[20:48:19.473] New invocation is queued and will start shortly
[20:48:20.854] Starting the invocation (attempt 1)
[20:48:20.891] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/428fc2c8875eca42b4803fe100791270ec971e4d"
[20:48:20.891] Popped gitiles commit info from properties and tags
[20:48:20.891] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:48:20.891] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:48:20.891] Buildbucket request:
{
"requestId": "8883917262940062368",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8883917262940062368",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c22586a9d18dd0f066e5660102f7de15fd239e2c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c22586a9d18dd0f066e5660102f7de15fd239e2c",
"title": "c22586a9d18dd0f066e5660102f7de15fd239e2c",
"url": "https://llvm.googlesource.com/llvm-project/+/c22586a9d18dd0f066e5660102f7de15fd239e2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ebb0e6cb2555186fa0417ecb54925aa659346771"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ebb0e6cb2555186fa0417ecb54925aa659346771",
"title": "ebb0e6cb2555186fa0417ecb54925aa659346771",
"url": "https://llvm.googlesource.com/llvm-project/+/ebb0e6cb2555186fa0417ecb54925aa659346771"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6263de90df7f58c8b98475024d5eef102e10a372"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6263de90df7f58c8b98475024d5eef102e10a372",
"title": "6263de90df7f58c8b98475024d5eef102e10a372",
"url": "https://llvm.googlesource.com/llvm-project/+/6263de90df7f58c8b98475024d5eef102e10a372"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9069ba183d0ad56a1e7b9710d9198686bc9b888b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9069ba183d0ad56a1e7b9710d9198686bc9b888b",
"title": "9069ba183d0ad56a1e7b9710d9198686bc9b888b",
"url": "https://llvm.googlesource.com/llvm-project/+/9069ba183d0ad56a1e7b9710d9198686bc9b888b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "03604a784011bec2292f900b118d825f34f8cf89"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@03604a784011bec2292f900b118d825f34f8cf89",
"title": "03604a784011bec2292f900b118d825f34f8cf89",
"url": "https://llvm.googlesource.com/llvm-project/+/03604a784011bec2292f900b118d825f34f8cf89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c182df633bcd7fd7f0634b2cf6bcab91c3674ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c182df633bcd7fd7f0634b2cf6bcab91c3674ec",
"title": "4c182df633bcd7fd7f0634b2cf6bcab91c3674ec",
"url": "https://llvm.googlesource.com/llvm-project/+/4c182df633bcd7fd7f0634b2cf6bcab91c3674ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b518242156f7c432249b1ca203a915b4f9906959"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b518242156f7c432249b1ca203a915b4f9906959",
"title": "b518242156f7c432249b1ca203a915b4f9906959",
"url": "https://llvm.googlesource.com/llvm-project/+/b518242156f7c432249b1ca203a915b4f9906959"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a859b11e3ca758043b88693fdf990d361a02ef1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a859b11e3ca758043b88693fdf990d361a02ef1",
"title": "3a859b11e3ca758043b88693fdf990d361a02ef1",
"url": "https://llvm.googlesource.com/llvm-project/+/3a859b11e3ca758043b88693fdf990d361a02ef1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61af05fe82c6989351c08de8d9eac4dc51f4ef79"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61af05fe82c6989351c08de8d9eac4dc51f4ef79",
"title": "61af05fe82c6989351c08de8d9eac4dc51f4ef79",
"url": "https://llvm.googlesource.com/llvm-project/+/61af05fe82c6989351c08de8d9eac4dc51f4ef79"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d341b632a1a07362dfb51f916baeedcbc8945e0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d341b632a1a07362dfb51f916baeedcbc8945e0f",
"title": "d341b632a1a07362dfb51f916baeedcbc8945e0f",
"url": "https://llvm.googlesource.com/llvm-project/+/d341b632a1a07362dfb51f916baeedcbc8945e0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "12cf6d3b9e0b4983d609576b15dc37ceb7d1d8d7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@12cf6d3b9e0b4983d609576b15dc37ceb7d1d8d7",
"title": "12cf6d3b9e0b4983d609576b15dc37ceb7d1d8d7",
"url": "https://llvm.googlesource.com/llvm-project/+/12cf6d3b9e0b4983d609576b15dc37ceb7d1d8d7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bbaf0877fa61ea5cadc6ded794c3184081790c66"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bbaf0877fa61ea5cadc6ded794c3184081790c66",
"title": "bbaf0877fa61ea5cadc6ded794c3184081790c66",
"url": "https://llvm.googlesource.com/llvm-project/+/bbaf0877fa61ea5cadc6ded794c3184081790c66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "428fc2c8875eca42b4803fe100791270ec971e4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@428fc2c8875eca42b4803fe100791270ec971e4d",
"title": "428fc2c8875eca42b4803fe100791270ec971e4d",
"url": "https://llvm.googlesource.com/llvm-project/+/428fc2c8875eca42b4803fe100791270ec971e4d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "428fc2c8875eca42b4803fe100791270ec971e4d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8883917262940062368"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:48:21.325] Scheduled build:
{
"id": "8718487200696866065",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-04T20:48:20.986136012Z",
"updateTime": "2025-04-04T20:48:20.986136012Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "428fc2c8875eca42b4803fe100791270ec971e4d",
"ref": "refs/heads/main"
}
}
}
[20:48:21.325] Task URL: https://cr-buildbucket.appspot.com/build/8718487200696866065
[20:48:21.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:2:0) after 6m42s
[20:48:21.394] Received PubSub notification, asking Buildbucket for the build status
[20:48:21.420] Build status: SCHEDULED
[20:48:25.000] Received PubSub notification, asking Buildbucket for the build status
[20:48:25.027] Build status: STARTED
[20:55:03.402] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:2:0)
[20:55:03.419] Build status: STARTED
[20:55:03.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:5:0) after 9m38s
[21:04:41.516] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:5:0)
[21:04:41.542] Build status: STARTED
[21:04:41.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:6:0) after 2m46s
[21:07:27.553] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:6:0)
[21:07:27.581] Build status: STARTED
[21:07:27.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:7:0) after 5m49s
[21:13:16.638] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:7:0)
[21:13:16.660] Build status: STARTED
[21:13:16.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:8:0) after 3m49s
[21:17:05.687] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:8:0)
[21:17:05.709] Build status: STARTED
[21:17:05.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:9:0) after 4m59s
[21:22:04.786] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:9:0)
[21:22:04.805] Build status: STARTED
[21:22:04.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:10:0) after 2m6s
[21:24:10.822] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:10:0)
[21:24:10.847] Build status: STARTED
[21:24:10.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:11:0) after 3m42s
[21:27:52.869] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:11:0)
[21:27:52.895] Build status: STARTED
[21:27:52.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:12:0) after 7m53s
[21:35:45.956] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:12:0)
[21:35:45.972] Build status: STARTED
[21:35:45.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:13:0) after 2m26s
[21:38:12.048] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:13:0)
[21:38:12.069] Build status: STARTED
[21:38:12.069] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:14:0) after 2m9s
[21:40:21.156] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:14:0)
[21:40:21.186] Build status: STARTED
[21:40:21.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:15:0) after 5m25s
[21:45:46.255] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:15:0)
[21:45:46.424] Build status: STARTED
[21:45:46.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:16:0) after 7m22s
[21:53:08.442] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:16:0)
[21:53:08.456] Build status: STARTED
[21:53:08.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:17:0) after 1m49s
[21:54:57.484] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:17:0)
[21:54:57.514] Build status: STARTED
[21:54:57.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:18:0) after 9m1s
[22:03:58.529] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:18:0)
[22:03:58.546] Build status: STARTED
[22:03:58.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:19:0) after 8m14s
[22:12:12.624] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:19:0)
[22:12:12.653] Build status: STARTED
[22:12:12.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:20:0) after 4m32s
[22:16:44.643] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:20:0)
[22:16:44.688] Build status: STARTED
[22:16:44.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883917262940062368:21:0) after 9m52s
[22:21:03.522] Received PubSub notification, asking Buildbucket for the build status
[22:21:03.558] Build:
{
"id": "8718487200696866065",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-04T20:48:20.986136012Z",
"startTime": "2025-04-04T20:48:24.795942918Z",
"endTime": "2025-04-04T22:21:03.037426218Z",
"updateTime": "2025-04-04T22:21:03.037426218Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "428fc2c8875eca42b4803fe100791270ec971e4d",
"ref": "refs/heads/main"
}
}
}
[22:21:03.558] Invocation finished in 1h32m44.09465038s with status SUCCEEDED