[21:44:02.445] New invocation is queued and will start shortly
[21:44:03.642] Starting the invocation (attempt 1)
[21:44:03.669] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/56cb5cbfcdc09499d366046d6ea2ea6655fc11ef"
[21:44:03.669] Popped gitiles commit info from properties and tags
[21:44:03.669] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:44:03.669] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:44:03.669] Buildbucket request:
{
"requestId": "8895057184452458944",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8895057184452458944",
"job": "fuchsia/toolchain.ci-clang-linux-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eaa4eb281d4a0e34c7b4c2dac50cd151c3cb27e6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eaa4eb281d4a0e34c7b4c2dac50cd151c3cb27e6",
"title": "eaa4eb281d4a0e34c7b4c2dac50cd151c3cb27e6",
"url": "https://llvm.googlesource.com/llvm-project/+/eaa4eb281d4a0e34c7b4c2dac50cd151c3cb27e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bde79c0e27fd0fb1e31c9b8b34ae71716c51a8e8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bde79c0e27fd0fb1e31c9b8b34ae71716c51a8e8",
"title": "bde79c0e27fd0fb1e31c9b8b34ae71716c51a8e8",
"url": "https://llvm.googlesource.com/llvm-project/+/bde79c0e27fd0fb1e31c9b8b34ae71716c51a8e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a15400d05d23dd45a8ed583da857d1b02329eb40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a15400d05d23dd45a8ed583da857d1b02329eb40",
"title": "a15400d05d23dd45a8ed583da857d1b02329eb40",
"url": "https://llvm.googlesource.com/llvm-project/+/a15400d05d23dd45a8ed583da857d1b02329eb40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0aa7892772a94b0395cb5a7fce077ab2348ecaa5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0aa7892772a94b0395cb5a7fce077ab2348ecaa5",
"title": "0aa7892772a94b0395cb5a7fce077ab2348ecaa5",
"url": "https://llvm.googlesource.com/llvm-project/+/0aa7892772a94b0395cb5a7fce077ab2348ecaa5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2c88ac9da9f842875592b232ba957da341e62ea5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2c88ac9da9f842875592b232ba957da341e62ea5",
"title": "2c88ac9da9f842875592b232ba957da341e62ea5",
"url": "https://llvm.googlesource.com/llvm-project/+/2c88ac9da9f842875592b232ba957da341e62ea5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4226e0a0c75e5cfd784eff429f93101c03a1995c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4226e0a0c75e5cfd784eff429f93101c03a1995c",
"title": "4226e0a0c75e5cfd784eff429f93101c03a1995c",
"url": "https://llvm.googlesource.com/llvm-project/+/4226e0a0c75e5cfd784eff429f93101c03a1995c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a6ef0debb1d60966b5bcc69f7d58a2b75c9c621d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a6ef0debb1d60966b5bcc69f7d58a2b75c9c621d",
"title": "a6ef0debb1d60966b5bcc69f7d58a2b75c9c621d",
"url": "https://llvm.googlesource.com/llvm-project/+/a6ef0debb1d60966b5bcc69f7d58a2b75c9c621d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "56cb5cbfcdc09499d366046d6ea2ea6655fc11ef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@56cb5cbfcdc09499d366046d6ea2ea6655fc11ef",
"title": "56cb5cbfcdc09499d366046d6ea2ea6655fc11ef",
"url": "https://llvm.googlesource.com/llvm-project/+/56cb5cbfcdc09499d366046d6ea2ea6655fc11ef"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "56cb5cbfcdc09499d366046d6ea2ea6655fc11ef",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8895057184452458944"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-linux-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:44:04.098] Scheduled build:
{
"id": "8729627122442925921",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-02T21:44:03.730921026Z",
"updateTime": "2024-12-02T21:44:03.730921026Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "56cb5cbfcdc09499d366046d6ea2ea6655fc11ef",
"ref": "refs/heads/main"
}
}
}
[21:44:04.098] Task URL: https://cr-buildbucket.appspot.com/build/8729627122442925921
[21:44:04.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:2:0) after 1m58s
[21:44:24.309] Received PubSub notification, asking Buildbucket for the build status
[21:44:24.343] Build status: STARTED
[21:44:29.242] Received PubSub notification, asking Buildbucket for the build status
[21:44:29.281] Build status: STARTED
[21:46:02.111] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:2:0)
[21:46:02.142] Build status: STARTED
[21:46:02.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:5:0) after 1m25s
[21:47:27.220] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:5:0)
[21:47:27.252] Build status: STARTED
[21:47:27.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:6:0) after 6m4s
[21:53:31.320] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:6:0)
[21:53:31.349] Build status: STARTED
[21:53:31.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:7:0) after 1m4s
[21:54:35.368] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:7:0)
[21:54:35.389] Build status: STARTED
[21:54:35.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:8:0) after 6m19s
[22:00:54.370] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:8:0)
[22:00:54.391] Build status: STARTED
[22:00:54.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:9:0) after 2m47s
[22:03:41.410] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:9:0)
[22:03:41.427] Build status: STARTED
[22:03:41.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-linux-x64-40be1bb5:8895057184452458944:10:0) after 9m22s
[22:11:36.199] Received PubSub notification, asking Buildbucket for the build status
[22:11:36.229] Build:
{
"id": "8729627122442925921",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-02T21:44:03.730921026Z",
"startTime": "2024-12-02T21:44:07.875161289Z",
"endTime": "2024-12-02T22:11:35.709351699Z",
"updateTime": "2024-12-02T22:11:35.709351699Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "56cb5cbfcdc09499d366046d6ea2ea6655fc11ef",
"ref": "refs/heads/main"
}
}
}
[22:11:36.229] Invocation finished in 27m33.799465388s with status SUCCEEDED