[02:54:39.091] New invocation is queued and will start shortly
[02:54:39.091] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[02:54:40.233] Starting the invocation (attempt 1)
[02:54:40.319] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/84277fe90f98edfa8fb7b7f06ab430610ef85248"
[02:54:40.319] Reconstructed gitiles commit from tags
[02:54:40.319] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:54:40.319] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:54:40.320] Buildbucket request:
{
"requestId": "8921582553659822912",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ea4c8ff3e3bdfd072f28d7831739800f4e830b79b564a50f3fdae75e56ca505d/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01019d57b469fab6a18814f115763ca0e7abb676",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8921582553659822912",
"job": "fuchsia/clang_toolchain.prod.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ea4c8ff3e3bdfd072f28d7831739800f4e830b79b564a50f3fdae75e56ca505d/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01019d57b469fab6a18814f115763ca0e7abb676",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "84277fe90f98edfa8fb7b7f06ab430610ef85248"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/84277fe90f98edfa8fb7b7f06ab430610ef85248",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "6b8b5ff6-128a-4eb1-93a6-818082790806",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "84277fe90f98edfa8fb7b7f06ab430610ef85248"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "84277fe90f98edfa8fb7b7f06ab430610ef85248",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8921582553659822912"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.prod.core.x64-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"
}
}
[02:54:40.783] Scheduled build:
{
"id": "8756152491641369041",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-14T02:54:40.393366708Z",
"updateTime": "2024-02-14T02:54:40.393366708Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "84277fe90f98edfa8fb7b7f06ab430610ef85248",
"ref": "refs/heads/main"
}
}
}
[02:54:40.783] Task URL: https://cr-buildbucket.appspot.com/build/8756152491641369041
[02:54:40.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:2:0) after 5m52s
[02:54:41.721] Received PubSub notification, asking Buildbucket for the build status
[02:54:41.759] Build status: STARTED
[02:54:42.394] Received PubSub notification, asking Buildbucket for the build status
[02:54:42.436] Build status: STARTED
[03:00:32.899] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:2:0)
[03:00:32.923] Build status: STARTED
[03:00:32.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:5:0) after 6m39s
[03:07:11.938] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:5:0)
[03:07:11.960] Build status: STARTED
[03:07:11.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:6:0) after 5m32s
[03:12:44.064] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:6:0)
[03:12:44.088] Build status: STARTED
[03:12:44.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:7:0) after 3m44s
[03:16:28.201] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:7:0)
[03:16:28.224] Build status: STARTED
[03:16:28.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:8:0) after 8m33s
[03:25:01.488] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:8:0)
[03:25:01.516] Build status: STARTED
[03:25:01.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:9:0) after 1m11s
[03:26:12.616] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:9:0)
[03:26:12.635] Build status: STARTED
[03:26:12.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:10:0) after 6m10s
[03:32:22.930] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:10:0)
[03:32:22.948] Build status: STARTED
[03:32:22.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:11:0) after 3m18s
[03:35:41.092] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:11:0)
[03:35:41.157] Build status: STARTED
[03:35:41.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:12:0) after 7m59s
[03:43:40.279] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:12:0)
[03:43:40.305] Build status: STARTED
[03:43:40.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:13:0) after 3m50s
[03:47:30.362] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:13:0)
[03:47:30.386] Build status: STARTED
[03:47:30.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:14:0) after 6m55s
[03:54:25.609] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:14:0)
[03:54:25.633] Build status: STARTED
[03:54:25.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:15:0) after 5m6s
[03:59:31.759] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:15:0)
[03:59:31.816] Build status: STARTED
[03:59:31.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:16:0) after 1m38s
[04:01:09.840] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:16:0)
[04:01:09.880] Build status: STARTED
[04:01:09.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:17:0) after 2m54s
[04:04:04.199] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:17:0)
[04:04:04.220] Build status: STARTED
[04:04:04.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:18:0) after 7m47s
[04:11:51.218] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:18:0)
[04:11:51.239] Build status: STARTED
[04:11:51.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:19:0) after 3m36s
[04:15:27.368] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:19:0)
[04:15:27.403] Build status: STARTED
[04:15:27.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:20:0) after 2m56s
[04:18:23.419] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:20:0)
[04:18:23.450] Build status: STARTED
[04:18:23.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:21:0) after 4m19s
[04:22:42.702] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:21:0)
[04:22:42.721] Build status: STARTED
[04:22:42.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:22:0) after 1m33s
[04:24:15.905] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:22:0)
[04:24:15.978] Build status: STARTED
[04:24:15.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:23:0) after 3m28s
[04:27:44.096] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:23:0)
[04:27:44.118] Build status: STARTED
[04:27:44.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:24:0) after 8m48s
[04:36:32.133] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:24:0)
[04:36:32.165] Build status: STARTED
[04:36:32.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8921582553659822912:25:0) after 5m20s
[04:39:46.203] Received PubSub notification, asking Buildbucket for the build status
[04:39:46.220] Build:
{
"id": "8756152491641369041",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-14T02:54:40.393366708Z",
"startTime": "2024-02-14T02:54:41.234532Z",
"endTime": "2024-02-14T04:39:45.134153Z",
"updateTime": "2024-02-14T04:39:45.134153Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "84277fe90f98edfa8fb7b7f06ab430610ef85248",
"ref": "refs/heads/main"
}
}
}
[04:39:46.220] Invocation finished in 1h45m7.136166874s with status SUCCEEDED