[18:17:03.670] New invocation is queued and will start shortly
[18:17:05.013] Starting the invocation (attempt 1)
[18:17:05.058] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2c43d591c6c85489bd81b2653f0f7b1e91bb97f5"
[18:17:05.059] Popped gitiles commit info from properties and tags
[18:17:05.059] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:17:05.062] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:17:05.063] Buildbucket request:
{
"requestId": "8938013168548505760",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8938013168548505760",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04e6129d3243b9ed60ed17048b701b56aa0e7557"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04e6129d3243b9ed60ed17048b701b56aa0e7557",
"title": "04e6129d3243b9ed60ed17048b701b56aa0e7557",
"url": "https://llvm.googlesource.com/llvm-project/+/04e6129d3243b9ed60ed17048b701b56aa0e7557"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e6014a26082361f13ad976e2d8bca92aa0433c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e6014a26082361f13ad976e2d8bca92aa0433c4",
"title": "6e6014a26082361f13ad976e2d8bca92aa0433c4",
"url": "https://llvm.googlesource.com/llvm-project/+/6e6014a26082361f13ad976e2d8bca92aa0433c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0805310b5017b9d015958bc10b10f3125f4f39da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0805310b5017b9d015958bc10b10f3125f4f39da",
"title": "0805310b5017b9d015958bc10b10f3125f4f39da",
"url": "https://llvm.googlesource.com/llvm-project/+/0805310b5017b9d015958bc10b10f3125f4f39da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1fd72321a48d76ae884adb132a109817eee981a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1fd72321a48d76ae884adb132a109817eee981a0",
"title": "1fd72321a48d76ae884adb132a109817eee981a0",
"url": "https://llvm.googlesource.com/llvm-project/+/1fd72321a48d76ae884adb132a109817eee981a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "922ac64b04b12f70135a53460610326ba2b72283"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@922ac64b04b12f70135a53460610326ba2b72283",
"title": "922ac64b04b12f70135a53460610326ba2b72283",
"url": "https://llvm.googlesource.com/llvm-project/+/922ac64b04b12f70135a53460610326ba2b72283"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de059a2ea299845b3586d6b6e1b2441b65b1a556"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de059a2ea299845b3586d6b6e1b2441b65b1a556",
"title": "de059a2ea299845b3586d6b6e1b2441b65b1a556",
"url": "https://llvm.googlesource.com/llvm-project/+/de059a2ea299845b3586d6b6e1b2441b65b1a556"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e87d68ce8f4f12390712e917c7a1d6160bad6ee5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e87d68ce8f4f12390712e917c7a1d6160bad6ee5",
"title": "e87d68ce8f4f12390712e917c7a1d6160bad6ee5",
"url": "https://llvm.googlesource.com/llvm-project/+/e87d68ce8f4f12390712e917c7a1d6160bad6ee5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "329979cf3771759646b47395384e06eb271f485f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@329979cf3771759646b47395384e06eb271f485f",
"title": "329979cf3771759646b47395384e06eb271f485f",
"url": "https://llvm.googlesource.com/llvm-project/+/329979cf3771759646b47395384e06eb271f485f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2e7aa2ee34eb53347396731dc8a3b2dbc6a3df45"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2e7aa2ee34eb53347396731dc8a3b2dbc6a3df45",
"title": "2e7aa2ee34eb53347396731dc8a3b2dbc6a3df45",
"url": "https://llvm.googlesource.com/llvm-project/+/2e7aa2ee34eb53347396731dc8a3b2dbc6a3df45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9d0d15e69a9b3375740ff803f78a8a4ecfc0105"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9d0d15e69a9b3375740ff803f78a8a4ecfc0105",
"title": "c9d0d15e69a9b3375740ff803f78a8a4ecfc0105",
"url": "https://llvm.googlesource.com/llvm-project/+/c9d0d15e69a9b3375740ff803f78a8a4ecfc0105"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "063c42e919c01d7e64c1af5a10898fc84b06dfe8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@063c42e919c01d7e64c1af5a10898fc84b06dfe8",
"title": "063c42e919c01d7e64c1af5a10898fc84b06dfe8",
"url": "https://llvm.googlesource.com/llvm-project/+/063c42e919c01d7e64c1af5a10898fc84b06dfe8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8b68cec9c0a42bbba04e7ed2e01136c16236cd50"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8b68cec9c0a42bbba04e7ed2e01136c16236cd50",
"title": "8b68cec9c0a42bbba04e7ed2e01136c16236cd50",
"url": "https://llvm.googlesource.com/llvm-project/+/8b68cec9c0a42bbba04e7ed2e01136c16236cd50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0e7649698a2f4b41159b0203147cf4beca07b0bc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0e7649698a2f4b41159b0203147cf4beca07b0bc",
"title": "0e7649698a2f4b41159b0203147cf4beca07b0bc",
"url": "https://llvm.googlesource.com/llvm-project/+/0e7649698a2f4b41159b0203147cf4beca07b0bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2c43d591c6c85489bd81b2653f0f7b1e91bb97f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2c43d591c6c85489bd81b2653f0f7b1e91bb97f5",
"title": "2c43d591c6c85489bd81b2653f0f7b1e91bb97f5",
"url": "https://llvm.googlesource.com/llvm-project/+/2c43d591c6c85489bd81b2653f0f7b1e91bb97f5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2c43d591c6c85489bd81b2653f0f7b1e91bb97f5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8938013168548505760"
},
{
"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"
}
}
[18:17:05.768] Scheduled build:
{
"id": "8772583106369226545",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-16T18:17:05.124570101Z",
"updateTime": "2023-08-16T18:17:05.124570101Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2c43d591c6c85489bd81b2653f0f7b1e91bb97f5",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:17:05.768] Task URL: https://cr-buildbucket.appspot.com/build/8772583106369226545
[18:17:05.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:2:0) after 7m45s
[18:17:06.579] Received PubSub notification, asking Buildbucket for the build status
[18:17:06.619] Build status: SCHEDULED
[18:19:00.545] Received PubSub notification, asking Buildbucket for the build status
[18:19:00.565] Build status: STARTED
[18:24:50.900] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:2:0)
[18:24:50.950] Build status: STARTED
[18:24:50.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:5:0) after 1m14s
[18:26:05.008] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:5:0)
[18:26:05.037] Build status: STARTED
[18:26:05.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:6:0) after 5m45s
[18:31:50.093] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:6:0)
[18:31:50.114] Build status: STARTED
[18:31:50.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:7:0) after 3m42s
[18:35:32.197] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:7:0)
[18:35:32.239] Build status: STARTED
[18:35:32.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:8:0) after 6m30s
[18:42:02.477] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:8:0)
[18:42:02.511] Build status: STARTED
[18:42:02.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:9:0) after 5m11s
[18:47:13.531] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:9:0)
[18:47:13.670] Build status: STARTED
[18:47:13.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:10:0) after 4m15s
[18:51:28.837] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:10:0)
[18:51:28.859] Build status: STARTED
[18:51:28.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:11:0) after 4m1s
[18:55:29.889] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:11:0)
[18:55:29.949] Build status: STARTED
[18:55:29.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:12:0) after 6m40s
[19:02:10.065] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:12:0)
[19:02:10.086] Build status: STARTED
[19:02:10.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:13:0) after 1m41s
[19:03:51.126] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:13:0)
[19:03:51.152] Build status: STARTED
[19:03:51.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:14:0) after 6m54s
[19:10:45.302] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:14:0)
[19:10:45.327] Build status: STARTED
[19:10:45.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:15:0) after 9m15s
[19:20:00.895] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:15:0)
[19:20:00.916] Build status: STARTED
[19:20:00.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8938013168548505760:16:0) after 8m33s
[19:23:34.662] Received PubSub notification, asking Buildbucket for the build status
[19:23:34.687] Build:
{
"id": "8772583106369226545",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-16T18:17:05.124570101Z",
"startTime": "2023-08-16T18:18:59.928293Z",
"endTime": "2023-08-16T19:23:34.277383823Z",
"updateTime": "2023-08-16T19:23:34.277383823Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2c43d591c6c85489bd81b2653f0f7b1e91bb97f5",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:23:34.687] Invocation finished in 1h6m31.025066121s with status SUCCEEDED