[20:28:50.314] New invocation is queued and will start shortly
[20:28:51.502] Starting the invocation (attempt 1)
[20:28:51.530] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31"
[20:28:51.531] Popped gitiles commit info from properties and tags
[20:28:51.531] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:28:51.532] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:28:51.533] Buildbucket request:
{
"requestId": "8905842954763188384",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905842954763188384",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc25748d07b0adb1a0223e836e9cae22af150496"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc25748d07b0adb1a0223e836e9cae22af150496",
"title": "cc25748d07b0adb1a0223e836e9cae22af150496",
"url": "https://llvm.googlesource.com/llvm-project/+/cc25748d07b0adb1a0223e836e9cae22af150496"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "241349fff2e1e99617124339a4c56a9b959f2f71"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@241349fff2e1e99617124339a4c56a9b959f2f71",
"title": "241349fff2e1e99617124339a4c56a9b959f2f71",
"url": "https://llvm.googlesource.com/llvm-project/+/241349fff2e1e99617124339a4c56a9b959f2f71"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c469540010af60c2e3d19d40f1ead16489176e21"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c469540010af60c2e3d19d40f1ead16489176e21",
"title": "c469540010af60c2e3d19d40f1ead16489176e21",
"url": "https://llvm.googlesource.com/llvm-project/+/c469540010af60c2e3d19d40f1ead16489176e21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d1b294029004e7c3220ed46e2b06addd32490745"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d1b294029004e7c3220ed46e2b06addd32490745",
"title": "d1b294029004e7c3220ed46e2b06addd32490745",
"url": "https://llvm.googlesource.com/llvm-project/+/d1b294029004e7c3220ed46e2b06addd32490745"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bde51232baa4c94ef060df9c7a7d2b6de6b09dae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bde51232baa4c94ef060df9c7a7d2b6de6b09dae",
"title": "bde51232baa4c94ef060df9c7a7d2b6de6b09dae",
"url": "https://llvm.googlesource.com/llvm-project/+/bde51232baa4c94ef060df9c7a7d2b6de6b09dae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c4ec19b985815b664cc598a608acc0906d29d902"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c4ec19b985815b664cc598a608acc0906d29d902",
"title": "c4ec19b985815b664cc598a608acc0906d29d902",
"url": "https://llvm.googlesource.com/llvm-project/+/c4ec19b985815b664cc598a608acc0906d29d902"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88d288489e09a261f6740972dcaf6fedaf87a762"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88d288489e09a261f6740972dcaf6fedaf87a762",
"title": "88d288489e09a261f6740972dcaf6fedaf87a762",
"url": "https://llvm.googlesource.com/llvm-project/+/88d288489e09a261f6740972dcaf6fedaf87a762"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7e8a9020b1ae3dea28c19f0cd68743482dca13d9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7e8a9020b1ae3dea28c19f0cd68743482dca13d9",
"title": "7e8a9020b1ae3dea28c19f0cd68743482dca13d9",
"url": "https://llvm.googlesource.com/llvm-project/+/7e8a9020b1ae3dea28c19f0cd68743482dca13d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "72825fde03aab3ce9eba2635b872144d1fb6b6b2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@72825fde03aab3ce9eba2635b872144d1fb6b6b2",
"title": "72825fde03aab3ce9eba2635b872144d1fb6b6b2",
"url": "https://llvm.googlesource.com/llvm-project/+/72825fde03aab3ce9eba2635b872144d1fb6b6b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f01a6f5ecb6c6969ee4ac4fdf6e1ab3d98c31309"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f01a6f5ecb6c6969ee4ac4fdf6e1ab3d98c31309",
"title": "f01a6f5ecb6c6969ee4ac4fdf6e1ab3d98c31309",
"url": "https://llvm.googlesource.com/llvm-project/+/f01a6f5ecb6c6969ee4ac4fdf6e1ab3d98c31309"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47fc4c37bb6c526444836b23090cdf0916b3058b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47fc4c37bb6c526444836b23090cdf0916b3058b",
"title": "47fc4c37bb6c526444836b23090cdf0916b3058b",
"url": "https://llvm.googlesource.com/llvm-project/+/47fc4c37bb6c526444836b23090cdf0916b3058b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2ef553c05ffe274d6910e3d11f52ed6417cc5061"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2ef553c05ffe274d6910e3d11f52ed6417cc5061",
"title": "2ef553c05ffe274d6910e3d11f52ed6417cc5061",
"url": "https://llvm.googlesource.com/llvm-project/+/2ef553c05ffe274d6910e3d11f52ed6417cc5061"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31",
"title": "4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31",
"url": "https://llvm.googlesource.com/llvm-project/+/4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905842954763188384"
},
{
"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:28:51.984] Scheduled build:
{
"id": "8740412892762934401",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-05T20:28:51.593112413Z",
"updateTime": "2024-08-05T20:28:51.593112413Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31",
"ref": "refs/heads/main"
}
}
}
[20:28:51.984] Task URL: https://cr-buildbucket.appspot.com/build/8740412892762934401
[20:28:51.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:2:0) after 5m41s
[20:28:52.089] Received PubSub notification, asking Buildbucket for the build status
[20:28:52.111] Build status: SCHEDULED
[20:28:56.667] Received PubSub notification, asking Buildbucket for the build status
[20:28:56.693] Build status: STARTED
[20:34:33.001] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:2:0)
[20:34:33.033] Build status: STARTED
[20:34:33.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:5:0) after 5m12s
[20:39:45.052] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:5:0)
[20:39:45.118] Build status: STARTED
[20:39:45.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:6:0) after 7m14s
[20:46:59.215] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:6:0)
[20:46:59.358] Build status: STARTED
[20:46:59.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:7:0) after 6m28s
[20:53:27.386] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:7:0)
[20:53:27.406] Build status: STARTED
[20:53:27.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:8:0) after 1m44s
[20:55:11.466] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:8:0)
[20:55:11.502] Build status: STARTED
[20:55:11.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:9:0) after 6m42s
[21:01:53.520] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:9:0)
[21:01:53.540] Build status: STARTED
[21:01:53.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:10:0) after 4m27s
[21:06:20.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:10:0)
[21:06:20.605] Build status: STARTED
[21:06:20.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:11:0) after 6m54s
[21:13:14.634] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:11:0)
[21:13:14.652] Build status: STARTED
[21:13:14.652] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:12:0) after 9m57s
[21:23:11.668] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:12:0)
[21:23:11.834] Build status: STARTED
[21:23:11.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:13:0) after 4m0s
[21:27:11.902] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:13:0)
[21:27:11.921] Build status: STARTED
[21:27:11.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:14:0) after 9m44s
[21:36:56.033] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:14:0)
[21:36:56.085] Build status: STARTED
[21:36:56.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:15:0) after 9m23s
[21:46:19.103] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:15:0)
[21:46:19.128] Build status: STARTED
[21:46:19.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8905842954763188384:16:0) after 3m46s
[21:49:13.408] Received PubSub notification, asking Buildbucket for the build status
[21:49:13.426] Build:
{
"id": "8740412892762934401",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-05T20:28:51.593112413Z",
"startTime": "2024-08-05T20:28:56.441595748Z",
"endTime": "2024-08-05T21:49:13.063416005Z",
"updateTime": "2024-08-05T21:49:13.063416005Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b3bc46d1d794b8ed78b75ccd35a6cc30235bf31",
"ref": "refs/heads/main"
}
}
}
[21:49:13.426] Invocation finished in 1h20m23.124313388s with status SUCCEEDED