[08:56:47.225] New invocation is queued and will start shortly
[08:56:48.485] Starting the invocation (attempt 1)
[08:56:48.513] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d8619608a195ef931b75626e8d957e49f54f81c"
[08:56:48.513] Popped gitiles commit info from properties and tags
[08:56:48.513] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:56:48.513] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:56:48.514] Buildbucket request:
{
"requestId": "8843646378951466016",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8843646378951466016",
"job": "chromium-m149/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "db9b0a5f11d0a3c633e5e5f7bb601532f25b0806"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@db9b0a5f11d0a3c633e5e5f7bb601532f25b0806",
"title": "db9b0a5f11d0a3c633e5e5f7bb601532f25b0806",
"url": "https://chromium.googlesource.com/chromium/src/+/db9b0a5f11d0a3c633e5e5f7bb601532f25b0806"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "60a2ba81fadee2fd34ff04e62cfaa43837c857cd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@60a2ba81fadee2fd34ff04e62cfaa43837c857cd",
"title": "60a2ba81fadee2fd34ff04e62cfaa43837c857cd",
"url": "https://chromium.googlesource.com/chromium/src/+/60a2ba81fadee2fd34ff04e62cfaa43837c857cd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "03fb8f3a072e24e5804de40b92f92aeec8b00d2b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@03fb8f3a072e24e5804de40b92f92aeec8b00d2b",
"title": "03fb8f3a072e24e5804de40b92f92aeec8b00d2b",
"url": "https://chromium.googlesource.com/chromium/src/+/03fb8f3a072e24e5804de40b92f92aeec8b00d2b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "99d25b993b5a01511efbfc387c89bb2efdd1758f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@99d25b993b5a01511efbfc387c89bb2efdd1758f",
"title": "99d25b993b5a01511efbfc387c89bb2efdd1758f",
"url": "https://chromium.googlesource.com/chromium/src/+/99d25b993b5a01511efbfc387c89bb2efdd1758f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "70c42dbbcf2d924f4aa1154d41ce545bbd7c33e6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@70c42dbbcf2d924f4aa1154d41ce545bbd7c33e6",
"title": "70c42dbbcf2d924f4aa1154d41ce545bbd7c33e6",
"url": "https://chromium.googlesource.com/chromium/src/+/70c42dbbcf2d924f4aa1154d41ce545bbd7c33e6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "28a53aa0094b99f11cd4b343665ccf084107f780"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@28a53aa0094b99f11cd4b343665ccf084107f780",
"title": "28a53aa0094b99f11cd4b343665ccf084107f780",
"url": "https://chromium.googlesource.com/chromium/src/+/28a53aa0094b99f11cd4b343665ccf084107f780"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "33968f3a1a75dbba35ff22aa2b54d63efa2c2bc4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@33968f3a1a75dbba35ff22aa2b54d63efa2c2bc4",
"title": "33968f3a1a75dbba35ff22aa2b54d63efa2c2bc4",
"url": "https://chromium.googlesource.com/chromium/src/+/33968f3a1a75dbba35ff22aa2b54d63efa2c2bc4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4d8619608a195ef931b75626e8d957e49f54f81c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@4d8619608a195ef931b75626e8d957e49f54f81c",
"title": "4d8619608a195ef931b75626e8d957e49f54f81c",
"url": "https://chromium.googlesource.com/chromium/src/+/4d8619608a195ef931b75626e8d957e49f54f81c"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4d8619608a195ef931b75626e8d957e49f54f81c",
"ref": "refs/branch-heads/7827"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8843646378951466016"
},
{
"key": "scheduler_job_id",
"value": "chromium-m149/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:56:49.113] Scheduled build:
{
"id": "8678216316874911937",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "mac-official"
},
"number": 289,
"createdBy": "project:chromium-m149",
"createTime": "2026-06-23T08:56:48.586240174Z",
"updateTime": "2026-06-23T08:56:48.586240174Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4d8619608a195ef931b75626e8d957e49f54f81c",
"ref": "refs/branch-heads/7827"
}
}
}
[08:56:49.113] Task URL: https://cr-buildbucket.appspot.com/build/8678216316874911937
[08:56:49.113] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:2:0) after 8m31s
[08:56:50.005] Received PubSub notification, asking Buildbucket for the build status
[08:56:50.026] Build status: SCHEDULED
[08:57:37.163] Received PubSub notification, asking Buildbucket for the build status
[08:57:37.180] Build status: STARTED
[09:05:20.263] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:2:0)
[09:05:20.286] Build status: STARTED
[09:05:20.286] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:5:0) after 3m6s
[09:08:26.284] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:5:0)
[09:08:26.308] Build status: STARTED
[09:08:26.308] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:6:0) after 9m24s
[09:17:50.324] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:6:0)
[09:17:50.341] Build status: STARTED
[09:17:50.341] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:7:0) after 1m43s
[09:19:33.379] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:7:0)
[09:19:33.404] Build status: STARTED
[09:19:33.404] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:8:0) after 8m12s
[09:27:45.539] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:8:0)
[09:27:45.566] Build status: STARTED
[09:27:45.566] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:9:0) after 1m34s
[09:29:19.630] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:9:0)
[09:29:19.651] Build status: STARTED
[09:29:19.651] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:10:0) after 5m48s
[09:35:07.725] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:10:0)
[09:35:07.748] Build status: STARTED
[09:35:07.748] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:11:0) after 4m5s
[09:39:12.812] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:11:0)
[09:39:12.835] Build status: STARTED
[09:39:12.835] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:12:0) after 9m54s
[09:49:06.904] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:12:0)
[09:49:06.923] Build status: STARTED
[09:49:06.923] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:13:0) after 2m36s
[09:51:42.948] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:13:0)
[09:51:42.977] Build status: STARTED
[09:51:42.977] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:14:0) after 3m54s
[09:55:36.971] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:14:0)
[09:55:37.166] Build status: STARTED
[09:55:37.166] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:15:0) after 9m20s
[10:04:57.218] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:15:0)
[10:04:57.262] Build status: STARTED
[10:04:57.262] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:16:0) after 3m42s
[10:08:39.281] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:16:0)
[10:08:39.297] Build status: STARTED
[10:08:39.297] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:17:0) after 5m32s
[10:14:11.321] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:17:0)
[10:14:11.391] Build status: STARTED
[10:14:11.391] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:18:0) after 4m22s
[10:18:33.410] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:18:0)
[10:18:33.457] Build status: STARTED
[10:18:33.457] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:19:0) after 8m34s
[10:27:07.477] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:19:0)
[10:27:07.494] Build status: STARTED
[10:27:07.494] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:20:0) after 2m20s
[10:29:27.490] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:20:0)
[10:29:27.512] Build status: STARTED
[10:29:27.512] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:21:0) after 4m14s
[10:33:41.529] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:21:0)
[10:33:41.568] Build status: STARTED
[10:33:41.568] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:22:0) after 3m8s
[10:36:49.584] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:22:0)
[10:36:49.607] Build status: STARTED
[10:36:49.607] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:23:0) after 3m31s
[10:40:20.623] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:23:0)
[10:40:20.640] Build status: STARTED
[10:40:20.640] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:24:0) after 8m34s
[10:48:54.657] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:24:0)
[10:48:54.680] Build status: STARTED
[10:48:54.680] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:25:0) after 7m27s
[10:56:21.700] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:25:0)
[10:56:21.716] Build status: STARTED
[10:56:21.716] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:26:0) after 2m23s
[10:58:44.731] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:26:0)
[10:58:44.751] Build status: STARTED
[10:58:44.751] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:27:0) after 1m11s
[10:59:55.743] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:27:0)
[10:59:55.760] Build status: STARTED
[10:59:55.760] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:28:0) after 9m39s
[11:09:34.862] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:28:0)
[11:09:34.910] Build status: STARTED
[11:09:34.910] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:29:0) after 2m43s
[11:12:17.932] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:29:0)
[11:12:18.115] Build status: STARTED
[11:12:18.115] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:30:0) after 3m35s
[11:15:53.218] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:30:0)
[11:15:53.315] Build status: STARTED
[11:15:53.315] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:31:0) after 1m49s
[11:17:42.359] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:31:0)
[11:17:42.386] Build status: STARTED
[11:17:42.386] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:32:0) after 6m26s
[11:24:08.495] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:32:0)
[11:24:08.513] Build status: STARTED
[11:24:08.513] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:33:0) after 5m34s
[11:29:42.531] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:33:0)
[11:29:42.549] Build status: STARTED
[11:29:42.549] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:34:0) after 3m8s
[11:32:50.599] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:34:0)
[11:32:50.617] Build status: STARTED
[11:32:50.617] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:35:0) after 4m56s
[11:37:46.684] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:35:0)
[11:37:46.709] Build status: STARTED
[11:37:46.709] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:36:0) after 8m24s
[11:46:10.807] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:36:0)
[11:46:10.825] Build status: STARTED
[11:46:10.825] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:37:0) after 9m7s
[11:55:17.864] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:37:0)
[11:55:17.919] Build status: STARTED
[11:55:17.919] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:38:0) after 5m1s
[12:00:18.942] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:38:0)
[12:00:18.961] Build status: STARTED
[12:00:18.961] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:39:0) after 2m23s
[12:02:41.975] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:39:0)
[12:02:41.993] Build status: STARTED
[12:02:41.993] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:40:0) after 7m59s
[12:10:41.084] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:40:0)
[12:10:41.108] Build status: STARTED
[12:10:41.108] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:41:0) after 4m52s
[12:15:33.127] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:41:0)
[12:15:33.146] Build status: STARTED
[12:15:33.146] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:42:0) after 3m11s
[12:18:44.165] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:42:0)
[12:18:44.186] Build status: STARTED
[12:18:44.186] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:43:0) after 9m43s
[12:28:27.205] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:43:0)
[12:28:27.263] Build status: STARTED
[12:28:27.263] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:44:0) after 1m49s
[12:30:16.284] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:44:0)
[12:30:16.305] Build status: STARTED
[12:30:16.305] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:45:0) after 6m2s
[12:36:18.424] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:45:0)
[12:36:18.443] Build status: STARTED
[12:36:18.443] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:46:0) after 8m37s
[12:44:55.462] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:46:0)
[12:44:55.481] Build status: STARTED
[12:44:55.482] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:47:0) after 8m12s
[12:53:07.540] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:47:0)
[12:53:07.558] Build status: STARTED
[12:53:07.558] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:48:0) after 2m39s
[12:55:46.573] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:48:0)
[12:55:46.588] Build status: STARTED
[12:55:46.588] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8843646378951466016:49:0) after 2m18s
[12:56:18.104] Received PubSub notification, asking Buildbucket for the build status
[12:56:18.127] Build:
{
"id": "8678216316874911937",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "mac-official"
},
"number": 289,
"createdBy": "project:chromium-m149",
"createTime": "2026-06-23T08:56:48.586240174Z",
"startTime": "2026-06-23T08:57:36.465816685Z",
"endTime": "2026-06-23T12:56:17.695249912Z",
"updateTime": "2026-06-23T12:56:17.695249912Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4d8619608a195ef931b75626e8d957e49f54f81c",
"ref": "refs/branch-heads/7827"
}
}
}
[12:56:18.127] Invocation finished in 3h59m30.904411122s with status SUCCEEDED