[17:19:08.185] New invocation is queued and will start shortly
[17:19:09.248] Starting the invocation (attempt 1)
[17:19:09.279] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7c265e9f576041c20422218571bc2dacf20d65d9"
[17:19:09.279] Popped gitiles commit info from properties and tags
[17:19:09.279] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:19:09.279] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:19:09.280] Buildbucket request:
{
"requestId": "8912468468333501744",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912468468333501744",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ad5da2defd4f88c6649bf2b77f1968f661f2dcc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ad5da2defd4f88c6649bf2b77f1968f661f2dcc",
"title": "9ad5da2defd4f88c6649bf2b77f1968f661f2dcc",
"url": "https://llvm.googlesource.com/llvm-project/+/9ad5da2defd4f88c6649bf2b77f1968f661f2dcc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "15135afad15cbcfaaa395d364d9f2ca1f48f2948"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@15135afad15cbcfaaa395d364d9f2ca1f48f2948",
"title": "15135afad15cbcfaaa395d364d9f2ca1f48f2948",
"url": "https://llvm.googlesource.com/llvm-project/+/15135afad15cbcfaaa395d364d9f2ca1f48f2948"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a1c9b9673c7408c64ac0d809e4aec5aee2eb2eb8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a1c9b9673c7408c64ac0d809e4aec5aee2eb2eb8",
"title": "a1c9b9673c7408c64ac0d809e4aec5aee2eb2eb8",
"url": "https://llvm.googlesource.com/llvm-project/+/a1c9b9673c7408c64ac0d809e4aec5aee2eb2eb8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "96af54b9607eae9fc22ce9352f8271bf7510236b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@96af54b9607eae9fc22ce9352f8271bf7510236b",
"title": "96af54b9607eae9fc22ce9352f8271bf7510236b",
"url": "https://llvm.googlesource.com/llvm-project/+/96af54b9607eae9fc22ce9352f8271bf7510236b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e814669a00e7a37a9797d4aeae387638438eee4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e814669a00e7a37a9797d4aeae387638438eee4",
"title": "9e814669a00e7a37a9797d4aeae387638438eee4",
"url": "https://llvm.googlesource.com/llvm-project/+/9e814669a00e7a37a9797d4aeae387638438eee4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8b90c2a20f6aba6b333004b0390ba12a76040c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8b90c2a20f6aba6b333004b0390ba12a76040c7",
"title": "b8b90c2a20f6aba6b333004b0390ba12a76040c7",
"url": "https://llvm.googlesource.com/llvm-project/+/b8b90c2a20f6aba6b333004b0390ba12a76040c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c265e9f576041c20422218571bc2dacf20d65d9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c265e9f576041c20422218571bc2dacf20d65d9",
"title": "7c265e9f576041c20422218571bc2dacf20d65d9",
"url": "https://llvm.googlesource.com/llvm-project/+/7c265e9f576041c20422218571bc2dacf20d65d9"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7c265e9f576041c20422218571bc2dacf20d65d9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912468468333501744"
},
{
"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"
}
}
[17:19:10.093] Scheduled build:
{
"id": "8747038406388136241",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-24T17:19:09.416716017Z",
"updateTime": "2024-05-24T17:19:09.416716017Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7c265e9f576041c20422218571bc2dacf20d65d9",
"ref": "refs/heads/main"
}
}
}
[17:19:10.093] Task URL: https://cr-buildbucket.appspot.com/build/8747038406388136241
[17:19:10.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:2:0) after 5m46s
[17:19:11.098] Received PubSub notification, asking Buildbucket for the build status
[17:19:11.190] Build status: SCHEDULED
[17:19:15.153] Received PubSub notification, asking Buildbucket for the build status
[17:19:15.181] Build status: STARTED
[17:24:56.138] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:2:0)
[17:24:56.155] Build status: STARTED
[17:24:56.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:5:0) after 5m35s
[17:30:31.200] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:5:0)
[17:30:31.229] Build status: STARTED
[17:30:31.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:6:0) after 2m18s
[17:32:49.246] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:6:0)
[17:32:49.270] Build status: STARTED
[17:32:49.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:7:0) after 3m37s
[17:36:26.321] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:7:0)
[17:36:26.340] Build status: STARTED
[17:36:26.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:8:0) after 1m16s
[17:37:42.417] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:8:0)
[17:37:42.444] Build status: STARTED
[17:37:42.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:9:0) after 3m29s
[17:41:11.462] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:9:0)
[17:41:11.496] Build status: STARTED
[17:41:11.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:10:0) after 2m23s
[17:43:34.502] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:10:0)
[17:43:34.554] Build status: STARTED
[17:43:34.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:11:0) after 1m27s
[17:45:01.572] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:11:0)
[17:45:01.599] Build status: STARTED
[17:45:01.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:12:0) after 4m47s
[17:49:48.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:12:0)
[17:49:48.654] Build status: STARTED
[17:49:48.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:13:0) after 8m32s
[17:58:20.668] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:13:0)
[17:58:20.690] Build status: STARTED
[17:58:20.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:14:0) after 4m44s
[18:03:04.738] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:14:0)
[18:03:04.757] Build status: STARTED
[18:03:04.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:15:0) after 2m11s
[18:05:15.779] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:15:0)
[18:05:15.798] Build status: STARTED
[18:05:15.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:16:0) after 8m6s
[18:13:21.774] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:16:0)
[18:13:21.793] Build status: STARTED
[18:13:21.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:17:0) after 4m26s
[18:17:47.762] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:17:0)
[18:17:47.781] Build status: STARTED
[18:17:47.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:18:0) after 6m44s
[18:24:31.797] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:18:0)
[18:24:31.816] Build status: STARTED
[18:24:31.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:19:0) after 6m32s
[18:31:03.834] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:19:0)
[18:31:03.855] Build status: STARTED
[18:31:03.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:20:0) after 3m30s
[18:34:33.870] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:20:0)
[18:34:33.897] Build status: STARTED
[18:34:33.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912468468333501744:21:0) after 9m44s
[18:34:46.825] Received PubSub notification, asking Buildbucket for the build status
[18:34:46.898] Build:
{
"id": "8747038406388136241",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-24T17:19:09.416716017Z",
"startTime": "2024-05-24T17:19:14.960110720Z",
"endTime": "2024-05-24T18:34:46.292629220Z",
"updateTime": "2024-05-24T18:34:46.292629220Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7c265e9f576041c20422218571bc2dacf20d65d9",
"ref": "refs/heads/main"
}
}
}
[18:34:46.898] Invocation finished in 1h15m38.721304807s with status SUCCEEDED