[07:34:54.320] New invocation is queued and will start shortly
[07:34:54.320] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[07:34:55.456] Starting the invocation (attempt 1)
[07:34:55.481] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3583d40b3c340a5cac8889a0afe33a08a1e02d26"
[07:34:55.481] Reconstructed gitiles commit from tags
[07:34:55.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:34:55.482] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:34:55.483] Buildbucket request:
{
"requestId": "8934973272647196144",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e8543f2721801c4cddf6584bd8c8f6022dab1fd9b092fc630bf214d2c1a018eb/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "8f9b3efe4f4ee22eb005a6baffa89c5af165bb88",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934973272647196144",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "3f1bb9539bcec59bb175b582bad55be2622be4d768007ffd37ee70f4b2815ac7/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b08ec3fddc39ff4273c152bfee946795fb40f64a",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "af935cf0ee8a26dcf0860ed0c72d74b4a1cb1314"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/af935cf0ee8a26dcf0860ed0c72d74b4a1cb1314",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "eade60de-410b-4f97-9caf-d7cfa82ea3ef",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d1a80b2b1a64c7126245e7e60114ac9901024a3d545ed82ed4bfe892da68316e/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b08ec3fddc39ff4273c152bfee946795fb40f64a",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1328a8534bf85ba820ffb6d97e8520aa2aa13788"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1328a8534bf85ba820ffb6d97e8520aa2aa13788",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f1a19e71-b442-4ed8-af41-386c14fb232b",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e8543f2721801c4cddf6584bd8c8f6022dab1fd9b092fc630bf214d2c1a018eb/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "8f9b3efe4f4ee22eb005a6baffa89c5af165bb88",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3583d40b3c340a5cac8889a0afe33a08a1e02d26"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3583d40b3c340a5cac8889a0afe33a08a1e02d26",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "b3007294-e70d-41eb-9897-f41ada1eb796",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3583d40b3c340a5cac8889a0afe33a08a1e02d26"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3583d40b3c340a5cac8889a0afe33a08a1e02d26",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934973272647196144"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:34:55.986] Scheduled build:
{
"id": "8769543210714603601",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-19T07:34:55.534436728Z",
"updateTime": "2023-09-19T07:34:55.534436728Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3583d40b3c340a5cac8889a0afe33a08a1e02d26",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:34:55.986] Task URL: https://cr-buildbucket.appspot.com/build/8769543210714603601
[07:34:55.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:2:0) after 7m36s
[07:34:58.876] Received PubSub notification, asking Buildbucket for the build status
[07:34:58.893] Build status: STARTED
[07:35:00.561] Received PubSub notification, asking Buildbucket for the build status
[07:35:00.601] Build status: STARTED
[07:42:32.104] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:2:0)
[07:42:32.132] Build status: STARTED
[07:42:32.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:5:0) after 9m59s
[07:52:31.240] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:5:0)
[07:52:31.266] Build status: STARTED
[07:52:31.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:6:0) after 1m9s
[07:53:40.488] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:6:0)
[07:53:40.538] Build status: STARTED
[07:53:40.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:7:0) after 9m0s
[08:02:40.553] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:7:0)
[08:02:40.618] Build status: STARTED
[08:02:40.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:8:0) after 3m40s
[08:06:20.756] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:8:0)
[08:06:20.884] Build status: STARTED
[08:06:20.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:9:0) after 5m44s
[08:12:04.868] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:9:0)
[08:12:04.886] Build status: STARTED
[08:12:04.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:10:0) after 2m0s
[08:14:04.902] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:10:0)
[08:14:04.926] Build status: STARTED
[08:14:04.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:11:0) after 7m36s
[08:21:41.002] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:11:0)
[08:21:41.018] Build status: STARTED
[08:21:41.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:12:0) after 9m25s
[08:31:06.115] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:12:0)
[08:31:06.149] Build status: STARTED
[08:31:06.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:13:0) after 2m48s
[08:33:54.424] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:13:0)
[08:33:54.448] Build status: STARTED
[08:33:54.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:14:0) after 3m20s
[08:37:14.462] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:14:0)
[08:37:14.486] Build status: STARTED
[08:37:14.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:15:0) after 3m4s
[08:40:19.266] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:15:0)
[08:40:19.285] Build status: STARTED
[08:40:19.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:16:0) after 2m57s
[08:43:16.302] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:16:0)
[08:43:16.360] Build status: STARTED
[08:43:16.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:17:0) after 1m24s
[08:44:40.342] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:17:0)
[08:44:40.364] Build status: STARTED
[08:44:40.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:18:0) after 9m16s
[08:53:56.385] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:18:0)
[08:53:56.417] Build status: STARTED
[08:53:56.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:19:0) after 1m13s
[08:55:09.531] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:19:0)
[08:55:09.565] Build status: STARTED
[08:55:09.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:20:0) after 6m45s
[09:01:54.588] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:20:0)
[09:01:54.611] Build status: STARTED
[09:01:54.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:21:0) after 3m13s
[09:05:07.750] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:21:0)
[09:05:07.812] Build status: STARTED
[09:05:07.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:22:0) after 7m38s
[09:12:46.315] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:22:0)
[09:12:46.335] Build status: STARTED
[09:12:46.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:23:0) after 5m10s
[09:17:56.508] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:23:0)
[09:17:56.529] Build status: STARTED
[09:17:56.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:24:0) after 5m47s
[09:23:43.691] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:24:0)
[09:23:43.716] Build status: STARTED
[09:23:43.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:25:0) after 2m23s
[09:26:06.738] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:25:0)
[09:26:06.759] Build status: STARTED
[09:26:06.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:26:0) after 2m48s
[09:28:54.774] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:26:0)
[09:28:54.812] Build status: STARTED
[09:28:54.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:27:0) after 2m9s
[09:31:03.830] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:27:0)
[09:31:03.882] Build status: STARTED
[09:31:03.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:28:0) after 3m23s
[09:34:27.261] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:28:0)
[09:34:27.283] Build status: STARTED
[09:34:27.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8934973272647196144:29:0) after 8m7s
[09:35:42.286] Received PubSub notification, asking Buildbucket for the build status
[09:35:42.315] Build:
{
"id": "8769543210714603601",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-19T07:34:55.534436728Z",
"startTime": "2023-09-19T07:34:56.955668Z",
"endTime": "2023-09-19T09:35:40.250081901Z",
"updateTime": "2023-09-19T09:35:40.250081901Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3583d40b3c340a5cac8889a0afe33a08a1e02d26",
"ref": "refs/heads/main"
}
},
"canary": true
}
[09:35:42.315] Invocation finished in 2h0m48.00677621s with status SUCCEEDED