[17:42:53.520] New invocation is queued and will start shortly
[17:42:54.771] Starting the invocation (attempt 1)
[17:42:54.796] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/aea452841b6448c20f2f5e4ac928f79d99963e04"
[17:42:54.796] Popped gitiles commit info from properties and tags
[17:42:54.796] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:42:54.796] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:42:54.797] Buildbucket request:
{
"requestId": "8936746960757053520",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936746960757053520",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c9988f85d2508bdbc64c81fed7c4b9b8db54262"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c9988f85d2508bdbc64c81fed7c4b9b8db54262",
"title": "3c9988f85d2508bdbc64c81fed7c4b9b8db54262",
"url": "https://llvm.googlesource.com/llvm-project/+/3c9988f85d2508bdbc64c81fed7c4b9b8db54262"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "651b2fbc1c7ec4992d2c80b8456c5c5a72394caf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@651b2fbc1c7ec4992d2c80b8456c5c5a72394caf",
"title": "651b2fbc1c7ec4992d2c80b8456c5c5a72394caf",
"url": "https://llvm.googlesource.com/llvm-project/+/651b2fbc1c7ec4992d2c80b8456c5c5a72394caf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9db799dda6928d52baad51802c4315a0312e69d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9db799dda6928d52baad51802c4315a0312e69d",
"title": "c9db799dda6928d52baad51802c4315a0312e69d",
"url": "https://llvm.googlesource.com/llvm-project/+/c9db799dda6928d52baad51802c4315a0312e69d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f93aa1c6574f967e993fc378d0805bcc0e44c38e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f93aa1c6574f967e993fc378d0805bcc0e44c38e",
"title": "f93aa1c6574f967e993fc378d0805bcc0e44c38e",
"url": "https://llvm.googlesource.com/llvm-project/+/f93aa1c6574f967e993fc378d0805bcc0e44c38e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "acc572f490fb0884d55a121053ae8cc515df0a2f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@acc572f490fb0884d55a121053ae8cc515df0a2f",
"title": "acc572f490fb0884d55a121053ae8cc515df0a2f",
"url": "https://llvm.googlesource.com/llvm-project/+/acc572f490fb0884d55a121053ae8cc515df0a2f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aca23d8ac30d773c1513d1708bdda8149acc075a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aca23d8ac30d773c1513d1708bdda8149acc075a",
"title": "aca23d8ac30d773c1513d1708bdda8149acc075a",
"url": "https://llvm.googlesource.com/llvm-project/+/aca23d8ac30d773c1513d1708bdda8149acc075a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a0aff2d24518b1931a1a333c32a13028a0f88f6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a0aff2d24518b1931a1a333c32a13028a0f88f6",
"title": "0a0aff2d24518b1931a1a333c32a13028a0f88f6",
"url": "https://llvm.googlesource.com/llvm-project/+/0a0aff2d24518b1931a1a333c32a13028a0f88f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb5fe55b810cc186d2ff31b64294b0d666d623da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb5fe55b810cc186d2ff31b64294b0d666d623da",
"title": "eb5fe55b810cc186d2ff31b64294b0d666d623da",
"url": "https://llvm.googlesource.com/llvm-project/+/eb5fe55b810cc186d2ff31b64294b0d666d623da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ef3e27385b165dea20e3383a2c2fa39baeb28290"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ef3e27385b165dea20e3383a2c2fa39baeb28290",
"title": "ef3e27385b165dea20e3383a2c2fa39baeb28290",
"url": "https://llvm.googlesource.com/llvm-project/+/ef3e27385b165dea20e3383a2c2fa39baeb28290"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d944cab731f1077d8e800fb7c1a91e6fb6b3bb14"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d944cab731f1077d8e800fb7c1a91e6fb6b3bb14",
"title": "d944cab731f1077d8e800fb7c1a91e6fb6b3bb14",
"url": "https://llvm.googlesource.com/llvm-project/+/d944cab731f1077d8e800fb7c1a91e6fb6b3bb14"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d3d71b8d5be8d8c2f494044099f9a44ffe18c878"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d3d71b8d5be8d8c2f494044099f9a44ffe18c878",
"title": "d3d71b8d5be8d8c2f494044099f9a44ffe18c878",
"url": "https://llvm.googlesource.com/llvm-project/+/d3d71b8d5be8d8c2f494044099f9a44ffe18c878"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "967d95382d0eac27f1a1387cf2640cdd48bca03e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@967d95382d0eac27f1a1387cf2640cdd48bca03e",
"title": "967d95382d0eac27f1a1387cf2640cdd48bca03e",
"url": "https://llvm.googlesource.com/llvm-project/+/967d95382d0eac27f1a1387cf2640cdd48bca03e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aea452841b6448c20f2f5e4ac928f79d99963e04"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aea452841b6448c20f2f5e4ac928f79d99963e04",
"title": "aea452841b6448c20f2f5e4ac928f79d99963e04",
"url": "https://llvm.googlesource.com/llvm-project/+/aea452841b6448c20f2f5e4ac928f79d99963e04"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "aea452841b6448c20f2f5e4ac928f79d99963e04",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936746960757053520"
},
{
"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:42:55.513] Scheduled build:
{
"id": "8771316898648177329",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-30T17:42:54.907076982Z",
"updateTime": "2023-08-30T17:42:54.907076982Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "aea452841b6448c20f2f5e4ac928f79d99963e04",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:42:55.513] Task URL: https://cr-buildbucket.appspot.com/build/8771316898648177329
[17:42:55.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:2:0) after 2m22s
[17:42:56.458] Received PubSub notification, asking Buildbucket for the build status
[17:42:56.474] Build status: SCHEDULED
[17:43:47.412] Received PubSub notification, asking Buildbucket for the build status
[17:43:47.431] Build status: STARTED
[17:45:17.571] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:2:0)
[17:45:17.593] Build status: STARTED
[17:45:17.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:5:0) after 1m51s
[17:47:08.643] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:5:0)
[17:47:08.662] Build status: STARTED
[17:47:08.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:6:0) after 6m52s
[17:54:00.993] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:6:0)
[17:54:01.020] Build status: STARTED
[17:54:01.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:7:0) after 7m47s
[18:01:48.202] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:7:0)
[18:01:48.225] Build status: STARTED
[18:01:48.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:8:0) after 9m21s
[18:11:09.242] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:8:0)
[18:11:09.272] Build status: STARTED
[18:11:09.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:9:0) after 5m40s
[18:16:49.576] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:9:0)
[18:16:49.676] Build status: STARTED
[18:16:49.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:10:0) after 5m7s
[18:21:56.701] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:10:0)
[18:21:56.742] Build status: STARTED
[18:21:56.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:11:0) after 6m7s
[18:28:03.810] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:11:0)
[18:28:03.830] Build status: STARTED
[18:28:03.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:12:0) after 3m51s
[18:31:54.850] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:12:0)
[18:31:54.876] Build status: STARTED
[18:31:54.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:13:0) after 6m49s
[18:38:44.163] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:13:0)
[18:38:44.185] Build status: STARTED
[18:38:44.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:14:0) after 8m57s
[18:47:41.203] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:14:0)
[18:47:41.223] Build status: STARTED
[18:47:41.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936746960757053520:15:0) after 7m2s
[18:48:25.347] Received PubSub notification, asking Buildbucket for the build status
[18:48:25.368] Build:
{
"id": "8771316898648177329",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-30T17:42:54.907076982Z",
"startTime": "2023-08-30T17:43:46.679907Z",
"endTime": "2023-08-30T18:48:24.881004699Z",
"updateTime": "2023-08-30T18:48:24.881004699Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "aea452841b6448c20f2f5e4ac928f79d99963e04",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:48:25.368] Invocation finished in 1h5m31.856260818s with status SUCCEEDED