[15:48:26.078] New invocation is queued and will start shortly
[15:48:27.136] Starting the invocation (attempt 1)
[15:48:27.175] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/da70f2cdcde8cb96e75ce0236db1fb5353407a69"
[15:48:27.175] Popped gitiles commit info from properties and tags
[15:48:27.175] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:48:27.177] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:48:27.186] Buildbucket request:
{
"requestId": "8915826262555402048",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8915826262555402048",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dbafcd7e6d5b6c3aff74307b2ed5ee1834f275b0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dbafcd7e6d5b6c3aff74307b2ed5ee1834f275b0",
"title": "dbafcd7e6d5b6c3aff74307b2ed5ee1834f275b0",
"url": "https://llvm.googlesource.com/llvm-project/+/dbafcd7e6d5b6c3aff74307b2ed5ee1834f275b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e49043512dbdc68319093da46e95a1e331ef837e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e49043512dbdc68319093da46e95a1e331ef837e",
"title": "e49043512dbdc68319093da46e95a1e331ef837e",
"url": "https://llvm.googlesource.com/llvm-project/+/e49043512dbdc68319093da46e95a1e331ef837e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4a5ab13bf5a94ec7f0eabaf24dfe1a5ee720b860"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4a5ab13bf5a94ec7f0eabaf24dfe1a5ee720b860",
"title": "4a5ab13bf5a94ec7f0eabaf24dfe1a5ee720b860",
"url": "https://llvm.googlesource.com/llvm-project/+/4a5ab13bf5a94ec7f0eabaf24dfe1a5ee720b860"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5d314353fbec1a15cd8900f466dcdcf2af40e8c9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5d314353fbec1a15cd8900f466dcdcf2af40e8c9",
"title": "5d314353fbec1a15cd8900f466dcdcf2af40e8c9",
"url": "https://llvm.googlesource.com/llvm-project/+/5d314353fbec1a15cd8900f466dcdcf2af40e8c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "812963f6aa2adb5e990f273b8ce1a0eabcdefd7f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@812963f6aa2adb5e990f273b8ce1a0eabcdefd7f",
"title": "812963f6aa2adb5e990f273b8ce1a0eabcdefd7f",
"url": "https://llvm.googlesource.com/llvm-project/+/812963f6aa2adb5e990f273b8ce1a0eabcdefd7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "458328ae23d318a5055d5bac66426b8551bce01f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@458328ae23d318a5055d5bac66426b8551bce01f",
"title": "458328ae23d318a5055d5bac66426b8551bce01f",
"url": "https://llvm.googlesource.com/llvm-project/+/458328ae23d318a5055d5bac66426b8551bce01f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "950bb097e11d6ee26533c00519c62df994322228"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@950bb097e11d6ee26533c00519c62df994322228",
"title": "950bb097e11d6ee26533c00519c62df994322228",
"url": "https://llvm.googlesource.com/llvm-project/+/950bb097e11d6ee26533c00519c62df994322228"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b854a2323337be2633b1135f590678a17e9d1ade"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b854a2323337be2633b1135f590678a17e9d1ade",
"title": "b854a2323337be2633b1135f590678a17e9d1ade",
"url": "https://llvm.googlesource.com/llvm-project/+/b854a2323337be2633b1135f590678a17e9d1ade"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8656d4c6a7a742c6fa6ee02c2ace7415163e65e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8656d4c6a7a742c6fa6ee02c2ace7415163e65e4",
"title": "8656d4c6a7a742c6fa6ee02c2ace7415163e65e4",
"url": "https://llvm.googlesource.com/llvm-project/+/8656d4c6a7a742c6fa6ee02c2ace7415163e65e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "abd5e45a96954d80f6ffe6d8676c0059fae8573b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@abd5e45a96954d80f6ffe6d8676c0059fae8573b",
"title": "abd5e45a96954d80f6ffe6d8676c0059fae8573b",
"url": "https://llvm.googlesource.com/llvm-project/+/abd5e45a96954d80f6ffe6d8676c0059fae8573b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a88ea8fbb3953c2fe2887438baf342e381a79d8b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a88ea8fbb3953c2fe2887438baf342e381a79d8b",
"title": "a88ea8fbb3953c2fe2887438baf342e381a79d8b",
"url": "https://llvm.googlesource.com/llvm-project/+/a88ea8fbb3953c2fe2887438baf342e381a79d8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "da70f2cdcde8cb96e75ce0236db1fb5353407a69"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@da70f2cdcde8cb96e75ce0236db1fb5353407a69",
"title": "da70f2cdcde8cb96e75ce0236db1fb5353407a69",
"url": "https://llvm.googlesource.com/llvm-project/+/da70f2cdcde8cb96e75ce0236db1fb5353407a69"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "da70f2cdcde8cb96e75ce0236db1fb5353407a69",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8915826262555402048"
},
{
"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"
}
}
[15:48:27.867] Scheduled build:
{
"id": "8750396200651758305",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-17T15:48:27.267896823Z",
"updateTime": "2024-04-17T15:48:27.267896823Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "da70f2cdcde8cb96e75ce0236db1fb5353407a69",
"ref": "refs/heads/main"
}
}
}
[15:48:27.867] Task URL: https://cr-buildbucket.appspot.com/build/8750396200651758305
[15:48:27.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:2:0) after 6m39s
[15:48:28.675] Received PubSub notification, asking Buildbucket for the build status
[15:48:28.705] Build status: SCHEDULED
[15:48:32.641] Received PubSub notification, asking Buildbucket for the build status
[15:48:32.675] Build status: STARTED
[15:55:06.929] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:2:0)
[15:55:06.954] Build status: STARTED
[15:55:06.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:5:0) after 9m53s
[16:05:00.026] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:5:0)
[16:05:00.066] Build status: STARTED
[16:05:00.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:6:0) after 5m40s
[16:10:40.171] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:6:0)
[16:10:40.205] Build status: STARTED
[16:10:40.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:7:0) after 2m46s
[16:13:26.222] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:7:0)
[16:13:26.252] Build status: STARTED
[16:13:26.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:8:0) after 1m10s
[16:14:36.241] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:8:0)
[16:14:36.301] Build status: STARTED
[16:14:36.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:9:0) after 9m47s
[16:24:23.636] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:9:0)
[16:24:23.688] Build status: STARTED
[16:24:23.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:10:0) after 2m19s
[16:26:42.713] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:10:0)
[16:26:42.740] Build status: STARTED
[16:26:42.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:11:0) after 9m25s
[16:36:07.763] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:11:0)
[16:36:07.787] Build status: STARTED
[16:36:07.787] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:12:0) after 2m40s
[16:38:47.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:12:0)
[16:38:47.829] Build status: STARTED
[16:38:47.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:13:0) after 3m54s
[16:42:41.858] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:13:0)
[16:42:41.903] Build status: STARTED
[16:42:41.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:14:0) after 8m49s
[16:51:31.173] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:14:0)
[16:51:31.216] Build status: STARTED
[16:51:31.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:15:0) after 2m17s
[16:53:48.285] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:15:0)
[16:53:48.306] Build status: STARTED
[16:53:48.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:16:0) after 6m2s
[16:59:50.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:16:0)
[16:59:50.406] Build status: STARTED
[16:59:50.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915826262555402048:17:0) after 7m50s
[17:03:00.783] Received PubSub notification, asking Buildbucket for the build status
[17:03:00.820] Build:
{
"id": "8750396200651758305",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-17T15:48:27.267896823Z",
"startTime": "2024-04-17T15:48:32.205792176Z",
"endTime": "2024-04-17T17:03:00.240481754Z",
"updateTime": "2024-04-17T17:03:00.240481754Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "da70f2cdcde8cb96e75ce0236db1fb5353407a69",
"ref": "refs/heads/main"
}
}
}
[17:03:00.820] Invocation finished in 1h14m34.751135684s with status SUCCEEDED