[20:50:30.262] New invocation is queued and will start shortly
[20:50:31.535] Starting the invocation (attempt 1)
[20:50:31.569] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e6b2525dafbab55e5e7748f3f302bb6a45899511"
[20:50:31.570] Popped gitiles commit info from properties and tags
[20:50:31.570] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:50:31.570] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:50:31.573] Buildbucket request:
{
"requestId": "8934198442147335600",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934198442147335600",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d5ccce12167937c83de2b1b82b4adb6f89cc511"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d5ccce12167937c83de2b1b82b4adb6f89cc511",
"title": "1d5ccce12167937c83de2b1b82b4adb6f89cc511",
"url": "https://llvm.googlesource.com/llvm-project/+/1d5ccce12167937c83de2b1b82b4adb6f89cc511"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "97bd6d60be8af4279efad1d2b064882574218028"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@97bd6d60be8af4279efad1d2b064882574218028",
"title": "97bd6d60be8af4279efad1d2b064882574218028",
"url": "https://llvm.googlesource.com/llvm-project/+/97bd6d60be8af4279efad1d2b064882574218028"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44274e566a2708a99a3571e64589520907ccbc7a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44274e566a2708a99a3571e64589520907ccbc7a",
"title": "44274e566a2708a99a3571e64589520907ccbc7a",
"url": "https://llvm.googlesource.com/llvm-project/+/44274e566a2708a99a3571e64589520907ccbc7a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "31e01e9388667b9b34804f37202e1fed76e98030"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@31e01e9388667b9b34804f37202e1fed76e98030",
"title": "31e01e9388667b9b34804f37202e1fed76e98030",
"url": "https://llvm.googlesource.com/llvm-project/+/31e01e9388667b9b34804f37202e1fed76e98030"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7afc442fb3599e35579017478693d04c3916a144"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7afc442fb3599e35579017478693d04c3916a144",
"title": "7afc442fb3599e35579017478693d04c3916a144",
"url": "https://llvm.googlesource.com/llvm-project/+/7afc442fb3599e35579017478693d04c3916a144"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "67b99fa8ba638edddd5ce38b4d379eab8e339e4a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@67b99fa8ba638edddd5ce38b4d379eab8e339e4a",
"title": "67b99fa8ba638edddd5ce38b4d379eab8e339e4a",
"url": "https://llvm.googlesource.com/llvm-project/+/67b99fa8ba638edddd5ce38b4d379eab8e339e4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1fd2251bce4aa5bfe4a021c4b5f156e40443373d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1fd2251bce4aa5bfe4a021c4b5f156e40443373d",
"title": "1fd2251bce4aa5bfe4a021c4b5f156e40443373d",
"url": "https://llvm.googlesource.com/llvm-project/+/1fd2251bce4aa5bfe4a021c4b5f156e40443373d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61b0f12d6b9cdcb6bb3dd679e3a3c36fa94daeae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61b0f12d6b9cdcb6bb3dd679e3a3c36fa94daeae",
"title": "61b0f12d6b9cdcb6bb3dd679e3a3c36fa94daeae",
"url": "https://llvm.googlesource.com/llvm-project/+/61b0f12d6b9cdcb6bb3dd679e3a3c36fa94daeae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d87f9e287217053bd4613e025c3fb0a941fd0196"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d87f9e287217053bd4613e025c3fb0a941fd0196",
"title": "d87f9e287217053bd4613e025c3fb0a941fd0196",
"url": "https://llvm.googlesource.com/llvm-project/+/d87f9e287217053bd4613e025c3fb0a941fd0196"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab3e647b893e1063838a7aff5477c53338992558"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab3e647b893e1063838a7aff5477c53338992558",
"title": "ab3e647b893e1063838a7aff5477c53338992558",
"url": "https://llvm.googlesource.com/llvm-project/+/ab3e647b893e1063838a7aff5477c53338992558"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "40dc8e6889c055172dfa66823b3e0aa073240086"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@40dc8e6889c055172dfa66823b3e0aa073240086",
"title": "40dc8e6889c055172dfa66823b3e0aa073240086",
"url": "https://llvm.googlesource.com/llvm-project/+/40dc8e6889c055172dfa66823b3e0aa073240086"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e6b2525dafbab55e5e7748f3f302bb6a45899511"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e6b2525dafbab55e5e7748f3f302bb6a45899511",
"title": "e6b2525dafbab55e5e7748f3f302bb6a45899511",
"url": "https://llvm.googlesource.com/llvm-project/+/e6b2525dafbab55e5e7748f3f302bb6a45899511"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e6b2525dafbab55e5e7748f3f302bb6a45899511",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934198442147335600"
},
{
"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:50:32.052] Scheduled build:
{
"id": "8768768380034914785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-27T20:50:31.653528329Z",
"updateTime": "2023-09-27T20:50:31.653528329Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e6b2525dafbab55e5e7748f3f302bb6a45899511",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:50:32.052] Task URL: https://cr-buildbucket.appspot.com/build/8768768380034914785
[20:50:32.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:2:0) after 9m2s
[20:50:32.153] Received PubSub notification, asking Buildbucket for the build status
[20:50:32.185] Build status: SCHEDULED
[20:50:56.640] Received PubSub notification, asking Buildbucket for the build status
[20:50:56.673] Build status: STARTED
[20:59:34.199] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:2:0)
[20:59:34.222] Build status: STARTED
[20:59:34.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:5:0) after 3m15s
[21:02:49.307] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:5:0)
[21:02:49.325] Build status: STARTED
[21:02:49.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:6:0) after 1m57s
[21:04:46.396] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:6:0)
[21:04:46.419] Build status: STARTED
[21:04:46.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:7:0) after 7m16s
[21:12:02.446] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:7:0)
[21:12:02.471] Build status: STARTED
[21:12:02.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:8:0) after 8m6s
[21:20:08.640] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:8:0)
[21:20:08.715] Build status: STARTED
[21:20:08.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:9:0) after 1m30s
[21:21:38.743] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:9:0)
[21:21:38.760] Build status: STARTED
[21:21:38.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:10:0) after 9m3s
[21:30:42.019] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:10:0)
[21:30:42.097] Build status: STARTED
[21:30:42.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:11:0) after 8m28s
[21:39:10.457] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:11:0)
[21:39:10.474] Build status: STARTED
[21:39:10.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:12:0) after 3m43s
[21:42:53.852] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:12:0)
[21:42:53.895] Build status: STARTED
[21:42:53.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:13:0) after 5m25s
[21:48:18.996] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:13:0)
[21:48:19.020] Build status: STARTED
[21:48:19.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:14:0) after 7m27s
[21:55:46.497] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:14:0)
[21:55:46.518] Build status: STARTED
[21:55:46.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8934198442147335600:15:0) after 5m56s
[21:56:04.443] Received PubSub notification, asking Buildbucket for the build status
[21:56:04.474] Build:
{
"id": "8768768380034914785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-27T20:50:31.653528329Z",
"startTime": "2023-09-27T20:50:56.076436Z",
"endTime": "2023-09-27T21:56:03.981078193Z",
"updateTime": "2023-09-27T21:56:03.981078193Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e6b2525dafbab55e5e7748f3f302bb6a45899511",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:56:04.474] Invocation finished in 1h5m34.218635399s with status SUCCEEDED