[19:57:05.108] New invocation is queued and will start shortly
[19:57:07.343] Starting the invocation (attempt 1)
[19:57:07.377] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a5a008ff4f5908e59ded084cc14a2237f080d681"
[19:57:07.377] Popped gitiles commit info from properties and tags
[19:57:07.377] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:57:07.377] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:57:07.379] Buildbucket request:
{
"requestId": "8934654787826453280",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934654787826453280",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3353f7dd3d91c9b2b6a15ba9229bee53e0cb8196"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3353f7dd3d91c9b2b6a15ba9229bee53e0cb8196",
"title": "3353f7dd3d91c9b2b6a15ba9229bee53e0cb8196",
"url": "https://llvm.googlesource.com/llvm-project/+/3353f7dd3d91c9b2b6a15ba9229bee53e0cb8196"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab82c3d0a8406edecfd26cb30678aab6d3eff1b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab82c3d0a8406edecfd26cb30678aab6d3eff1b7",
"title": "ab82c3d0a8406edecfd26cb30678aab6d3eff1b7",
"url": "https://llvm.googlesource.com/llvm-project/+/ab82c3d0a8406edecfd26cb30678aab6d3eff1b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2aff14ef3e41ef0e2290dd33f321f06e51da8364"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2aff14ef3e41ef0e2290dd33f321f06e51da8364",
"title": "2aff14ef3e41ef0e2290dd33f321f06e51da8364",
"url": "https://llvm.googlesource.com/llvm-project/+/2aff14ef3e41ef0e2290dd33f321f06e51da8364"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46d5d264fc66a017bbd0182b2b5fcc0f3f23d3be"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46d5d264fc66a017bbd0182b2b5fcc0f3f23d3be",
"title": "46d5d264fc66a017bbd0182b2b5fcc0f3f23d3be",
"url": "https://llvm.googlesource.com/llvm-project/+/46d5d264fc66a017bbd0182b2b5fcc0f3f23d3be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6ac71a0149cf92afac71b8b61f17f93af2731bfd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6ac71a0149cf92afac71b8b61f17f93af2731bfd",
"title": "6ac71a0149cf92afac71b8b61f17f93af2731bfd",
"url": "https://llvm.googlesource.com/llvm-project/+/6ac71a0149cf92afac71b8b61f17f93af2731bfd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a921f2a3d721aac0814b6e319b81db1bc46cd3f8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a921f2a3d721aac0814b6e319b81db1bc46cd3f8",
"title": "a921f2a3d721aac0814b6e319b81db1bc46cd3f8",
"url": "https://llvm.googlesource.com/llvm-project/+/a921f2a3d721aac0814b6e319b81db1bc46cd3f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f71ba7d323331bdb718e76a2f3a9562de835bb0d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f71ba7d323331bdb718e76a2f3a9562de835bb0d",
"title": "f71ba7d323331bdb718e76a2f3a9562de835bb0d",
"url": "https://llvm.googlesource.com/llvm-project/+/f71ba7d323331bdb718e76a2f3a9562de835bb0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bfa501b8927a3a18466fe9cc20c6d5afa786599f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bfa501b8927a3a18466fe9cc20c6d5afa786599f",
"title": "bfa501b8927a3a18466fe9cc20c6d5afa786599f",
"url": "https://llvm.googlesource.com/llvm-project/+/bfa501b8927a3a18466fe9cc20c6d5afa786599f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a5a008ff4f5908e59ded084cc14a2237f080d681"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a5a008ff4f5908e59ded084cc14a2237f080d681",
"title": "a5a008ff4f5908e59ded084cc14a2237f080d681",
"url": "https://llvm.googlesource.com/llvm-project/+/a5a008ff4f5908e59ded084cc14a2237f080d681"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a5a008ff4f5908e59ded084cc14a2237f080d681",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934654787826453280"
},
{
"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"
}
}
[19:57:07.842] Scheduled build:
{
"id": "8769224724724932673",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-22T19:57:07.443200007Z",
"updateTime": "2023-09-22T19:57:07.443200007Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a5a008ff4f5908e59ded084cc14a2237f080d681",
"ref": "refs/heads/main"
}
}
}
[19:57:07.842] Task URL: https://cr-buildbucket.appspot.com/build/8769224724724932673
[19:57:07.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:2:0) after 2m48s
[19:59:10.727] Received PubSub notification, asking Buildbucket for the build status
[19:59:10.789] Build status: STARTED
[19:59:55.856] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:2:0)
[19:59:55.946] Build status: STARTED
[19:59:55.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:4:0) after 2m54s
[20:02:50.031] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:4:0)
[20:02:50.104] Build status: STARTED
[20:02:50.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:5:0) after 8m31s
[20:08:19.893] Received PubSub notification, asking Buildbucket for the build status
[20:08:19.983] Build status: STARTED
[20:11:21.129] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:5:0)
[20:11:21.148] Build status: STARTED
[20:11:21.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:7:0) after 9m9s
[20:20:30.164] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:7:0)
[20:20:30.188] Build status: STARTED
[20:20:30.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:8:0) after 3m17s
[20:23:47.514] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:8:0)
[20:23:47.537] Build status: STARTED
[20:23:47.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:9:0) after 3m51s
[20:27:38.638] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:9:0)
[20:27:38.669] Build status: STARTED
[20:27:38.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:10:0) after 6m32s
[20:34:10.812] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:10:0)
[20:34:10.895] Build status: STARTED
[20:34:10.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:11:0) after 1m34s
[20:35:45.094] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:11:0)
[20:35:45.112] Build status: STARTED
[20:35:45.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:12:0) after 8m35s
[20:44:21.772] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:12:0)
[20:44:21.913] Build status: STARTED
[20:44:21.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:13:0) after 1m4s
[20:45:26.361] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:13:0)
[20:45:26.406] Build status: STARTED
[20:45:26.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:14:0) after 4m47s
[20:50:13.477] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:14:0)
[20:50:13.506] Build status: STARTED
[20:50:13.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:15:0) after 9m25s
[20:59:38.541] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:15:0)
[20:59:38.565] Build status: STARTED
[20:59:38.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934654787826453280:16:0) after 8m21s
[21:06:55.742] Received PubSub notification, asking Buildbucket for the build status
[21:06:55.768] Build:
{
"id": "8769224724724932673",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-22T19:57:07.443200007Z",
"startTime": "2023-09-22T19:59:10.069996Z",
"endTime": "2023-09-22T21:06:55.248329795Z",
"updateTime": "2023-09-22T21:06:55.248329795Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a5a008ff4f5908e59ded084cc14a2237f080d681",
"ref": "refs/heads/main"
}
}
}
[21:06:55.768] Invocation finished in 1h9m50.666395469s with status SUCCEEDED