[17:32:57.365] New invocation is queued and will start shortly
[17:32:58.463] Starting the invocation (attempt 1)
[17:32:58.491] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ec4d5a6658782b4a88c634d5b332c56b754c5949"
[17:32:58.491] Popped gitiles commit info from properties and tags
[17:32:58.492] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:32:58.493] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:32:58.493] Buildbucket request:
{
"requestId": "8903951484033829824",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8903951484033829824",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "121ed07975c087291ac7faf681042d51211b9f97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@121ed07975c087291ac7faf681042d51211b9f97",
"title": "121ed07975c087291ac7faf681042d51211b9f97",
"url": "https://llvm.googlesource.com/llvm-project/+/121ed07975c087291ac7faf681042d51211b9f97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04ebd1907c0561831e4fcf2658e1f3614f8cdd77"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04ebd1907c0561831e4fcf2658e1f3614f8cdd77",
"title": "04ebd1907c0561831e4fcf2658e1f3614f8cdd77",
"url": "https://llvm.googlesource.com/llvm-project/+/04ebd1907c0561831e4fcf2658e1f3614f8cdd77"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ee09f7d1fc173f2b495838c925f2cf39a2b55369"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ee09f7d1fc173f2b495838c925f2cf39a2b55369",
"title": "ee09f7d1fc173f2b495838c925f2cf39a2b55369",
"url": "https://llvm.googlesource.com/llvm-project/+/ee09f7d1fc173f2b495838c925f2cf39a2b55369"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a79cf0228e4ade1f69e8196fdcf9c0184b4ba1b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a79cf0228e4ade1f69e8196fdcf9c0184b4ba1b7",
"title": "a79cf0228e4ade1f69e8196fdcf9c0184b4ba1b7",
"url": "https://llvm.googlesource.com/llvm-project/+/a79cf0228e4ade1f69e8196fdcf9c0184b4ba1b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c1b3ebba7909e9e3e99a4ac45bef38d7f590cc3b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c1b3ebba7909e9e3e99a4ac45bef38d7f590cc3b",
"title": "c1b3ebba7909e9e3e99a4ac45bef38d7f590cc3b",
"url": "https://llvm.googlesource.com/llvm-project/+/c1b3ebba7909e9e3e99a4ac45bef38d7f590cc3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "625e929d4305987a85c86ad4c67f1e15b36f89e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@625e929d4305987a85c86ad4c67f1e15b36f89e0",
"title": "625e929d4305987a85c86ad4c67f1e15b36f89e0",
"url": "https://llvm.googlesource.com/llvm-project/+/625e929d4305987a85c86ad4c67f1e15b36f89e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2e426fe8ff314c2565073e73e27fdbdf36c140a3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2e426fe8ff314c2565073e73e27fdbdf36c140a3",
"title": "2e426fe8ff314c2565073e73e27fdbdf36c140a3",
"url": "https://llvm.googlesource.com/llvm-project/+/2e426fe8ff314c2565073e73e27fdbdf36c140a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "710664341d72071729401d2eb86356056a3d7f46"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@710664341d72071729401d2eb86356056a3d7f46",
"title": "710664341d72071729401d2eb86356056a3d7f46",
"url": "https://llvm.googlesource.com/llvm-project/+/710664341d72071729401d2eb86356056a3d7f46"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7af61d5cf464f1d716c82bc77907fa3fe4ebc841"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7af61d5cf464f1d716c82bc77907fa3fe4ebc841",
"title": "7af61d5cf464f1d716c82bc77907fa3fe4ebc841",
"url": "https://llvm.googlesource.com/llvm-project/+/7af61d5cf464f1d716c82bc77907fa3fe4ebc841"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bbf2781bc49aee4d7ee8ec40dcf7316db360c454"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bbf2781bc49aee4d7ee8ec40dcf7316db360c454",
"title": "bbf2781bc49aee4d7ee8ec40dcf7316db360c454",
"url": "https://llvm.googlesource.com/llvm-project/+/bbf2781bc49aee4d7ee8ec40dcf7316db360c454"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c073821142d1bda68682f8ff640d143cbb03ae7b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c073821142d1bda68682f8ff640d143cbb03ae7b",
"title": "c073821142d1bda68682f8ff640d143cbb03ae7b",
"url": "https://llvm.googlesource.com/llvm-project/+/c073821142d1bda68682f8ff640d143cbb03ae7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2ef3dcf1fd4b3a2fc849b113644533f3e6df8b1e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2ef3dcf1fd4b3a2fc849b113644533f3e6df8b1e",
"title": "2ef3dcf1fd4b3a2fc849b113644533f3e6df8b1e",
"url": "https://llvm.googlesource.com/llvm-project/+/2ef3dcf1fd4b3a2fc849b113644533f3e6df8b1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec4d5a6658782b4a88c634d5b332c56b754c5949"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec4d5a6658782b4a88c634d5b332c56b754c5949",
"title": "ec4d5a6658782b4a88c634d5b332c56b754c5949",
"url": "https://llvm.googlesource.com/llvm-project/+/ec4d5a6658782b4a88c634d5b332c56b754c5949"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ec4d5a6658782b4a88c634d5b332c56b754c5949",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8903951484033829824"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:32:58.929] Scheduled build:
{
"id": "8738521422139618113",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-26T17:32:58.547197898Z",
"updateTime": "2024-08-26T17:32:58.547197898Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ec4d5a6658782b4a88c634d5b332c56b754c5949",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:32:58.929] Task URL: https://cr-buildbucket.appspot.com/build/8738521422139618113
[17:32:58.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:2:0) after 8m17s
[17:32:59.059] Received PubSub notification, asking Buildbucket for the build status
[17:32:59.098] Build status: SCHEDULED
[17:33:02.940] Received PubSub notification, asking Buildbucket for the build status
[17:33:02.966] Build status: STARTED
[17:41:16.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:2:0)
[17:41:16.100] Build status: STARTED
[17:41:16.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:5:0) after 9m44s
[17:51:00.197] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:5:0)
[17:51:00.237] Build status: STARTED
[17:51:00.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:6:0) after 1m20s
[17:52:20.245] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:6:0)
[17:52:20.265] Build status: STARTED
[17:52:20.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:7:0) after 2m1s
[17:54:21.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:7:0)
[17:54:21.276] Build status: STARTED
[17:54:21.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:8:0) after 5m3s
[17:59:24.413] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:8:0)
[17:59:24.454] Build status: STARTED
[17:59:24.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:9:0) after 2m33s
[18:01:57.514] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:9:0)
[18:01:57.544] Build status: STARTED
[18:01:57.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:10:0) after 8m20s
[18:10:17.562] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:10:0)
[18:10:17.604] Build status: STARTED
[18:10:17.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:11:0) after 8m25s
[18:18:42.619] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:11:0)
[18:18:42.642] Build status: STARTED
[18:18:42.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:12:0) after 7m14s
[18:25:56.769] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:12:0)
[18:25:56.806] Build status: STARTED
[18:25:56.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:13:0) after 3m10s
[18:29:06.890] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:13:0)
[18:29:06.941] Build status: STARTED
[18:29:06.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:14:0) after 1m8s
[18:30:15.072] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:14:0)
[18:30:15.101] Build status: STARTED
[18:30:15.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:15:0) after 6m33s
[18:36:48.230] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:15:0)
[18:36:48.248] Build status: STARTED
[18:36:48.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:16:0) after 4m41s
[18:41:29.269] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:16:0)
[18:41:29.320] Build status: STARTED
[18:41:29.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:17:0) after 8m11s
[18:49:40.348] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:17:0)
[18:49:40.370] Build status: STARTED
[18:49:40.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:18:0) after 9m14s
[18:58:54.408] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:18:0)
[18:58:54.432] Build status: STARTED
[18:58:54.432] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8903951484033829824:19:0) after 5m29s
[19:01:41.992] Received PubSub notification, asking Buildbucket for the build status
[19:01:42.025] Build:
{
"id": "8738521422139618113",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-26T17:32:58.547197898Z",
"startTime": "2024-08-26T17:33:02.372023986Z",
"endTime": "2024-08-26T19:01:41.557907827Z",
"updateTime": "2024-08-26T19:01:41.557907827Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ec4d5a6658782b4a88c634d5b332c56b754c5949",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:01:42.025] Invocation finished in 1h28m44.667471745s with status SUCCEEDED