[10:17:05.164] New invocation is queued and will start shortly
[10:17:06.182] Starting the invocation (attempt 1)
[10:17:06.212] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f782ff8fc6426890863be0791a9ace2394da3887"
[10:17:06.212] Popped gitiles commit info from properties and tags
[10:17:06.212] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:17:06.212] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:17:06.213] Buildbucket request:
{
"requestId": "8909505321550403360",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8909505321550403360",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "be00190ce35807c8586ee4e2e61507fc0221e825"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@be00190ce35807c8586ee4e2e61507fc0221e825",
"title": "be00190ce35807c8586ee4e2e61507fc0221e825",
"url": "https://llvm.googlesource.com/llvm-project/+/be00190ce35807c8586ee4e2e61507fc0221e825"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1dbc2aad68f29f9d6306f6329610e1eca8afb3fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1dbc2aad68f29f9d6306f6329610e1eca8afb3fe",
"title": "1dbc2aad68f29f9d6306f6329610e1eca8afb3fe",
"url": "https://llvm.googlesource.com/llvm-project/+/1dbc2aad68f29f9d6306f6329610e1eca8afb3fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8681bb8bedf065abe34a4523fb58287fc05f7907"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8681bb8bedf065abe34a4523fb58287fc05f7907",
"title": "8681bb8bedf065abe34a4523fb58287fc05f7907",
"url": "https://llvm.googlesource.com/llvm-project/+/8681bb8bedf065abe34a4523fb58287fc05f7907"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5b4000dc58572d08754f0b2199c2046871ec8507"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5b4000dc58572d08754f0b2199c2046871ec8507",
"title": "5b4000dc58572d08754f0b2199c2046871ec8507",
"url": "https://llvm.googlesource.com/llvm-project/+/5b4000dc58572d08754f0b2199c2046871ec8507"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90e4eb8a479dbef4f98f7d8ccd2de5494c6366c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90e4eb8a479dbef4f98f7d8ccd2de5494c6366c7",
"title": "90e4eb8a479dbef4f98f7d8ccd2de5494c6366c7",
"url": "https://llvm.googlesource.com/llvm-project/+/90e4eb8a479dbef4f98f7d8ccd2de5494c6366c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f782ff8fc6426890863be0791a9ace2394da3887"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f782ff8fc6426890863be0791a9ace2394da3887",
"title": "f782ff8fc6426890863be0791a9ace2394da3887",
"url": "https://llvm.googlesource.com/llvm-project/+/f782ff8fc6426890863be0791a9ace2394da3887"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f782ff8fc6426890863be0791a9ace2394da3887",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8909505321550403360"
},
{
"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"
}
}
[10:17:06.920] Scheduled build:
{
"id": "8744075259730027169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-26T10:17:06.280494975Z",
"updateTime": "2024-06-26T10:17:06.280494975Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f782ff8fc6426890863be0791a9ace2394da3887",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:17:06.920] Task URL: https://cr-buildbucket.appspot.com/build/8744075259730027169
[10:17:06.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:2:0) after 9m44s
[10:17:07.829] Received PubSub notification, asking Buildbucket for the build status
[10:17:07.874] Build status: SCHEDULED
[10:17:13.279] Received PubSub notification, asking Buildbucket for the build status
[10:17:13.343] Build status: STARTED
[10:26:50.942] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:2:0)
[10:26:50.960] Build status: STARTED
[10:26:50.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:5:0) after 9m39s
[10:36:30.045] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:5:0)
[10:36:30.126] Build status: STARTED
[10:36:30.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:6:0) after 1m15s
[10:37:45.275] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:6:0)
[10:37:45.306] Build status: STARTED
[10:37:45.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:7:0) after 4m30s
[10:42:15.283] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:7:0)
[10:42:15.316] Build status: STARTED
[10:42:15.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:8:0) after 3m19s
[10:45:34.330] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:8:0)
[10:45:34.355] Build status: STARTED
[10:45:34.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:9:0) after 6m0s
[10:51:34.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:9:0)
[10:51:34.444] Build status: STARTED
[10:51:34.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:10:0) after 9m39s
[11:01:14.035] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:10:0)
[11:01:14.052] Build status: STARTED
[11:01:14.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:11:0) after 2m12s
[11:03:26.169] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:11:0)
[11:03:26.189] Build status: STARTED
[11:03:26.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:12:0) after 7m11s
[11:10:37.278] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:12:0)
[11:10:37.296] Build status: STARTED
[11:10:37.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:13:0) after 4m25s
[11:15:02.308] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:13:0)
[11:15:02.589] Build status: STARTED
[11:15:02.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:14:0) after 1m59s
[11:17:02.059] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:14:0)
[11:17:02.084] Build status: STARTED
[11:17:02.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:15:0) after 6m24s
[11:23:26.132] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:15:0)
[11:23:26.158] Build status: STARTED
[11:23:26.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:16:0) after 9m26s
[11:32:52.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:16:0)
[11:32:52.395] Build status: STARTED
[11:32:52.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8909505321550403360:17:0) after 2m53s
[11:33:35.065] Received PubSub notification, asking Buildbucket for the build status
[11:33:35.084] Build:
{
"id": "8744075259730027169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-26T10:17:06.280494975Z",
"startTime": "2024-06-26T10:17:13.079603953Z",
"endTime": "2024-06-26T11:33:26.729093618Z",
"updateTime": "2024-06-26T11:33:26.729093618Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f782ff8fc6426890863be0791a9ace2394da3887",
"ref": "refs/heads/main"
}
},
"canary": true
}
[11:33:35.084] Invocation finished in 1h16m29.924387116s with status SUCCEEDED