[23:33:58.247] New invocation is queued and will start shortly
[23:33:59.384] Starting the invocation (attempt 1)
[23:33:59.408] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c663401f69ecb999eb0c5a2af183b920c6c50a6a"
[23:33:59.408] Popped gitiles commit info from properties and tags
[23:33:59.408] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:33:59.409] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:33:59.409] Buildbucket request:
{
"requestId": "8935275321326254368",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8935275321326254368",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4f85e0ab405c89e1b843401a055538bd26a0187"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4f85e0ab405c89e1b843401a055538bd26a0187",
"title": "f4f85e0ab405c89e1b843401a055538bd26a0187",
"url": "https://llvm.googlesource.com/llvm-project/+/f4f85e0ab405c89e1b843401a055538bd26a0187"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90a0dc7eaf7242582df9dc4ee4e16cb29f584757"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90a0dc7eaf7242582df9dc4ee4e16cb29f584757",
"title": "90a0dc7eaf7242582df9dc4ee4e16cb29f584757",
"url": "https://llvm.googlesource.com/llvm-project/+/90a0dc7eaf7242582df9dc4ee4e16cb29f584757"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6af7bf6953789224fd9e0b786cd38ac16d300e45"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6af7bf6953789224fd9e0b786cd38ac16d300e45",
"title": "6af7bf6953789224fd9e0b786cd38ac16d300e45",
"url": "https://llvm.googlesource.com/llvm-project/+/6af7bf6953789224fd9e0b786cd38ac16d300e45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ac182deee828731d717ed062977bc8ed358e31b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ac182deee828731d717ed062977bc8ed358e31b6",
"title": "ac182deee828731d717ed062977bc8ed358e31b6",
"url": "https://llvm.googlesource.com/llvm-project/+/ac182deee828731d717ed062977bc8ed358e31b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff2622b5ac6befc1f0814f83dabed8c04d7215ef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff2622b5ac6befc1f0814f83dabed8c04d7215ef",
"title": "ff2622b5ac6befc1f0814f83dabed8c04d7215ef",
"url": "https://llvm.googlesource.com/llvm-project/+/ff2622b5ac6befc1f0814f83dabed8c04d7215ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c663401f69ecb999eb0c5a2af183b920c6c50a6a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c663401f69ecb999eb0c5a2af183b920c6c50a6a",
"title": "c663401f69ecb999eb0c5a2af183b920c6c50a6a",
"url": "https://llvm.googlesource.com/llvm-project/+/c663401f69ecb999eb0c5a2af183b920c6c50a6a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c663401f69ecb999eb0c5a2af183b920c6c50a6a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8935275321326254368"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:33:59.907] Scheduled build:
{
"id": "8769845259354584113",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-15T23:33:59.504462697Z",
"updateTime": "2023-09-15T23:33:59.504462697Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c663401f69ecb999eb0c5a2af183b920c6c50a6a",
"ref": "refs/heads/main"
}
}
}
[23:33:59.907] Task URL: https://cr-buildbucket.appspot.com/build/8769845259354584113
[23:33:59.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:2:0) after 5m16s
[23:34:26.702] Received PubSub notification, asking Buildbucket for the build status
[23:34:26.741] Build status: SCHEDULED
[23:34:58.369] Received PubSub notification, asking Buildbucket for the build status
[23:34:58.406] Build status: STARTED
[23:39:15.969] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:2:0)
[23:39:15.990] Build status: STARTED
[23:39:15.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:5:0) after 3m33s
[23:42:49.233] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:5:0)
[23:42:49.257] Build status: STARTED
[23:42:49.257] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:6:0) after 9m59s
[23:52:48.720] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:6:0)
[23:52:48.746] Build status: STARTED
[23:52:48.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:7:0) after 6m54s
[23:59:42.774] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:7:0)
[23:59:42.796] Build status: STARTED
[23:59:42.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:8:0) after 8m37s
[00:08:20.368] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:8:0)
[00:08:20.580] Build status: STARTED
[00:08:20.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:9:0) after 5m41s
[00:14:01.610] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:9:0)
[00:14:01.696] Build status: STARTED
[00:14:01.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:10:0) after 3m23s
[00:17:24.761] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:10:0)
[00:17:24.781] Build status: STARTED
[00:17:24.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:11:0) after 5m41s
[00:23:05.886] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:11:0)
[00:23:05.905] Build status: STARTED
[00:23:05.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:12:0) after 9m30s
[00:32:35.919] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:12:0)
[00:32:35.994] Build status: STARTED
[00:32:35.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:13:0) after 6m8s
[00:38:44.825] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:13:0)
[00:38:44.844] Build status: STARTED
[00:38:44.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8935275321326254368:14:0) after 3m31s
[00:39:16.760] Received PubSub notification, asking Buildbucket for the build status
[00:39:16.778] Build:
{
"id": "8769845259354584113",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-15T23:33:59.504462697Z",
"startTime": "2023-09-15T23:34:28.808640Z",
"endTime": "2023-09-16T00:39:16.467583430Z",
"updateTime": "2023-09-16T00:39:16.467583430Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c663401f69ecb999eb0c5a2af183b920c6c50a6a",
"ref": "refs/heads/main"
}
}
}
[00:39:16.778] Invocation finished in 1h5m18.538960258s with status SUCCEEDED