[16:44:50.521] New invocation is queued and will start shortly
[16:44:51.601] Starting the invocation (attempt 1)
[16:44:51.628] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779"
[16:44:51.628] Popped gitiles commit info from properties and tags
[16:44:51.628] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:44:51.628] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:44:51.629] Buildbucket request:
{
"requestId": "8887465863221469872",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887465863221469872",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a88167a60d0b5529b2a5ab185680f25c3c983ec3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a88167a60d0b5529b2a5ab185680f25c3c983ec3",
"title": "a88167a60d0b5529b2a5ab185680f25c3c983ec3",
"url": "https://llvm.googlesource.com/llvm-project/+/a88167a60d0b5529b2a5ab185680f25c3c983ec3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2dfb29a9b2f63e8dcbace2bf9b73ecc770f62b4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2dfb29a9b2f63e8dcbace2bf9b73ecc770f62b4d",
"title": "2dfb29a9b2f63e8dcbace2bf9b73ecc770f62b4d",
"url": "https://llvm.googlesource.com/llvm-project/+/2dfb29a9b2f63e8dcbace2bf9b73ecc770f62b4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a6108bcac26016b791cabce86424c1f1dcf3056"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a6108bcac26016b791cabce86424c1f1dcf3056",
"title": "3a6108bcac26016b791cabce86424c1f1dcf3056",
"url": "https://llvm.googlesource.com/llvm-project/+/3a6108bcac26016b791cabce86424c1f1dcf3056"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0b52aa1bdbc7416592e9c81d9a44ce411c21e081"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0b52aa1bdbc7416592e9c81d9a44ce411c21e081",
"title": "0b52aa1bdbc7416592e9c81d9a44ce411c21e081",
"url": "https://llvm.googlesource.com/llvm-project/+/0b52aa1bdbc7416592e9c81d9a44ce411c21e081"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "16f9c5da45b88ace429064b4823e94491b0ea9b1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@16f9c5da45b88ace429064b4823e94491b0ea9b1",
"title": "16f9c5da45b88ace429064b4823e94491b0ea9b1",
"url": "https://llvm.googlesource.com/llvm-project/+/16f9c5da45b88ace429064b4823e94491b0ea9b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "529b3d16daf2c7970f6f0b1f97e8ed09891c726a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@529b3d16daf2c7970f6f0b1f97e8ed09891c726a",
"title": "529b3d16daf2c7970f6f0b1f97e8ed09891c726a",
"url": "https://llvm.googlesource.com/llvm-project/+/529b3d16daf2c7970f6f0b1f97e8ed09891c726a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "17ccaf4fa82ed6d081144f91b5580e24e44d435c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@17ccaf4fa82ed6d081144f91b5580e24e44d435c",
"title": "17ccaf4fa82ed6d081144f91b5580e24e44d435c",
"url": "https://llvm.googlesource.com/llvm-project/+/17ccaf4fa82ed6d081144f91b5580e24e44d435c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b66ec64b5b634cbf760d69d1629e462268aa1cbd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b66ec64b5b634cbf760d69d1629e462268aa1cbd",
"title": "b66ec64b5b634cbf760d69d1629e462268aa1cbd",
"url": "https://llvm.googlesource.com/llvm-project/+/b66ec64b5b634cbf760d69d1629e462268aa1cbd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "538b898a836ac6efc3b0ec12cf27b511608d2e64"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@538b898a836ac6efc3b0ec12cf27b511608d2e64",
"title": "538b898a836ac6efc3b0ec12cf27b511608d2e64",
"url": "https://llvm.googlesource.com/llvm-project/+/538b898a836ac6efc3b0ec12cf27b511608d2e64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cebb8f72b7937548bd17c7972297f2efafa1e958"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cebb8f72b7937548bd17c7972297f2efafa1e958",
"title": "cebb8f72b7937548bd17c7972297f2efafa1e958",
"url": "https://llvm.googlesource.com/llvm-project/+/cebb8f72b7937548bd17c7972297f2efafa1e958"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5bddadf783c177943fa4f86fa0d295d4e88e7dea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5bddadf783c177943fa4f86fa0d295d4e88e7dea",
"title": "5bddadf783c177943fa4f86fa0d295d4e88e7dea",
"url": "https://llvm.googlesource.com/llvm-project/+/5bddadf783c177943fa4f86fa0d295d4e88e7dea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4defac91dbdf4d54aa40a47851c48e9c587fb7e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4defac91dbdf4d54aa40a47851c48e9c587fb7e9",
"title": "4defac91dbdf4d54aa40a47851c48e9c587fb7e9",
"url": "https://llvm.googlesource.com/llvm-project/+/4defac91dbdf4d54aa40a47851c48e9c587fb7e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7a4cb9bac50c8c19ec0d4ab7f186ef086064a549"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7a4cb9bac50c8c19ec0d4ab7f186ef086064a549",
"title": "7a4cb9bac50c8c19ec0d4ab7f186ef086064a549",
"url": "https://llvm.googlesource.com/llvm-project/+/7a4cb9bac50c8c19ec0d4ab7f186ef086064a549"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779",
"title": "ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779",
"url": "https://llvm.googlesource.com/llvm-project/+/ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887465863221469872"
},
{
"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"
}
}
[16:44:51.955] Scheduled build:
{
"id": "8722035801357332273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-24T16:44:51.677172236Z",
"updateTime": "2025-02-24T16:44:51.677172236Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779",
"ref": "refs/heads/main"
}
}
}
[16:44:51.955] Task URL: https://cr-buildbucket.appspot.com/build/8722035801357332273
[16:44:51.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:2:0) after 7m50s
[16:44:52.028] Received PubSub notification, asking Buildbucket for the build status
[16:44:52.051] Build status: SCHEDULED
[16:44:56.536] Received PubSub notification, asking Buildbucket for the build status
[16:44:56.551] Build status: STARTED
[16:52:41.976] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:2:0)
[16:52:42.056] Build status: STARTED
[16:52:42.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:5:0) after 1m15s
[16:53:57.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:5:0)
[16:53:57.096] Build status: STARTED
[16:53:57.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:6:0) after 1m59s
[16:55:56.122] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:6:0)
[16:55:56.149] Build status: STARTED
[16:55:56.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:7:0) after 2m39s
[16:58:35.163] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:7:0)
[16:58:35.199] Build status: STARTED
[16:58:35.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:8:0) after 5m17s
[17:03:52.274] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:8:0)
[17:03:52.293] Build status: STARTED
[17:03:52.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:9:0) after 2m7s
[17:05:59.294] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:9:0)
[17:05:59.325] Build status: STARTED
[17:05:59.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:10:0) after 7m35s
[17:13:34.344] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:10:0)
[17:13:34.410] Build status: STARTED
[17:13:34.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:11:0) after 6m51s
[17:20:25.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:11:0)
[17:20:25.449] Build status: STARTED
[17:20:25.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:12:0) after 8m28s
[17:28:53.511] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:12:0)
[17:28:53.528] Build status: STARTED
[17:28:53.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:13:0) after 7m12s
[17:36:05.504] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:13:0)
[17:36:05.518] Build status: STARTED
[17:36:05.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:14:0) after 9m44s
[17:45:49.535] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:14:0)
[17:45:49.553] Build status: STARTED
[17:45:49.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:15:0) after 3m20s
[17:49:09.627] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:15:0)
[17:49:09.665] Build status: STARTED
[17:49:09.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:16:0) after 9m47s
[17:58:56.699] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:16:0)
[17:58:56.718] Build status: STARTED
[17:58:56.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:17:0) after 1m4s
[18:00:00.758] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:17:0)
[18:00:00.794] Build status: STARTED
[18:00:00.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:18:0) after 7m25s
[18:07:25.856] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:18:0)
[18:07:25.875] Build status: STARTED
[18:07:25.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:19:0) after 8m58s
[18:16:23.889] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:19:0)
[18:16:23.962] Build status: STARTED
[18:16:23.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:20:0) after 2m32s
[18:18:56.054] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:20:0)
[18:18:56.128] Build status: STARTED
[18:18:56.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8887465863221469872:21:0) after 8m28s
[18:20:39.209] Received PubSub notification, asking Buildbucket for the build status
[18:20:39.229] Build:
{
"id": "8722035801357332273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-24T16:44:51.677172236Z",
"startTime": "2025-02-24T16:44:56.101896876Z",
"endTime": "2025-02-24T18:20:09.688916178Z",
"updateTime": "2025-02-24T18:20:09.688916178Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ff7790e6dde7859b993b7d9abb4a2ec4fe2ae779",
"ref": "refs/heads/main"
}
}
}
[18:20:39.229] Invocation finished in 1h35m48.71314874s with status SUCCEEDED