[18:58:20.651] New invocation is queued and will start shortly
[18:58:21.980] Starting the invocation (attempt 1)
[18:58:22.007] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5dd2b20deb7fb044181cd05bf0d7a10f508327c7"
[18:58:22.007] Popped gitiles commit info from properties and tags
[18:58:22.007] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:58:22.007] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:58:22.008] Buildbucket request:
{
"requestId": "8888544627600788976",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888544627600788976",
"job": "chromium-m134/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d1108e7696f21e0e461e14d79b32ad73e390dfa3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@d1108e7696f21e0e461e14d79b32ad73e390dfa3",
"title": "d1108e7696f21e0e461e14d79b32ad73e390dfa3",
"url": "https://chromium.googlesource.com/chromium/src/+/d1108e7696f21e0e461e14d79b32ad73e390dfa3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "48936a3380578b1c61f587f361454ed32e2793da"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@48936a3380578b1c61f587f361454ed32e2793da",
"title": "48936a3380578b1c61f587f361454ed32e2793da",
"url": "https://chromium.googlesource.com/chromium/src/+/48936a3380578b1c61f587f361454ed32e2793da"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8169e370fce665f3cea34a67cf4c529065c64eba"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@8169e370fce665f3cea34a67cf4c529065c64eba",
"title": "8169e370fce665f3cea34a67cf4c529065c64eba",
"url": "https://chromium.googlesource.com/chromium/src/+/8169e370fce665f3cea34a67cf4c529065c64eba"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d714bf7ca05022a6fe0874796eb8c4db3f4150b7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@d714bf7ca05022a6fe0874796eb8c4db3f4150b7",
"title": "d714bf7ca05022a6fe0874796eb8c4db3f4150b7",
"url": "https://chromium.googlesource.com/chromium/src/+/d714bf7ca05022a6fe0874796eb8c4db3f4150b7"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "90e9e1e7626cba0a42c97f6130180f18a84510e8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@90e9e1e7626cba0a42c97f6130180f18a84510e8",
"title": "90e9e1e7626cba0a42c97f6130180f18a84510e8",
"url": "https://chromium.googlesource.com/chromium/src/+/90e9e1e7626cba0a42c97f6130180f18a84510e8"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ddeb011bacc10b27aff67a0d0c7860f21a2bbe9b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@ddeb011bacc10b27aff67a0d0c7860f21a2bbe9b",
"title": "ddeb011bacc10b27aff67a0d0c7860f21a2bbe9b",
"url": "https://chromium.googlesource.com/chromium/src/+/ddeb011bacc10b27aff67a0d0c7860f21a2bbe9b"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "990bece3262a21b833e9c11a59d756c389c0d9ea"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@990bece3262a21b833e9c11a59d756c389c0d9ea",
"title": "990bece3262a21b833e9c11a59d756c389c0d9ea",
"url": "https://chromium.googlesource.com/chromium/src/+/990bece3262a21b833e9c11a59d756c389c0d9ea"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9166cb463269ef633c8d474a7b7f564bdde745b3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@9166cb463269ef633c8d474a7b7f564bdde745b3",
"title": "9166cb463269ef633c8d474a7b7f564bdde745b3",
"url": "https://chromium.googlesource.com/chromium/src/+/9166cb463269ef633c8d474a7b7f564bdde745b3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "af709223e7a456c54713675874dfc4d15a966ad5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@af709223e7a456c54713675874dfc4d15a966ad5",
"title": "af709223e7a456c54713675874dfc4d15a966ad5",
"url": "https://chromium.googlesource.com/chromium/src/+/af709223e7a456c54713675874dfc4d15a966ad5"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2adf7007bfed19ff5b1378a4abde6112effe6ff3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@2adf7007bfed19ff5b1378a4abde6112effe6ff3",
"title": "2adf7007bfed19ff5b1378a4abde6112effe6ff3",
"url": "https://chromium.googlesource.com/chromium/src/+/2adf7007bfed19ff5b1378a4abde6112effe6ff3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5dd2b20deb7fb044181cd05bf0d7a10f508327c7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@5dd2b20deb7fb044181cd05bf0d7a10f508327c7",
"title": "5dd2b20deb7fb044181cd05bf0d7a10f508327c7",
"url": "https://chromium.googlesource.com/chromium/src/+/5dd2b20deb7fb044181cd05bf0d7a10f508327c7"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5dd2b20deb7fb044181cd05bf0d7a10f508327c7",
"ref": "refs/branch-heads/6998"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888544627600788976"
},
{
"key": "scheduler_job_id",
"value": "chromium-m134/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:58:22.484] Scheduled build:
{
"id": "8723114565447112497",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "mac-official"
},
"number": 62,
"createdBy": "project:chromium-m134",
"createTime": "2025-02-12T18:58:22.071393752Z",
"updateTime": "2025-02-12T18:58:22.071393752Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5dd2b20deb7fb044181cd05bf0d7a10f508327c7",
"ref": "refs/branch-heads/6998"
}
}
}
[18:58:22.484] Task URL: https://cr-buildbucket.appspot.com/build/8723114565447112497
[18:58:22.484] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:2:0) after 2m29s
[18:58:23.460] Received PubSub notification, asking Buildbucket for the build status
[18:58:23.498] Build status: SCHEDULED
[19:00:51.502] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:2:0)
[19:00:51.591] Build status: SCHEDULED
[19:00:51.591] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:4:0) after 8m51s
[19:05:27.676] Received PubSub notification, asking Buildbucket for the build status
[19:05:27.699] Build status: STARTED
[19:09:42.616] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:4:0)
[19:09:42.639] Build status: STARTED
[19:09:42.639] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:6:0) after 7m20s
[19:17:02.662] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:6:0)
[19:17:02.684] Build status: STARTED
[19:17:02.684] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:7:0) after 2m5s
[19:19:07.666] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:7:0)
[19:19:07.697] Build status: STARTED
[19:19:07.697] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:8:0) after 9m35s
[19:28:42.747] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:8:0)
[19:28:42.832] Build status: STARTED
[19:28:42.832] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:9:0) after 4m8s
[19:32:50.843] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:9:0)
[19:32:50.867] Build status: STARTED
[19:32:50.867] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:10:0) after 2m29s
[19:35:19.972] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:10:0)
[19:35:20.057] Build status: STARTED
[19:35:20.057] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:11:0) after 4m6s
[19:39:26.222] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:11:0)
[19:39:26.241] Build status: STARTED
[19:39:26.241] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:12:0) after 3m50s
[19:43:16.301] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:12:0)
[19:43:16.325] Build status: STARTED
[19:43:16.326] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:13:0) after 7m17s
[19:50:33.398] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:13:0)
[19:50:33.414] Build status: STARTED
[19:50:33.414] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:14:0) after 6m23s
[19:56:56.475] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:14:0)
[19:56:56.499] Build status: STARTED
[19:56:56.499] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:15:0) after 9m47s
[20:06:43.589] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:15:0)
[20:06:43.604] Build status: STARTED
[20:06:43.604] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:16:0) after 2m44s
[20:09:27.623] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:16:0)
[20:09:27.649] Build status: STARTED
[20:09:27.649] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:17:0) after 4m53s
[20:14:20.716] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:17:0)
[20:14:20.737] Build status: STARTED
[20:14:20.737] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:18:0) after 3m56s
[20:18:16.761] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:18:0)
[20:18:16.781] Build status: STARTED
[20:18:16.781] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:19:0) after 1m44s
[20:20:00.806] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:19:0)
[20:20:00.821] Build status: STARTED
[20:20:00.821] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:20:0) after 6m17s
[20:26:17.837] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:20:0)
[20:26:17.853] Build status: STARTED
[20:26:17.853] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:21:0) after 2m13s
[20:28:30.897] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:21:0)
[20:28:30.912] Build status: STARTED
[20:28:30.912] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:22:0) after 7m13s
[20:35:43.940] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:22:0)
[20:35:43.960] Build status: STARTED
[20:35:43.960] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:23:0) after 1m44s
[20:37:28.018] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:23:0)
[20:37:28.044] Build status: STARTED
[20:37:28.044] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:24:0) after 9m14s
[20:46:42.072] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:24:0)
[20:46:42.131] Build status: STARTED
[20:46:42.132] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:25:0) after 5m57s
[20:52:39.223] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:25:0)
[20:52:39.251] Build status: STARTED
[20:52:39.251] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:26:0) after 1m33s
[20:54:12.317] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:26:0)
[20:54:12.335] Build status: STARTED
[20:54:12.336] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:27:0) after 9m31s
[21:03:43.420] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:27:0)
[21:03:43.437] Build status: STARTED
[21:03:43.437] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:28:0) after 8m4s
[21:11:47.466] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:28:0)
[21:11:47.487] Build status: STARTED
[21:11:47.487] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:29:0) after 7m3s
[21:18:50.575] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:29:0)
[21:18:50.604] Build status: STARTED
[21:18:50.604] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:30:0) after 5m9s
[21:23:59.667] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:30:0)
[21:23:59.695] Build status: STARTED
[21:23:59.695] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:31:0) after 3m32s
[21:27:31.805] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:31:0)
[21:27:31.832] Build status: STARTED
[21:27:31.832] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:32:0) after 4m22s
[21:31:53.855] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:32:0)
[21:31:53.873] Build status: STARTED
[21:31:53.873] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:33:0) after 3m46s
[21:35:39.897] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:33:0)
[21:35:39.994] Build status: STARTED
[21:35:39.994] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:34:0) after 1m52s
[21:37:32.011] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:34:0)
[21:37:32.029] Build status: STARTED
[21:37:32.029] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:35:0) after 4m15s
[21:41:47.123] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:35:0)
[21:41:47.140] Build status: STARTED
[21:41:47.140] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:36:0) after 2m1s
[21:43:48.162] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:36:0)
[21:43:48.181] Build status: STARTED
[21:43:48.181] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:37:0) after 4m27s
[21:48:15.292] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:37:0)
[21:48:15.337] Build status: STARTED
[21:48:15.337] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:38:0) after 6m45s
[21:55:00.349] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:38:0)
[21:55:00.368] Build status: STARTED
[21:55:00.368] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:39:0) after 1m51s
[21:56:51.577] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:39:0)
[21:56:51.641] Build status: STARTED
[21:56:51.642] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:40:0) after 8m30s
[22:05:21.668] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:40:0)
[22:05:21.682] Build status: STARTED
[22:05:21.682] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:41:0) after 6m12s
[22:11:33.951] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:41:0)
[22:11:33.969] Build status: STARTED
[22:11:33.969] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:42:0) after 3m1s
[22:14:34.985] Handling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:42:0)
[22:14:35.049] Build status: STARTED
[22:14:35.049] Scheduling timer "check-buildbucket-build-status" (chromium-m134/mac-official:8888544627600788976:43:0) after 7m51s
[22:19:43.206] Received PubSub notification, asking Buildbucket for the build status
[22:19:43.227] Build:
{
"id": "8723114565447112497",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "mac-official"
},
"number": 62,
"createdBy": "project:chromium-m134",
"createTime": "2025-02-12T18:58:22.071393752Z",
"startTime": "2025-02-12T19:05:27.478474187Z",
"endTime": "2025-02-12T22:19:42.871445876Z",
"updateTime": "2025-02-12T22:19:42.871445876Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5dd2b20deb7fb044181cd05bf0d7a10f508327c7",
"ref": "refs/branch-heads/6998"
}
}
}
[22:19:43.227] Invocation finished in 3h21m22.592578919s with status SUCCEEDED