[18:06:37.780] New invocation is queued and will start shortly
[18:06:38.873] Starting the invocation (attempt 1)
[18:06:38.902] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4b0beb4f5ec42aea58461df7994e2fa40f335bb6"
[18:06:38.903] Popped gitiles commit info from properties and tags
[18:06:38.903] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:06:38.905] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:06:38.907] Buildbucket request:
{
"requestId": "8916270552919800352",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916270552919800352",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "54a6798e0a3630e705ed32dbbd63414a16331085"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@54a6798e0a3630e705ed32dbbd63414a16331085",
"title": "54a6798e0a3630e705ed32dbbd63414a16331085",
"url": "https://llvm.googlesource.com/llvm-project/+/54a6798e0a3630e705ed32dbbd63414a16331085"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3652b2a877c3691b524a19bc38b338f1ba1dde37"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3652b2a877c3691b524a19bc38b338f1ba1dde37",
"title": "3652b2a877c3691b524a19bc38b338f1ba1dde37",
"url": "https://llvm.googlesource.com/llvm-project/+/3652b2a877c3691b524a19bc38b338f1ba1dde37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d61edecbfd099143e0e2617505fec921524938f8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d61edecbfd099143e0e2617505fec921524938f8",
"title": "d61edecbfd099143e0e2617505fec921524938f8",
"url": "https://llvm.googlesource.com/llvm-project/+/d61edecbfd099143e0e2617505fec921524938f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dcd097c475163b9bd41ff009a9157e86c6f2f171"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dcd097c475163b9bd41ff009a9157e86c6f2f171",
"title": "dcd097c475163b9bd41ff009a9157e86c6f2f171",
"url": "https://llvm.googlesource.com/llvm-project/+/dcd097c475163b9bd41ff009a9157e86c6f2f171"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6a85cf8fc0437d4885fc829948befe32c1e5a21d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6a85cf8fc0437d4885fc829948befe32c1e5a21d",
"title": "6a85cf8fc0437d4885fc829948befe32c1e5a21d",
"url": "https://llvm.googlesource.com/llvm-project/+/6a85cf8fc0437d4885fc829948befe32c1e5a21d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7cafe04e0d74c1e9f7e3871a0bcdf4ccb1c89f0c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7cafe04e0d74c1e9f7e3871a0bcdf4ccb1c89f0c",
"title": "7cafe04e0d74c1e9f7e3871a0bcdf4ccb1c89f0c",
"url": "https://llvm.googlesource.com/llvm-project/+/7cafe04e0d74c1e9f7e3871a0bcdf4ccb1c89f0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fe59cb256289d9f2f6ebe75571389f3cc90bbdec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fe59cb256289d9f2f6ebe75571389f3cc90bbdec",
"title": "fe59cb256289d9f2f6ebe75571389f3cc90bbdec",
"url": "https://llvm.googlesource.com/llvm-project/+/fe59cb256289d9f2f6ebe75571389f3cc90bbdec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "edd7fed9da48c0e708cce9bd4d305ae43d8bd77c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@edd7fed9da48c0e708cce9bd4d305ae43d8bd77c",
"title": "edd7fed9da48c0e708cce9bd4d305ae43d8bd77c",
"url": "https://llvm.googlesource.com/llvm-project/+/edd7fed9da48c0e708cce9bd4d305ae43d8bd77c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c11976f525f3b9b9dc6080f0b23d2ef1ec5fe8fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c11976f525f3b9b9dc6080f0b23d2ef1ec5fe8fd",
"title": "c11976f525f3b9b9dc6080f0b23d2ef1ec5fe8fd",
"url": "https://llvm.googlesource.com/llvm-project/+/c11976f525f3b9b9dc6080f0b23d2ef1ec5fe8fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a11a4324bb27c01e7a005e1a7f49fb8284098e8c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a11a4324bb27c01e7a005e1a7f49fb8284098e8c",
"title": "a11a4324bb27c01e7a005e1a7f49fb8284098e8c",
"url": "https://llvm.googlesource.com/llvm-project/+/a11a4324bb27c01e7a005e1a7f49fb8284098e8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2620ccc3cdebcaa53b96b5f4d79ffe3951534e07"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2620ccc3cdebcaa53b96b5f4d79ffe3951534e07",
"title": "2620ccc3cdebcaa53b96b5f4d79ffe3951534e07",
"url": "https://llvm.googlesource.com/llvm-project/+/2620ccc3cdebcaa53b96b5f4d79ffe3951534e07"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "446d38c65f72fd5d242a64182b05683577f683d3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@446d38c65f72fd5d242a64182b05683577f683d3",
"title": "446d38c65f72fd5d242a64182b05683577f683d3",
"url": "https://llvm.googlesource.com/llvm-project/+/446d38c65f72fd5d242a64182b05683577f683d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9022d9c102a8c47616fbeb6a45b015db6bd2c17a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9022d9c102a8c47616fbeb6a45b015db6bd2c17a",
"title": "9022d9c102a8c47616fbeb6a45b015db6bd2c17a",
"url": "https://llvm.googlesource.com/llvm-project/+/9022d9c102a8c47616fbeb6a45b015db6bd2c17a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b0beb4f5ec42aea58461df7994e2fa40f335bb6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b0beb4f5ec42aea58461df7994e2fa40f335bb6",
"title": "4b0beb4f5ec42aea58461df7994e2fa40f335bb6",
"url": "https://llvm.googlesource.com/llvm-project/+/4b0beb4f5ec42aea58461df7994e2fa40f335bb6"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b0beb4f5ec42aea58461df7994e2fa40f335bb6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916270552919800352"
},
{
"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"
}
}
[18:06:39.406] Scheduled build:
{
"id": "8750840490986888945",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-12T18:06:38.985105122Z",
"updateTime": "2024-04-12T18:06:38.985105122Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b0beb4f5ec42aea58461df7994e2fa40f335bb6",
"ref": "refs/heads/main"
}
}
}
[18:06:39.406] Task URL: https://cr-buildbucket.appspot.com/build/8750840490986888945
[18:06:39.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:2:0) after 2m29s
[18:06:40.423] Received PubSub notification, asking Buildbucket for the build status
[18:06:40.457] Build status: SCHEDULED
[18:06:46.059] Received PubSub notification, asking Buildbucket for the build status
[18:06:46.225] Build status: STARTED
[18:09:08.454] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:2:0)
[18:09:08.507] Build status: STARTED
[18:09:08.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:5:0) after 1m21s
[18:10:29.564] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:5:0)
[18:10:29.644] Build status: STARTED
[18:10:29.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:6:0) after 5m19s
[18:15:48.677] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:6:0)
[18:15:48.696] Build status: STARTED
[18:15:48.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:7:0) after 9m15s
[18:25:03.837] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:7:0)
[18:25:03.866] Build status: STARTED
[18:25:03.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:8:0) after 5m5s
[18:30:08.929] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:8:0)
[18:30:09.003] Build status: STARTED
[18:30:09.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:9:0) after 6m59s
[18:37:07.985] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:9:0)
[18:37:08.023] Build status: STARTED
[18:37:08.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:10:0) after 4m2s
[18:41:10.068] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:10:0)
[18:41:10.105] Build status: STARTED
[18:41:10.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:11:0) after 5m7s
[18:46:17.139] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:11:0)
[18:46:17.278] Build status: STARTED
[18:46:17.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:12:0) after 1m39s
[18:47:56.351] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:12:0)
[18:47:56.374] Build status: STARTED
[18:47:56.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:13:0) after 1m2s
[18:48:58.405] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:13:0)
[18:48:58.440] Build status: STARTED
[18:48:58.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:14:0) after 4m34s
[18:53:32.492] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:14:0)
[18:53:32.675] Build status: STARTED
[18:53:32.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:15:0) after 3m38s
[18:57:10.670] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:15:0)
[18:57:10.700] Build status: STARTED
[18:57:10.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:16:0) after 7m55s
[19:05:05.784] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:16:0)
[19:05:06.210] Build status: STARTED
[19:05:06.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:17:0) after 3m55s
[19:09:01.218] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:17:0)
[19:09:01.302] Build status: STARTED
[19:09:01.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:18:0) after 3m38s
[19:12:39.320] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:18:0)
[19:12:39.351] Build status: STARTED
[19:12:39.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:19:0) after 1m12s
[19:13:51.368] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:19:0)
[19:13:51.389] Build status: STARTED
[19:13:51.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:20:0) after 6m23s
[19:20:14.606] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:20:0)
[19:20:14.656] Build status: STARTED
[19:20:14.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916270552919800352:21:0) after 4m15s
[19:24:18.602] Received PubSub notification, asking Buildbucket for the build status
[19:24:18.633] Build:
{
"id": "8750840490986888945",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-12T18:06:38.985105122Z",
"startTime": "2024-04-12T18:06:45.846354133Z",
"endTime": "2024-04-12T19:24:18.178879756Z",
"updateTime": "2024-04-12T19:24:18.178879756Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b0beb4f5ec42aea58461df7994e2fa40f335bb6",
"ref": "refs/heads/main"
}
}
}
[19:24:18.633] Invocation finished in 1h17m40.873810947s with status SUCCEEDED