[17:41:40.963] New invocation is queued and will start shortly
[17:41:42.170] Starting the invocation (attempt 1)
[17:41:42.205] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7396ab1210a2aeee6bab5b73ec6d02975ba51b93"
[17:41:42.206] Popped gitiles commit info from properties and tags
[17:41:42.206] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:41:42.206] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:41:42.206] Buildbucket request:
{
"requestId": "8914550780093226896",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914550780093226896",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a00bbcbe7c7b1d5fb437d530555a6940c0b8d06a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a00bbcbe7c7b1d5fb437d530555a6940c0b8d06a",
"title": "a00bbcbe7c7b1d5fb437d530555a6940c0b8d06a",
"url": "https://llvm.googlesource.com/llvm-project/+/a00bbcbe7c7b1d5fb437d530555a6940c0b8d06a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6dfaecf077ade4bf003345501fdcfcebc8409ff7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6dfaecf077ade4bf003345501fdcfcebc8409ff7",
"title": "6dfaecf077ade4bf003345501fdcfcebc8409ff7",
"url": "https://llvm.googlesource.com/llvm-project/+/6dfaecf077ade4bf003345501fdcfcebc8409ff7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a764f49b4ae80daa5ba56cf0892bf0ebce48e2b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a764f49b4ae80daa5ba56cf0892bf0ebce48e2b3",
"title": "a764f49b4ae80daa5ba56cf0892bf0ebce48e2b3",
"url": "https://llvm.googlesource.com/llvm-project/+/a764f49b4ae80daa5ba56cf0892bf0ebce48e2b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "754072e9a5c0785560953e237229d0fbdd504d04"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@754072e9a5c0785560953e237229d0fbdd504d04",
"title": "754072e9a5c0785560953e237229d0fbdd504d04",
"url": "https://llvm.googlesource.com/llvm-project/+/754072e9a5c0785560953e237229d0fbdd504d04"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "477c705cb0d7cc857fad8184faac523f8ef72c84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@477c705cb0d7cc857fad8184faac523f8ef72c84",
"title": "477c705cb0d7cc857fad8184faac523f8ef72c84",
"url": "https://llvm.googlesource.com/llvm-project/+/477c705cb0d7cc857fad8184faac523f8ef72c84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "987c036f5413a94aab58bd5e27b653f740a5f7e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@987c036f5413a94aab58bd5e27b653f740a5f7e2",
"title": "987c036f5413a94aab58bd5e27b653f740a5f7e2",
"url": "https://llvm.googlesource.com/llvm-project/+/987c036f5413a94aab58bd5e27b653f740a5f7e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6c369cf937b7d9acb98a1fc46b1340cef7703e12"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6c369cf937b7d9acb98a1fc46b1340cef7703e12",
"title": "6c369cf937b7d9acb98a1fc46b1340cef7703e12",
"url": "https://llvm.googlesource.com/llvm-project/+/6c369cf937b7d9acb98a1fc46b1340cef7703e12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cf2f32c97f8fece105557c2357be4809cb9c14a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cf2f32c97f8fece105557c2357be4809cb9c14a1",
"title": "cf2f32c97f8fece105557c2357be4809cb9c14a1",
"url": "https://llvm.googlesource.com/llvm-project/+/cf2f32c97f8fece105557c2357be4809cb9c14a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7396ab1210a2aeee6bab5b73ec6d02975ba51b93"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7396ab1210a2aeee6bab5b73ec6d02975ba51b93",
"title": "7396ab1210a2aeee6bab5b73ec6d02975ba51b93",
"url": "https://llvm.googlesource.com/llvm-project/+/7396ab1210a2aeee6bab5b73ec6d02975ba51b93"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7396ab1210a2aeee6bab5b73ec6d02975ba51b93",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914550780093226896"
},
{
"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:41:42.784] Scheduled build:
{
"id": "8749120718010515073",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-01T17:41:42.303835501Z",
"updateTime": "2024-05-01T17:41:42.303835501Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7396ab1210a2aeee6bab5b73ec6d02975ba51b93",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:41:42.784] Task URL: https://cr-buildbucket.appspot.com/build/8749120718010515073
[17:41:42.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:2:0) after 1m54s
[17:41:43.716] Received PubSub notification, asking Buildbucket for the build status
[17:41:43.738] Build status: SCHEDULED
[17:41:47.109] Received PubSub notification, asking Buildbucket for the build status
[17:41:47.147] Build status: STARTED
[17:43:36.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:2:0)
[17:43:36.829] Build status: STARTED
[17:43:36.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:5:0) after 2m30s
[17:46:06.980] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:5:0)
[17:46:07.013] Build status: STARTED
[17:46:07.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:6:0) after 5m47s
[17:51:54.056] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:6:0)
[17:51:54.212] Build status: STARTED
[17:51:54.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:7:0) after 4m11s
[17:56:05.279] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:7:0)
[17:56:05.320] Build status: STARTED
[17:56:05.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:8:0) after 8m25s
[18:04:30.346] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:8:0)
[18:04:30.370] Build status: STARTED
[18:04:30.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:9:0) after 4m24s
[18:08:54.431] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:9:0)
[18:08:54.458] Build status: STARTED
[18:08:54.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:10:0) after 9m23s
[18:18:17.584] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:10:0)
[18:18:17.603] Build status: STARTED
[18:18:17.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:11:0) after 3m48s
[18:22:05.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:11:0)
[18:22:05.656] Build status: STARTED
[18:22:05.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:12:0) after 4m42s
[18:26:47.886] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:12:0)
[18:26:47.917] Build status: STARTED
[18:26:47.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:13:0) after 8m43s
[18:35:30.946] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:13:0)
[18:35:30.966] Build status: STARTED
[18:35:30.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:14:0) after 4m56s
[18:40:27.001] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:14:0)
[18:40:27.041] Build status: STARTED
[18:40:27.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:15:0) after 5m37s
[18:46:04.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:15:0)
[18:46:04.160] Build status: STARTED
[18:46:04.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:16:0) after 6m23s
[18:52:27.229] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:16:0)
[18:52:27.250] Build status: STARTED
[18:52:27.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:17:0) after 7m35s
[19:00:02.685] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:17:0)
[19:00:02.857] Build status: STARTED
[19:00:02.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:18:0) after 4m0s
[19:04:02.833] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:18:0)
[19:04:02.854] Build status: STARTED
[19:04:02.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8914550780093226896:19:0) after 5m25s
[19:05:58.817] Received PubSub notification, asking Buildbucket for the build status
[19:05:58.850] Build:
{
"id": "8749120718010515073",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-01T17:41:42.303835501Z",
"startTime": "2024-05-01T17:41:46.810703163Z",
"endTime": "2024-05-01T19:05:58.326048672Z",
"updateTime": "2024-05-01T19:05:58.326048672Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7396ab1210a2aeee6bab5b73ec6d02975ba51b93",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:05:58.850] Invocation finished in 1h24m17.916684098s with status SUCCEEDED