[10:46:04.168] New invocation is queued and will start shortly
[10:46:04.168] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[10:46:05.245] Starting the invocation (attempt 1)
[10:46:05.274] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3928edecfbd116d56bbe7411365d50bb567380a1"
[10:46:05.274] Reconstructed gitiles commit from tags
[10:46:05.274] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:46:05.274] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:46:05.274] Buildbucket request:
{
"requestId": "8902618128633962368",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6a11ca584c7832f9878abc2308fb05b6e1b243db9fb3a9989740422947a52ec7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b497e07ea6a704f1e6abd1f722d1cc383fc265d3",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8902618128633962368",
"job": "fuchsia/clang_toolchain.prod.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6a11ca584c7832f9878abc2308fb05b6e1b243db9fb3a9989740422947a52ec7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "b497e07ea6a704f1e6abd1f722d1cc383fc265d3",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3928edecfbd116d56bbe7411365d50bb567380a1"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3928edecfbd116d56bbe7411365d50bb567380a1",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "fa6dca40-75bc-4ea8-8197-e83ae9c0a100",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3928edecfbd116d56bbe7411365d50bb567380a1"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3928edecfbd116d56bbe7411365d50bb567380a1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8902618128633962368"
},
{
"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"
}
}
[10:46:05.839] Scheduled build:
{
"id": "8737188066656966001",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-10T10:46:05.426210122Z",
"updateTime": "2024-09-10T10:46:05.426210122Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3928edecfbd116d56bbe7411365d50bb567380a1",
"ref": "refs/heads/main"
}
}
}
[10:46:05.839] Task URL: https://cr-buildbucket.appspot.com/build/8737188066656966001
[10:46:05.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:2:0) after 4m4s
[10:46:06.771] Received PubSub notification, asking Buildbucket for the build status
[10:46:06.796] Build status: SCHEDULED
[10:46:11.675] Received PubSub notification, asking Buildbucket for the build status
[10:46:11.767] Build status: STARTED
[10:50:09.871] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:2:0)
[10:50:09.902] Build status: STARTED
[10:50:09.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:5:0) after 6m14s
[10:56:24.019] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:5:0)
[10:56:24.045] Build status: STARTED
[10:56:24.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:6:0) after 8m10s
[11:04:34.143] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:6:0)
[11:04:34.174] Build status: STARTED
[11:04:34.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:7:0) after 5m58s
[11:10:32.198] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:7:0)
[11:10:32.215] Build status: STARTED
[11:10:32.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:8:0) after 9m31s
[11:20:03.234] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:8:0)
[11:20:03.385] Build status: STARTED
[11:20:03.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:9:0) after 2m33s
[11:22:36.412] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:9:0)
[11:22:36.435] Build status: STARTED
[11:22:36.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:10:0) after 7m28s
[11:30:04.461] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:10:0)
[11:30:04.478] Build status: STARTED
[11:30:04.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:11:0) after 7m56s
[11:38:00.832] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:11:0)
[11:38:00.864] Build status: STARTED
[11:38:00.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:12:0) after 9m36s
[11:47:37.242] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:12:0)
[11:47:37.264] Build status: STARTED
[11:47:37.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:13:0) after 5m54s
[11:53:31.626] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:13:0)
[11:53:31.692] Build status: STARTED
[11:53:31.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:14:0) after 7m37s
[12:01:08.803] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:14:0)
[12:01:08.859] Build status: STARTED
[12:01:08.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:15:0) after 4m16s
[12:05:25.374] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:15:0)
[12:05:25.462] Build status: STARTED
[12:05:25.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:16:0) after 3m34s
[12:09:00.325] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:16:0)
[12:09:00.343] Build status: STARTED
[12:09:00.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:17:0) after 1m56s
[12:10:56.367] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:17:0)
[12:10:56.387] Build status: STARTED
[12:10:56.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:18:0) after 7m5s
[12:18:01.442] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:18:0)
[12:18:01.461] Build status: STARTED
[12:18:01.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:19:0) after 5m45s
[12:23:46.528] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:19:0)
[12:23:46.548] Build status: STARTED
[12:23:46.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:20:0) after 1m32s
[12:25:18.679] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:20:0)
[12:25:18.702] Build status: STARTED
[12:25:18.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:21:0) after 5m52s
[12:31:10.931] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:21:0)
[12:31:10.954] Build status: STARTED
[12:31:10.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:22:0) after 5m52s
[12:37:02.970] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:22:0)
[12:37:02.991] Build status: STARTED
[12:37:02.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:23:0) after 6m33s
[12:43:36.046] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:23:0)
[12:43:36.063] Build status: STARTED
[12:43:36.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:24:0) after 3m12s
[12:46:48.085] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:24:0)
[12:46:48.162] Build status: STARTED
[12:46:48.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:25:0) after 6m3s
[12:52:51.184] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:25:0)
[12:52:51.210] Build status: STARTED
[12:52:51.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:26:0) after 3m55s
[12:56:46.234] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:26:0)
[12:56:46.258] Build status: STARTED
[12:56:46.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:27:0) after 2m10s
[12:58:56.274] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:27:0)
[12:58:56.291] Build status: STARTED
[12:58:56.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:28:0) after 4m58s
[13:03:54.321] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:28:0)
[13:03:54.364] Build status: STARTED
[13:03:54.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:29:0) after 2m24s
[13:06:18.381] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:29:0)
[13:06:18.449] Build status: STARTED
[13:06:18.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:30:0) after 1m45s
[13:08:03.516] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:30:0)
[13:08:03.544] Build status: STARTED
[13:08:03.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:31:0) after 2m6s
[13:10:09.568] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:31:0)
[13:10:09.593] Build status: STARTED
[13:10:09.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.x64-debug:8902618128633962368:32:0) after 9m51s
[13:19:53.604] Received PubSub notification, asking Buildbucket for the build status
[13:19:53.681] Build:
{
"id": "8737188066656966001",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-10T10:46:05.426210122Z",
"startTime": "2024-09-10T10:46:11.372907373Z",
"endTime": "2024-09-10T13:19:53.099009420Z",
"updateTime": "2024-09-10T13:19:53.099009420Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3928edecfbd116d56bbe7411365d50bb567380a1",
"ref": "refs/heads/main"
}
}
}
[13:19:53.681] Invocation finished in 2h33m49.523486948s with status SUCCEEDED