[17:05:04.972] New invocation is queued and will start shortly
[17:05:06.147] Starting the invocation (attempt 1)
[17:05:06.177] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f559c2efe195b54ebc0f0a0077918483a25a6ae4"
[17:05:06.177] Popped gitiles commit info from properties and tags
[17:05:06.177] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:05:06.178] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:05:06.178] Buildbucket request:
{
"requestId": "8921710243081286368",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8921710243081286368",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "70caa316e955a35904e34961c79d75935b7d906f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@70caa316e955a35904e34961c79d75935b7d906f",
"title": "70caa316e955a35904e34961c79d75935b7d906f",
"url": "https://llvm.googlesource.com/llvm-project/+/70caa316e955a35904e34961c79d75935b7d906f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76eb8e35d6631827c0450e9d5f4743e410d4151a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76eb8e35d6631827c0450e9d5f4743e410d4151a",
"title": "76eb8e35d6631827c0450e9d5f4743e410d4151a",
"url": "https://llvm.googlesource.com/llvm-project/+/76eb8e35d6631827c0450e9d5f4743e410d4151a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1da7f410bcd831d4b2c3166b672d93c8110edfc0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1da7f410bcd831d4b2c3166b672d93c8110edfc0",
"title": "1da7f410bcd831d4b2c3166b672d93c8110edfc0",
"url": "https://llvm.googlesource.com/llvm-project/+/1da7f410bcd831d4b2c3166b672d93c8110edfc0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "673e5e34b40071b2762c5ac1fea32c3596fe4dd3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@673e5e34b40071b2762c5ac1fea32c3596fe4dd3",
"title": "673e5e34b40071b2762c5ac1fea32c3596fe4dd3",
"url": "https://llvm.googlesource.com/llvm-project/+/673e5e34b40071b2762c5ac1fea32c3596fe4dd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab702513f1ee2268ce216d11c310a08cae24a0e7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab702513f1ee2268ce216d11c310a08cae24a0e7",
"title": "ab702513f1ee2268ce216d11c310a08cae24a0e7",
"url": "https://llvm.googlesource.com/llvm-project/+/ab702513f1ee2268ce216d11c310a08cae24a0e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d2d6b368a17547a847baf2c9767ad8c1686e58d1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d2d6b368a17547a847baf2c9767ad8c1686e58d1",
"title": "d2d6b368a17547a847baf2c9767ad8c1686e58d1",
"url": "https://llvm.googlesource.com/llvm-project/+/d2d6b368a17547a847baf2c9767ad8c1686e58d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cf55e61dd916d7ba042b9d072d07c3a0b50a815f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cf55e61dd916d7ba042b9d072d07c3a0b50a815f",
"title": "cf55e61dd916d7ba042b9d072d07c3a0b50a815f",
"url": "https://llvm.googlesource.com/llvm-project/+/cf55e61dd916d7ba042b9d072d07c3a0b50a815f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "30338223e461a00463cef665ec29d8f5a8ef2cda"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@30338223e461a00463cef665ec29d8f5a8ef2cda",
"title": "30338223e461a00463cef665ec29d8f5a8ef2cda",
"url": "https://llvm.googlesource.com/llvm-project/+/30338223e461a00463cef665ec29d8f5a8ef2cda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b5046a7fa9b38cfcc3980b83a93db678871ad350"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b5046a7fa9b38cfcc3980b83a93db678871ad350",
"title": "b5046a7fa9b38cfcc3980b83a93db678871ad350",
"url": "https://llvm.googlesource.com/llvm-project/+/b5046a7fa9b38cfcc3980b83a93db678871ad350"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "595d8d4e856217f69dc05448ae852c24e65cc181"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@595d8d4e856217f69dc05448ae852c24e65cc181",
"title": "595d8d4e856217f69dc05448ae852c24e65cc181",
"url": "https://llvm.googlesource.com/llvm-project/+/595d8d4e856217f69dc05448ae852c24e65cc181"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6a3a5cad2e1249f1b685546ebe71b2ead9a27541"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6a3a5cad2e1249f1b685546ebe71b2ead9a27541",
"title": "6a3a5cad2e1249f1b685546ebe71b2ead9a27541",
"url": "https://llvm.googlesource.com/llvm-project/+/6a3a5cad2e1249f1b685546ebe71b2ead9a27541"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7d9c38a040d778338131fbbcc094aa412dc9306a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7d9c38a040d778338131fbbcc094aa412dc9306a",
"title": "7d9c38a040d778338131fbbcc094aa412dc9306a",
"url": "https://llvm.googlesource.com/llvm-project/+/7d9c38a040d778338131fbbcc094aa412dc9306a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "165fdaab213d3e3e7461344b4fc504f04dcba571"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@165fdaab213d3e3e7461344b4fc504f04dcba571",
"title": "165fdaab213d3e3e7461344b4fc504f04dcba571",
"url": "https://llvm.googlesource.com/llvm-project/+/165fdaab213d3e3e7461344b4fc504f04dcba571"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f559c2efe195b54ebc0f0a0077918483a25a6ae4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f559c2efe195b54ebc0f0a0077918483a25a6ae4",
"title": "f559c2efe195b54ebc0f0a0077918483a25a6ae4",
"url": "https://llvm.googlesource.com/llvm-project/+/f559c2efe195b54ebc0f0a0077918483a25a6ae4"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f559c2efe195b54ebc0f0a0077918483a25a6ae4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8921710243081286368"
},
{
"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"
}
}
[17:05:06.844] Scheduled build:
{
"id": "8756280181056375313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-12T17:05:06.277662526Z",
"updateTime": "2024-02-12T17:05:06.277662526Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f559c2efe195b54ebc0f0a0077918483a25a6ae4",
"ref": "refs/heads/main"
}
}
}
[17:05:06.844] Task URL: https://cr-buildbucket.appspot.com/build/8756280181056375313
[17:05:06.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:2:0) after 5m48s
[17:05:07.697] Received PubSub notification, asking Buildbucket for the build status
[17:05:07.727] Build status: SCHEDULED
[17:05:51.449] Received PubSub notification, asking Buildbucket for the build status
[17:05:51.493] Build status: STARTED
[17:10:55.084] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:2:0)
[17:10:55.128] Build status: STARTED
[17:10:55.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:5:0) after 6m6s
[17:17:01.262] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:5:0)
[17:17:01.284] Build status: STARTED
[17:17:01.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:6:0) after 7m57s
[17:24:58.308] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:6:0)
[17:24:58.365] Build status: STARTED
[17:24:58.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:7:0) after 4m31s
[17:29:30.012] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:7:0)
[17:29:30.078] Build status: STARTED
[17:29:30.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:8:0) after 8m40s
[17:38:10.095] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:8:0)
[17:38:10.143] Build status: STARTED
[17:38:10.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:9:0) after 2m50s
[17:41:00.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:9:0)
[17:41:00.528] Build status: STARTED
[17:41:00.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:10:0) after 9m21s
[17:50:21.999] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:10:0)
[17:50:22.018] Build status: STARTED
[17:50:22.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:11:0) after 7m20s
[17:57:42.113] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:11:0)
[17:57:42.141] Build status: STARTED
[17:57:42.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:12:0) after 8m40s
[18:06:22.658] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:12:0)
[18:06:22.679] Build status: STARTED
[18:06:22.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:13:0) after 2m42s
[18:09:04.803] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:13:0)
[18:09:04.826] Build status: STARTED
[18:09:04.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:14:0) after 4m22s
[18:13:27.095] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:14:0)
[18:13:27.118] Build status: STARTED
[18:13:27.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:15:0) after 3m15s
[18:16:42.462] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:15:0)
[18:16:42.484] Build status: STARTED
[18:16:42.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8921710243081286368:16:0) after 3m58s
[18:19:22.271] Received PubSub notification, asking Buildbucket for the build status
[18:19:22.292] Build:
{
"id": "8756280181056375313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-12T17:05:06.277662526Z",
"startTime": "2024-02-12T17:05:50.895636Z",
"endTime": "2024-02-12T18:19:21.202085Z",
"updateTime": "2024-02-12T18:19:21.202085Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f559c2efe195b54ebc0f0a0077918483a25a6ae4",
"ref": "refs/heads/main"
}
}
}
[18:19:22.292] Invocation finished in 1h14m17.330071539s with status SUCCEEDED