[07:01:26.438] New invocation is queued and will start shortly
[07:01:27.620] Starting the invocation (attempt 1)
[07:01:27.647] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/db096adba0f5d602587d0c90fb093cd12e706e5b"
[07:01:27.647] Popped gitiles commit info from properties and tags
[07:01:27.647] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:01:27.647] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:01:27.648] Buildbucket request:
{
"requestId": "8910785988065898848",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910785988065898848",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3bd9d4dedf11bb1d62f72e7602412db335a768d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3bd9d4dedf11bb1d62f72e7602412db335a768d4",
"title": "3bd9d4dedf11bb1d62f72e7602412db335a768d4",
"url": "https://llvm.googlesource.com/llvm-project/+/3bd9d4dedf11bb1d62f72e7602412db335a768d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9a2c8418695ca302c85ec398cc8ed58653729461"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9a2c8418695ca302c85ec398cc8ed58653729461",
"title": "9a2c8418695ca302c85ec398cc8ed58653729461",
"url": "https://llvm.googlesource.com/llvm-project/+/9a2c8418695ca302c85ec398cc8ed58653729461"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55bc04f67be1c61573acd03c70f6eee2ec764dc0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55bc04f67be1c61573acd03c70f6eee2ec764dc0",
"title": "55bc04f67be1c61573acd03c70f6eee2ec764dc0",
"url": "https://llvm.googlesource.com/llvm-project/+/55bc04f67be1c61573acd03c70f6eee2ec764dc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "93d4fb032ec1e069cfa5b800f3ca1c807f0d87ac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@93d4fb032ec1e069cfa5b800f3ca1c807f0d87ac",
"title": "93d4fb032ec1e069cfa5b800f3ca1c807f0d87ac",
"url": "https://llvm.googlesource.com/llvm-project/+/93d4fb032ec1e069cfa5b800f3ca1c807f0d87ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c012e487b7246239c31bd378ab074fb110631186"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c012e487b7246239c31bd378ab074fb110631186",
"title": "c012e487b7246239c31bd378ab074fb110631186",
"url": "https://llvm.googlesource.com/llvm-project/+/c012e487b7246239c31bd378ab074fb110631186"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b24c2dfb5c02896ec2e9855ac72eb0771d0764d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b24c2dfb5c02896ec2e9855ac72eb0771d0764d",
"title": "4b24c2dfb5c02896ec2e9855ac72eb0771d0764d",
"url": "https://llvm.googlesource.com/llvm-project/+/4b24c2dfb5c02896ec2e9855ac72eb0771d0764d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2fe72385a4964f80e7a1c5abcd426455e4127c03"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2fe72385a4964f80e7a1c5abcd426455e4127c03",
"title": "2fe72385a4964f80e7a1c5abcd426455e4127c03",
"url": "https://llvm.googlesource.com/llvm-project/+/2fe72385a4964f80e7a1c5abcd426455e4127c03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "db096adba0f5d602587d0c90fb093cd12e706e5b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@db096adba0f5d602587d0c90fb093cd12e706e5b",
"title": "db096adba0f5d602587d0c90fb093cd12e706e5b",
"url": "https://llvm.googlesource.com/llvm-project/+/db096adba0f5d602587d0c90fb093cd12e706e5b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "db096adba0f5d602587d0c90fb093cd12e706e5b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910785988065898848"
},
{
"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"
}
}
[07:01:28.547] Scheduled build:
{
"id": "8745355925954572945",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-12T07:01:27.793689178Z",
"updateTime": "2024-06-12T07:01:27.793689178Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "db096adba0f5d602587d0c90fb093cd12e706e5b",
"ref": "refs/heads/main"
}
}
}
[07:01:28.547] Task URL: https://cr-buildbucket.appspot.com/build/8745355925954572945
[07:01:28.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:2:0) after 2m54s
[07:01:29.582] Received PubSub notification, asking Buildbucket for the build status
[07:01:29.599] Build status: SCHEDULED
[07:01:34.620] Received PubSub notification, asking Buildbucket for the build status
[07:01:34.711] Build status: STARTED
[07:04:22.835] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:2:0)
[07:04:22.862] Build status: STARTED
[07:04:22.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:5:0) after 1m19s
[07:05:41.880] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:5:0)
[07:05:41.900] Build status: STARTED
[07:05:41.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:6:0) after 5m57s
[07:11:39.016] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:6:0)
[07:11:39.039] Build status: STARTED
[07:11:39.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:7:0) after 2m50s
[07:14:29.157] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:7:0)
[07:14:29.174] Build status: STARTED
[07:14:29.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:8:0) after 6m2s
[07:20:31.464] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:8:0)
[07:20:31.482] Build status: STARTED
[07:20:31.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:9:0) after 4m43s
[07:25:14.484] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:9:0)
[07:25:14.516] Build status: STARTED
[07:25:14.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:10:0) after 3m28s
[07:28:42.595] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:10:0)
[07:28:42.641] Build status: STARTED
[07:28:42.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:11:0) after 5m7s
[07:33:49.804] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:11:0)
[07:33:49.823] Build status: STARTED
[07:33:49.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:12:0) after 6m1s
[07:39:50.876] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:12:0)
[07:39:50.933] Build status: STARTED
[07:39:50.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:13:0) after 1m51s
[07:41:42.054] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:13:0)
[07:41:42.074] Build status: STARTED
[07:41:42.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:14:0) after 7m46s
[07:49:28.171] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:14:0)
[07:49:28.188] Build status: STARTED
[07:49:28.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:15:0) after 7m12s
[07:56:40.183] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:15:0)
[07:56:40.206] Build status: STARTED
[07:56:40.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:16:0) after 6m20s
[08:03:00.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:16:0)
[08:03:00.263] Build status: STARTED
[08:03:00.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:17:0) after 1m53s
[08:04:53.380] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:17:0)
[08:04:53.402] Build status: STARTED
[08:04:53.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:18:0) after 5m51s
[08:10:44.381] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:18:0)
[08:10:44.400] Build status: STARTED
[08:10:44.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:19:0) after 8m42s
[08:19:26.417] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:19:0)
[08:19:26.438] Build status: STARTED
[08:19:26.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:20:0) after 2m20s
[08:21:46.792] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:20:0)
[08:21:46.827] Build status: STARTED
[08:21:46.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910785988065898848:21:0) after 6m33s
[08:24:13.244] Received PubSub notification, asking Buildbucket for the build status
[08:24:13.261] Build:
{
"id": "8745355925954572945",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-12T07:01:27.793689178Z",
"startTime": "2024-06-12T07:01:34.321525412Z",
"endTime": "2024-06-12T08:24:12.788709121Z",
"updateTime": "2024-06-12T08:24:12.788709121Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "db096adba0f5d602587d0c90fb093cd12e706e5b",
"ref": "refs/heads/main"
}
}
}
[08:24:13.261] Invocation finished in 1h22m46.865489026s with status SUCCEEDED