[12:38:42.236] New invocation is queued and will start shortly
[12:38:43.434] Starting the invocation (attempt 1)
[12:38:43.463] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/734026347cca85cf0e242ef5f04896f55e0ac113"
[12:38:43.463] Popped gitiles commit info from properties and tags
[12:38:43.463] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:38:43.463] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:38:43.463] Buildbucket request:
{
"requestId": "8918284317477636656",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8918284317477636656",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "83e5a1239242d64110e3dfa96ed3889170ab96b2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@83e5a1239242d64110e3dfa96ed3889170ab96b2",
"title": "83e5a1239242d64110e3dfa96ed3889170ab96b2",
"url": "https://llvm.googlesource.com/llvm-project/+/83e5a1239242d64110e3dfa96ed3889170ab96b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ac243bc0d7922d083af2cf025247b5698556062"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ac243bc0d7922d083af2cf025247b5698556062",
"title": "3ac243bc0d7922d083af2cf025247b5698556062",
"url": "https://llvm.googlesource.com/llvm-project/+/3ac243bc0d7922d083af2cf025247b5698556062"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34f0a8aaba11bf703ddd2de92eee8ecbb77be5c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34f0a8aaba11bf703ddd2de92eee8ecbb77be5c8",
"title": "34f0a8aaba11bf703ddd2de92eee8ecbb77be5c8",
"url": "https://llvm.googlesource.com/llvm-project/+/34f0a8aaba11bf703ddd2de92eee8ecbb77be5c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df6a1d44094e187d7d5ea3ee5b54b9bccc8a4798"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df6a1d44094e187d7d5ea3ee5b54b9bccc8a4798",
"title": "df6a1d44094e187d7d5ea3ee5b54b9bccc8a4798",
"url": "https://llvm.googlesource.com/llvm-project/+/df6a1d44094e187d7d5ea3ee5b54b9bccc8a4798"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2699072b4bc8d8d5e84eb66af38face73ceeb4d3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2699072b4bc8d8d5e84eb66af38face73ceeb4d3",
"title": "2699072b4bc8d8d5e84eb66af38face73ceeb4d3",
"url": "https://llvm.googlesource.com/llvm-project/+/2699072b4bc8d8d5e84eb66af38face73ceeb4d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4946cc37f4865b89fbebcfa0120183a11ae8d4ab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4946cc37f4865b89fbebcfa0120183a11ae8d4ab",
"title": "4946cc37f4865b89fbebcfa0120183a11ae8d4ab",
"url": "https://llvm.googlesource.com/llvm-project/+/4946cc37f4865b89fbebcfa0120183a11ae8d4ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "02cb89b36a7ae9be4ab657306b69dc9d2830d0d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@02cb89b36a7ae9be4ab657306b69dc9d2830d0d5",
"title": "02cb89b36a7ae9be4ab657306b69dc9d2830d0d5",
"url": "https://llvm.googlesource.com/llvm-project/+/02cb89b36a7ae9be4ab657306b69dc9d2830d0d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "734026347cca85cf0e242ef5f04896f55e0ac113"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@734026347cca85cf0e242ef5f04896f55e0ac113",
"title": "734026347cca85cf0e242ef5f04896f55e0ac113",
"url": "https://llvm.googlesource.com/llvm-project/+/734026347cca85cf0e242ef5f04896f55e0ac113"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "734026347cca85cf0e242ef5f04896f55e0ac113",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8918284317477636656"
},
{
"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"
}
}
[12:38:44.047] Scheduled build:
{
"id": "8752854255467311793",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-21T12:38:43.521628758Z",
"updateTime": "2024-03-21T12:38:43.521628758Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "734026347cca85cf0e242ef5f04896f55e0ac113",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:38:44.047] Task URL: https://cr-buildbucket.appspot.com/build/8752854255467311793
[12:38:44.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:2:0) after 9m19s
[12:38:49.631] Received PubSub notification, asking Buildbucket for the build status
[12:38:49.658] Build status: STARTED
[12:38:51.286] Received PubSub notification, asking Buildbucket for the build status
[12:38:51.352] Build status: STARTED
[12:48:03.065] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:2:0)
[12:48:03.109] Build status: STARTED
[12:48:03.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:5:0) after 5m55s
[12:53:58.253] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:5:0)
[12:53:58.300] Build status: STARTED
[12:53:58.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:6:0) after 2m7s
[12:56:05.325] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:6:0)
[12:56:05.381] Build status: STARTED
[12:56:05.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:7:0) after 6m5s
[13:02:10.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:7:0)
[13:02:10.719] Build status: STARTED
[13:02:10.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:8:0) after 7m29s
[13:09:39.729] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:8:0)
[13:09:39.818] Build status: STARTED
[13:09:39.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:9:0) after 6m46s
[13:16:26.109] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:9:0)
[13:16:26.135] Build status: STARTED
[13:16:26.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:10:0) after 2m42s
[13:19:08.203] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:10:0)
[13:19:08.326] Build status: STARTED
[13:19:08.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:11:0) after 4m42s
[13:23:50.346] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:11:0)
[13:23:50.368] Build status: STARTED
[13:23:50.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:12:0) after 2m41s
[13:26:31.399] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:12:0)
[13:26:31.418] Build status: STARTED
[13:26:31.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:13:0) after 2m28s
[13:28:59.475] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:13:0)
[13:28:59.496] Build status: STARTED
[13:28:59.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:14:0) after 2m51s
[13:31:51.055] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:14:0)
[13:31:51.172] Build status: STARTED
[13:31:51.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:15:0) after 3m15s
[13:35:06.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:15:0)
[13:35:06.551] Build status: STARTED
[13:35:06.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:16:0) after 2m21s
[13:37:27.825] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:16:0)
[13:37:27.863] Build status: STARTED
[13:37:27.863] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:17:0) after 3m46s
[13:41:13.898] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:17:0)
[13:41:13.921] Build status: STARTED
[13:41:13.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8918284317477636656:18:0) after 9m23s
[13:50:30.448] Received PubSub notification, asking Buildbucket for the build status
[13:50:30.471] Build:
{
"id": "8752854255467311793",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-21T12:38:43.521628758Z",
"startTime": "2024-03-21T12:38:44.483506Z",
"endTime": "2024-03-21T13:50:28.445354Z",
"updateTime": "2024-03-21T13:50:28.445354Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "734026347cca85cf0e242ef5f04896f55e0ac113",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:50:30.471] Invocation finished in 1h11m48.251250643s with status SUCCEEDED