[18:45:48.273] New invocation is queued and will start shortly
[18:45:52.387] Starting the invocation (attempt 1)
[18:45:52.426] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9f75270ceb3a0a3fb9b97980031a59652b7d5473"
[18:45:52.426] Popped gitiles commit info from properties and tags
[18:45:52.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:45:52.426] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:45:52.427] Buildbucket request:
{
"requestId": "8906393018902819488",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906393018902819488",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0813260aa88827681da80bedd7f8737ad35c6895"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0813260aa88827681da80bedd7f8737ad35c6895",
"title": "0813260aa88827681da80bedd7f8737ad35c6895",
"url": "https://llvm.googlesource.com/llvm-project/+/0813260aa88827681da80bedd7f8737ad35c6895"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f08df56d3af3e67ab39ebbfb62be3ed3f86d0c9d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f08df56d3af3e67ab39ebbfb62be3ed3f86d0c9d",
"title": "f08df56d3af3e67ab39ebbfb62be3ed3f86d0c9d",
"url": "https://llvm.googlesource.com/llvm-project/+/f08df56d3af3e67ab39ebbfb62be3ed3f86d0c9d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39b6900852e7a1187bd742ba5c1387ca1be58e2c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39b6900852e7a1187bd742ba5c1387ca1be58e2c",
"title": "39b6900852e7a1187bd742ba5c1387ca1be58e2c",
"url": "https://llvm.googlesource.com/llvm-project/+/39b6900852e7a1187bd742ba5c1387ca1be58e2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2acf77f987331c05520c5bfd849326909ffce983"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2acf77f987331c05520c5bfd849326909ffce983",
"title": "2acf77f987331c05520c5bfd849326909ffce983",
"url": "https://llvm.googlesource.com/llvm-project/+/2acf77f987331c05520c5bfd849326909ffce983"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c95abe94aebb6862c3518e590343df3b7376ccee"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c95abe94aebb6862c3518e590343df3b7376ccee",
"title": "c95abe94aebb6862c3518e590343df3b7376ccee",
"url": "https://llvm.googlesource.com/llvm-project/+/c95abe94aebb6862c3518e590343df3b7376ccee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d69d981d77ee2c9aa740e192d81dabb53c7c3cda"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d69d981d77ee2c9aa740e192d81dabb53c7c3cda",
"title": "d69d981d77ee2c9aa740e192d81dabb53c7c3cda",
"url": "https://llvm.googlesource.com/llvm-project/+/d69d981d77ee2c9aa740e192d81dabb53c7c3cda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f3b0f4da0aa5142d7de3e6723538d35c34c9008"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f3b0f4da0aa5142d7de3e6723538d35c34c9008",
"title": "1f3b0f4da0aa5142d7de3e6723538d35c34c9008",
"url": "https://llvm.googlesource.com/llvm-project/+/1f3b0f4da0aa5142d7de3e6723538d35c34c9008"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ea9d3d432350b0f63df61026f4eacdd504adee8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ea9d3d432350b0f63df61026f4eacdd504adee8",
"title": "5ea9d3d432350b0f63df61026f4eacdd504adee8",
"url": "https://llvm.googlesource.com/llvm-project/+/5ea9d3d432350b0f63df61026f4eacdd504adee8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "442c33f3a3545dfbfa4589a92ab4f2981b6b197c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@442c33f3a3545dfbfa4589a92ab4f2981b6b197c",
"title": "442c33f3a3545dfbfa4589a92ab4f2981b6b197c",
"url": "https://llvm.googlesource.com/llvm-project/+/442c33f3a3545dfbfa4589a92ab4f2981b6b197c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5af7086a50249315109f0fabe8aaad344b37ac5a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5af7086a50249315109f0fabe8aaad344b37ac5a",
"title": "5af7086a50249315109f0fabe8aaad344b37ac5a",
"url": "https://llvm.googlesource.com/llvm-project/+/5af7086a50249315109f0fabe8aaad344b37ac5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6992ebcb4b69fc7f116cd475e4731d3877118c1d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6992ebcb4b69fc7f116cd475e4731d3877118c1d",
"title": "6992ebcb4b69fc7f116cd475e4731d3877118c1d",
"url": "https://llvm.googlesource.com/llvm-project/+/6992ebcb4b69fc7f116cd475e4731d3877118c1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb03279ddcc4bb655021101f0038ece2cec3158a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb03279ddcc4bb655021101f0038ece2cec3158a",
"title": "eb03279ddcc4bb655021101f0038ece2cec3158a",
"url": "https://llvm.googlesource.com/llvm-project/+/eb03279ddcc4bb655021101f0038ece2cec3158a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc7aef97bb74b53175365a7fa4137aada902b3f2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc7aef97bb74b53175365a7fa4137aada902b3f2",
"title": "cc7aef97bb74b53175365a7fa4137aada902b3f2",
"url": "https://llvm.googlesource.com/llvm-project/+/cc7aef97bb74b53175365a7fa4137aada902b3f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "51f728376c4c68b0b287e7f6be568607f9a69452"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@51f728376c4c68b0b287e7f6be568607f9a69452",
"title": "51f728376c4c68b0b287e7f6be568607f9a69452",
"url": "https://llvm.googlesource.com/llvm-project/+/51f728376c4c68b0b287e7f6be568607f9a69452"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "99a0a12ad66b64616788619efbe2db52c066fbe2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@99a0a12ad66b64616788619efbe2db52c066fbe2",
"title": "99a0a12ad66b64616788619efbe2db52c066fbe2",
"url": "https://llvm.googlesource.com/llvm-project/+/99a0a12ad66b64616788619efbe2db52c066fbe2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d067062a42b0ce591f03c15cb76fe0fb27d1d9c1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d067062a42b0ce591f03c15cb76fe0fb27d1d9c1",
"title": "d067062a42b0ce591f03c15cb76fe0fb27d1d9c1",
"url": "https://llvm.googlesource.com/llvm-project/+/d067062a42b0ce591f03c15cb76fe0fb27d1d9c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f75270ceb3a0a3fb9b97980031a59652b7d5473"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f75270ceb3a0a3fb9b97980031a59652b7d5473",
"title": "9f75270ceb3a0a3fb9b97980031a59652b7d5473",
"url": "https://llvm.googlesource.com/llvm-project/+/9f75270ceb3a0a3fb9b97980031a59652b7d5473"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9f75270ceb3a0a3fb9b97980031a59652b7d5473",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906393018902819488"
},
{
"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"
}
}
[18:45:52.945] Scheduled build:
{
"id": "8740962953815120657",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-30T18:45:52.496123451Z",
"updateTime": "2024-07-30T18:45:52.496123451Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9f75270ceb3a0a3fb9b97980031a59652b7d5473",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:45:52.945] Task URL: https://cr-buildbucket.appspot.com/build/8740962953815120657
[18:45:52.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:2:0) after 9m21s
[18:45:53.335] Received PubSub notification, asking Buildbucket for the build status
[18:45:53.354] Build status: SCHEDULED
[18:46:00.052] Received PubSub notification, asking Buildbucket for the build status
[18:46:00.080] Build status: STARTED
[18:55:13.973] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:2:0)
[18:55:13.999] Build status: STARTED
[18:55:13.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:5:0) after 6m16s
[19:01:30.015] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:5:0)
[19:01:30.032] Build status: STARTED
[19:01:30.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:6:0) after 1m24s
[19:02:54.123] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:6:0)
[19:02:54.141] Build status: STARTED
[19:02:54.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:7:0) after 4m10s
[19:07:04.164] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:7:0)
[19:07:04.188] Build status: STARTED
[19:07:04.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:8:0) after 4m23s
[19:11:27.206] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:8:0)
[19:11:27.232] Build status: STARTED
[19:11:27.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:9:0) after 6m0s
[19:17:27.272] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:9:0)
[19:17:27.296] Build status: STARTED
[19:17:27.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:10:0) after 8m45s
[19:26:12.413] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:10:0)
[19:26:12.432] Build status: STARTED
[19:26:12.432] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:11:0) after 3m14s
[19:29:26.487] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:11:0)
[19:29:26.511] Build status: STARTED
[19:29:26.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:12:0) after 2m10s
[19:31:36.531] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:12:0)
[19:31:36.558] Build status: STARTED
[19:31:36.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:13:0) after 8m0s
[19:39:36.709] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:13:0)
[19:39:36.745] Build status: STARTED
[19:39:36.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:14:0) after 7m37s
[19:47:13.800] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:14:0)
[19:47:13.823] Build status: STARTED
[19:47:13.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:15:0) after 3m32s
[19:50:45.829] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:15:0)
[19:50:45.849] Build status: STARTED
[19:50:45.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:16:0) after 2m28s
[19:53:13.894] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:16:0)
[19:53:13.931] Build status: STARTED
[19:53:13.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:17:0) after 4m32s
[19:57:46.004] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:17:0)
[19:57:46.022] Build status: STARTED
[19:57:46.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:18:0) after 2m37s
[20:00:23.183] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:18:0)
[20:00:23.199] Build status: STARTED
[20:00:23.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:19:0) after 1m30s
[20:01:53.272] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:19:0)
[20:01:53.350] Build status: STARTED
[20:01:53.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:20:0) after 9m39s
[20:11:32.463] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:20:0)
[20:11:32.482] Build status: STARTED
[20:11:32.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:21:0) after 1m22s
[20:12:54.554] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:21:0)
[20:12:54.572] Build status: STARTED
[20:12:54.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8906393018902819488:22:0) after 4m31s
[20:16:54.042] Received PubSub notification, asking Buildbucket for the build status
[20:16:54.098] Build:
{
"id": "8740962953815120657",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-30T18:45:52.496123451Z",
"startTime": "2024-07-30T18:45:59.832872263Z",
"endTime": "2024-07-30T20:16:53.620720812Z",
"updateTime": "2024-07-30T20:16:53.620720812Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9f75270ceb3a0a3fb9b97980031a59652b7d5473",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:16:54.098] Invocation finished in 1h31m5.838492116s with status SUCCEEDED