[00:42:10.291] New invocation is queued and will start shortly
[00:42:11.423] Starting the invocation (attempt 1)
[00:42:11.460] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/07e2ba445df7d277e5195c0ec85b133735ea76e3"
[00:42:11.460] Popped gitiles commit info from properties and tags
[00:42:11.460] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:42:11.460] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:42:11.461] Buildbucket request:
{
"requestId": "8879825687070524368",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879825687070524368",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7268c4e7b3b905835597129f40ba697c0f1319dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7268c4e7b3b905835597129f40ba697c0f1319dd",
"title": "7268c4e7b3b905835597129f40ba697c0f1319dd",
"url": "https://llvm.googlesource.com/llvm-project/+/7268c4e7b3b905835597129f40ba697c0f1319dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a53b306c479cb905c0ac3bb6567e4a20b379643e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a53b306c479cb905c0ac3bb6567e4a20b379643e",
"title": "a53b306c479cb905c0ac3bb6567e4a20b379643e",
"url": "https://llvm.googlesource.com/llvm-project/+/a53b306c479cb905c0ac3bb6567e4a20b379643e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ad3c1d2091d7f793101d7acbb06f3449ab01a310"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ad3c1d2091d7f793101d7acbb06f3449ab01a310",
"title": "ad3c1d2091d7f793101d7acbb06f3449ab01a310",
"url": "https://llvm.googlesource.com/llvm-project/+/ad3c1d2091d7f793101d7acbb06f3449ab01a310"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0528848def299b9af334268a8f658df5105f6b64"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0528848def299b9af334268a8f658df5105f6b64",
"title": "0528848def299b9af334268a8f658df5105f6b64",
"url": "https://llvm.googlesource.com/llvm-project/+/0528848def299b9af334268a8f658df5105f6b64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c2fd63c32ccbf466e4848149d1d050056370d5a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c2fd63c32ccbf466e4848149d1d050056370d5a9",
"title": "c2fd63c32ccbf466e4848149d1d050056370d5a9",
"url": "https://llvm.googlesource.com/llvm-project/+/c2fd63c32ccbf466e4848149d1d050056370d5a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ad450313b7eaee91ec0df62d1686f024cc5cadf1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ad450313b7eaee91ec0df62d1686f024cc5cadf1",
"title": "ad450313b7eaee91ec0df62d1686f024cc5cadf1",
"url": "https://llvm.googlesource.com/llvm-project/+/ad450313b7eaee91ec0df62d1686f024cc5cadf1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4cfbe55781cb8fb95568c9a8538912f68d2ff681"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4cfbe55781cb8fb95568c9a8538912f68d2ff681",
"title": "4cfbe55781cb8fb95568c9a8538912f68d2ff681",
"url": "https://llvm.googlesource.com/llvm-project/+/4cfbe55781cb8fb95568c9a8538912f68d2ff681"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a718797eaf141b9117b6ff41dc02c52f462918e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a718797eaf141b9117b6ff41dc02c52f462918e",
"title": "0a718797eaf141b9117b6ff41dc02c52f462918e",
"url": "https://llvm.googlesource.com/llvm-project/+/0a718797eaf141b9117b6ff41dc02c52f462918e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "30ebcf6280ae098d9d16f5648e99855d612e4954"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@30ebcf6280ae098d9d16f5648e99855d612e4954",
"title": "30ebcf6280ae098d9d16f5648e99855d612e4954",
"url": "https://llvm.googlesource.com/llvm-project/+/30ebcf6280ae098d9d16f5648e99855d612e4954"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "73c638f897327b7869435a588bde7909709ca795"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@73c638f897327b7869435a588bde7909709ca795",
"title": "73c638f897327b7869435a588bde7909709ca795",
"url": "https://llvm.googlesource.com/llvm-project/+/73c638f897327b7869435a588bde7909709ca795"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e9c0840e9b4adc0f5cef53b4f4bcfcc0f475c4fa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e9c0840e9b4adc0f5cef53b4f4bcfcc0f475c4fa",
"title": "e9c0840e9b4adc0f5cef53b4f4bcfcc0f475c4fa",
"url": "https://llvm.googlesource.com/llvm-project/+/e9c0840e9b4adc0f5cef53b4f4bcfcc0f475c4fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dbfd0fd4fffedc8946e8f33ab6d8b782c958febb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dbfd0fd4fffedc8946e8f33ab6d8b782c958febb",
"title": "dbfd0fd4fffedc8946e8f33ab6d8b782c958febb",
"url": "https://llvm.googlesource.com/llvm-project/+/dbfd0fd4fffedc8946e8f33ab6d8b782c958febb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90daed32a82ad2695d27db285ac36f579f2b270e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90daed32a82ad2695d27db285ac36f579f2b270e",
"title": "90daed32a82ad2695d27db285ac36f579f2b270e",
"url": "https://llvm.googlesource.com/llvm-project/+/90daed32a82ad2695d27db285ac36f579f2b270e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "07e2ba445df7d277e5195c0ec85b133735ea76e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@07e2ba445df7d277e5195c0ec85b133735ea76e3",
"title": "07e2ba445df7d277e5195c0ec85b133735ea76e3",
"url": "https://llvm.googlesource.com/llvm-project/+/07e2ba445df7d277e5195c0ec85b133735ea76e3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "07e2ba445df7d277e5195c0ec85b133735ea76e3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879825687070524368"
},
{
"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"
}
}
[00:42:11.894] Scheduled build:
{
"id": "8714395625114414481",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-20T00:42:11.533676211Z",
"updateTime": "2025-05-20T00:42:11.533676211Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "07e2ba445df7d277e5195c0ec85b133735ea76e3",
"ref": "refs/heads/main"
}
}
}
[00:42:11.894] Task URL: https://cr-buildbucket.appspot.com/build/8714395625114414481
[00:42:11.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:2:0) after 3m24s
[00:42:49.843] Received PubSub notification, asking Buildbucket for the build status
[00:42:49.868] Build status: STARTED
[00:42:55.722] Received PubSub notification, asking Buildbucket for the build status
[00:42:55.747] Build status: STARTED
[00:45:35.919] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:2:0)
[00:45:35.937] Build status: STARTED
[00:45:35.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:5:0) after 5m13s
[00:50:49.036] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:5:0)
[00:50:49.069] Build status: STARTED
[00:50:49.069] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:6:0) after 3m40s
[00:54:29.094] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:6:0)
[00:54:29.120] Build status: STARTED
[00:54:29.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:7:0) after 5m31s
[01:00:00.135] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:7:0)
[01:00:00.192] Build status: STARTED
[01:00:00.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:8:0) after 8m18s
[01:08:18.216] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:8:0)
[01:08:18.297] Build status: STARTED
[01:08:18.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:9:0) after 3m10s
[01:11:28.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:9:0)
[01:11:28.389] Build status: STARTED
[01:11:28.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:10:0) after 2m52s
[01:14:20.608] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:10:0)
[01:14:20.628] Build status: STARTED
[01:14:20.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:11:0) after 5m37s
[01:19:57.647] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:11:0)
[01:19:57.670] Build status: STARTED
[01:19:57.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:12:0) after 8m38s
[01:28:35.697] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:12:0)
[01:28:35.722] Build status: STARTED
[01:28:35.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:13:0) after 2m13s
[01:30:48.743] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:13:0)
[01:30:48.792] Build status: STARTED
[01:30:48.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:14:0) after 9m17s
[01:40:05.870] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:14:0)
[01:40:05.907] Build status: STARTED
[01:40:05.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:15:0) after 8m1s
[01:48:06.942] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:15:0)
[01:48:06.976] Build status: STARTED
[01:48:06.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:16:0) after 5m0s
[01:53:07.091] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:16:0)
[01:53:07.123] Build status: STARTED
[01:53:07.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:17:0) after 7m2s
[02:00:09.228] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:17:0)
[02:00:09.254] Build status: STARTED
[02:00:09.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:18:0) after 1m13s
[02:01:22.395] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:18:0)
[02:01:22.424] Build status: STARTED
[02:01:22.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:19:0) after 2m8s
[02:03:30.447] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:19:0)
[02:03:30.572] Build status: STARTED
[02:03:30.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8879825687070524368:20:0) after 7m49s
[02:06:07.400] Received PubSub notification, asking Buildbucket for the build status
[02:06:07.419] Build:
{
"id": "8714395625114414481",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-20T00:42:11.533676211Z",
"startTime": "2025-05-20T00:42:15.177892733Z",
"endTime": "2025-05-20T02:06:07.019084267Z",
"updateTime": "2025-05-20T02:06:07.019084267Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "07e2ba445df7d277e5195c0ec85b133735ea76e3",
"ref": "refs/heads/main"
}
}
}
[02:06:07.419] Invocation finished in 1h23m57.135787471s with status SUCCEEDED