[01:22:02.779] New invocation is queued and will start shortly
[01:22:03.904] Starting the invocation (attempt 1)
[01:22:03.929] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c05230c03acdef896dd7cd861950682167ff97f1"
[01:22:03.929] Popped gitiles commit info from properties and tags
[01:22:03.929] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:22:03.929] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:22:03.930] Buildbucket request:
{
"requestId": "8841319467644924720",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8841319467644924720",
"job": "chromium-m150/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b65c00c4357e5ffcd169e79117439e320b1d067c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@b65c00c4357e5ffcd169e79117439e320b1d067c",
"title": "b65c00c4357e5ffcd169e79117439e320b1d067c",
"url": "https://chromium.googlesource.com/chromium/src/+/b65c00c4357e5ffcd169e79117439e320b1d067c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "06fde94ae233a87932e53dfae7c9d470e1f866e8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@06fde94ae233a87932e53dfae7c9d470e1f866e8",
"title": "06fde94ae233a87932e53dfae7c9d470e1f866e8",
"url": "https://chromium.googlesource.com/chromium/src/+/06fde94ae233a87932e53dfae7c9d470e1f866e8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0f72a8eea7da98126a488c71231898829ce7b73c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@0f72a8eea7da98126a488c71231898829ce7b73c",
"title": "0f72a8eea7da98126a488c71231898829ce7b73c",
"url": "https://chromium.googlesource.com/chromium/src/+/0f72a8eea7da98126a488c71231898829ce7b73c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a3992ee1c3cefdf562865b01f8a8419b5dbd6047"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@a3992ee1c3cefdf562865b01f8a8419b5dbd6047",
"title": "a3992ee1c3cefdf562865b01f8a8419b5dbd6047",
"url": "https://chromium.googlesource.com/chromium/src/+/a3992ee1c3cefdf562865b01f8a8419b5dbd6047"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "68d83c8a85e1906a7f582e49f0014795f9e06a8f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@68d83c8a85e1906a7f582e49f0014795f9e06a8f",
"title": "68d83c8a85e1906a7f582e49f0014795f9e06a8f",
"url": "https://chromium.googlesource.com/chromium/src/+/68d83c8a85e1906a7f582e49f0014795f9e06a8f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5c9543d683db15975693d66008308d6890e6de3c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@5c9543d683db15975693d66008308d6890e6de3c",
"title": "5c9543d683db15975693d66008308d6890e6de3c",
"url": "https://chromium.googlesource.com/chromium/src/+/5c9543d683db15975693d66008308d6890e6de3c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5097eb99075d510f5e330430590b9a58ee49a4f0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@5097eb99075d510f5e330430590b9a58ee49a4f0",
"title": "5097eb99075d510f5e330430590b9a58ee49a4f0",
"url": "https://chromium.googlesource.com/chromium/src/+/5097eb99075d510f5e330430590b9a58ee49a4f0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "35f19118ac01361ffa5175a1505b38a41cf0b2b0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@35f19118ac01361ffa5175a1505b38a41cf0b2b0",
"title": "35f19118ac01361ffa5175a1505b38a41cf0b2b0",
"url": "https://chromium.googlesource.com/chromium/src/+/35f19118ac01361ffa5175a1505b38a41cf0b2b0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0c08a6d9bb1e5a4d1f56fc562e05aa8994d88046"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@0c08a6d9bb1e5a4d1f56fc562e05aa8994d88046",
"title": "0c08a6d9bb1e5a4d1f56fc562e05aa8994d88046",
"url": "https://chromium.googlesource.com/chromium/src/+/0c08a6d9bb1e5a4d1f56fc562e05aa8994d88046"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "369f450e906f77a66dd7af6c24c94001fb0cf47c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@369f450e906f77a66dd7af6c24c94001fb0cf47c",
"title": "369f450e906f77a66dd7af6c24c94001fb0cf47c",
"url": "https://chromium.googlesource.com/chromium/src/+/369f450e906f77a66dd7af6c24c94001fb0cf47c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c05230c03acdef896dd7cd861950682167ff97f1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@c05230c03acdef896dd7cd861950682167ff97f1",
"title": "c05230c03acdef896dd7cd861950682167ff97f1",
"url": "https://chromium.googlesource.com/chromium/src/+/c05230c03acdef896dd7cd861950682167ff97f1"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c05230c03acdef896dd7cd861950682167ff97f1",
"ref": "refs/branch-heads/7871"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8841319467644924720"
},
{
"key": "scheduler_job_id",
"value": "chromium-m150/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:22:04.532] Scheduled build:
{
"id": "8675889405707296593",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "mac-official"
},
"number": 283,
"createdBy": "project:chromium-m150",
"createTime": "2026-07-19T01:22:04.003069443Z",
"updateTime": "2026-07-19T01:22:04.003069443Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c05230c03acdef896dd7cd861950682167ff97f1",
"ref": "refs/branch-heads/7871"
}
}
}
[01:22:04.532] Task URL: https://cr-buildbucket.appspot.com/build/8675889405707296593
[01:22:04.532] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:2:0) after 9m12s
[01:22:05.453] Received PubSub notification, asking Buildbucket for the build status
[01:22:05.484] Build status: SCHEDULED
[01:22:09.903] Received PubSub notification, asking Buildbucket for the build status
[01:22:09.918] Build status: STARTED
[01:31:16.782] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:2:0)
[01:31:16.805] Build status: STARTED
[01:31:16.805] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:5:0) after 3m31s
[01:34:47.934] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:5:0)
[01:34:47.951] Build status: STARTED
[01:34:47.951] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:6:0) after 8m0s
[01:42:47.950] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:6:0)
[01:42:48.012] Build status: STARTED
[01:42:48.013] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:7:0) after 8m23s
[01:51:11.065] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:7:0)
[01:51:11.216] Build status: STARTED
[01:51:11.216] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:8:0) after 8m54s
[02:00:05.287] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:8:0)
[02:00:05.309] Build status: STARTED
[02:00:05.310] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:9:0) after 7m17s
[02:07:22.369] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:9:0)
[02:07:22.388] Build status: STARTED
[02:07:22.388] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:10:0) after 9m20s
[02:16:42.370] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:10:0)
[02:16:42.389] Build status: STARTED
[02:16:42.389] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:11:0) after 8m14s
[02:24:56.405] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:11:0)
[02:24:56.418] Build status: STARTED
[02:24:56.418] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:12:0) after 4m11s
[02:29:07.434] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:12:0)
[02:29:07.464] Build status: STARTED
[02:29:07.464] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:13:0) after 5m40s
[02:34:47.536] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:13:0)
[02:34:47.555] Build status: STARTED
[02:34:47.555] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:14:0) after 9m29s
[02:44:16.574] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:14:0)
[02:44:16.595] Build status: STARTED
[02:44:16.595] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:15:0) after 4m46s
[02:49:02.612] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:15:0)
[02:49:02.629] Build status: STARTED
[02:49:02.629] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:16:0) after 2m34s
[02:51:36.786] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:16:0)
[02:51:36.806] Build status: STARTED
[02:51:36.806] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:17:0) after 1m33s
[02:53:09.827] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:17:0)
[02:53:09.858] Build status: STARTED
[02:53:09.858] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:18:0) after 4m23s
[02:57:32.857] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:18:0)
[02:57:33.099] Build status: STARTED
[02:57:33.099] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:19:0) after 6m44s
[03:04:17.114] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:19:0)
[03:04:17.133] Build status: STARTED
[03:04:17.133] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:20:0) after 2m4s
[03:06:21.173] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:20:0)
[03:06:21.196] Build status: STARTED
[03:06:21.196] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:21:0) after 1m52s
[03:08:13.216] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:21:0)
[03:08:13.242] Build status: STARTED
[03:08:13.242] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:22:0) after 5m36s
[03:13:49.311] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:22:0)
[03:13:49.332] Build status: STARTED
[03:13:49.332] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:23:0) after 6m2s
[03:19:51.349] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:23:0)
[03:19:51.368] Build status: STARTED
[03:19:51.368] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:24:0) after 5m42s
[03:25:33.429] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:24:0)
[03:25:33.482] Build status: STARTED
[03:25:33.482] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:25:0) after 6m34s
[03:32:07.497] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:25:0)
[03:32:07.516] Build status: STARTED
[03:32:07.516] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:26:0) after 9m38s
[03:41:45.534] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:26:0)
[03:41:45.562] Build status: STARTED
[03:41:45.562] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:27:0) after 9m8s
[03:50:53.577] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:27:0)
[03:50:53.593] Build status: STARTED
[03:50:53.593] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:28:0) after 4m50s
[03:55:43.573] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:28:0)
[03:55:43.592] Build status: STARTED
[03:55:43.592] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:29:0) after 4m17s
[04:00:00.804] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:29:0)
[04:00:00.829] Build status: STARTED
[04:00:00.829] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:30:0) after 7m55s
[04:07:56.070] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:30:0)
[04:07:56.087] Build status: STARTED
[04:07:56.087] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:31:0) after 5m38s
[04:13:34.150] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:31:0)
[04:13:34.168] Build status: STARTED
[04:13:34.168] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:32:0) after 2m58s
[04:16:32.151] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:32:0)
[04:16:32.218] Build status: STARTED
[04:16:32.218] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:33:0) after 1m27s
[04:17:59.305] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:33:0)
[04:17:59.319] Build status: STARTED
[04:17:59.319] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:34:0) after 5m58s
[04:23:57.738] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:34:0)
[04:23:57.763] Build status: STARTED
[04:23:57.763] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:35:0) after 2m59s
[04:26:57.458] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:35:0)
[04:26:57.534] Build status: STARTED
[04:26:57.534] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:36:0) after 9m47s
[04:36:44.888] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:36:0)
[04:36:44.909] Build status: STARTED
[04:36:44.909] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:37:0) after 3m37s
[04:40:22.369] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:37:0)
[04:40:22.388] Build status: STARTED
[04:40:22.388] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:38:0) after 5m58s
[04:46:20.402] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:38:0)
[04:46:20.427] Build status: STARTED
[04:46:20.427] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:39:0) after 1m23s
[04:47:43.444] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:39:0)
[04:47:43.467] Build status: STARTED
[04:47:43.467] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:40:0) after 3m46s
[04:51:29.886] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:40:0)
[04:51:29.900] Build status: STARTED
[04:51:29.900] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:41:0) after 2m36s
[04:54:06.019] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:41:0)
[04:54:06.062] Build status: STARTED
[04:54:06.062] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:42:0) after 5m20s
[04:59:26.076] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:42:0)
[04:59:26.118] Build status: STARTED
[04:59:26.118] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:43:0) after 1m8s
[05:00:34.141] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:43:0)
[05:00:34.160] Build status: STARTED
[05:00:34.160] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:44:0) after 3m31s
[05:04:05.217] Handling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:44:0)
[05:04:05.236] Build status: STARTED
[05:04:05.236] Scheduling timer "check-buildbucket-build-status" (chromium-m150/mac-official:8841319467644924720:45:0) after 7m20s
[05:05:17.363] Received PubSub notification, asking Buildbucket for the build status
[05:05:17.384] Build:
{
"id": "8675889405707296593",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "mac-official"
},
"number": 283,
"createdBy": "project:chromium-m150",
"createTime": "2026-07-19T01:22:04.003069443Z",
"startTime": "2026-07-19T01:22:09.016726257Z",
"endTime": "2026-07-19T05:05:17.107579512Z",
"updateTime": "2026-07-19T05:05:17.107579512Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c05230c03acdef896dd7cd861950682167ff97f1",
"ref": "refs/branch-heads/7871"
}
}
}
[05:05:17.384] Invocation finished in 3h43m14.611421516s with status SUCCEEDED