[03:12:14.748] New invocation is queued and will start shortly
[03:12:16.012] Starting the invocation (attempt 1)
[03:12:16.039] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/214f0c72e92fab31c642c993d2fe0b7441f69e30"
[03:12:16.039] Popped gitiles commit info from properties and tags
[03:12:16.039] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:12:16.041] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:12:16.042] Buildbucket request:
{
"requestId": "8848560291802023456",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8848560291802023456",
"job": "chromium-m148/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d7d1386710a8c486a20a27e3a757edcbf61b4521"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d7d1386710a8c486a20a27e3a757edcbf61b4521",
"title": "d7d1386710a8c486a20a27e3a757edcbf61b4521",
"url": "https://chromium.googlesource.com/chromium/src/+/d7d1386710a8c486a20a27e3a757edcbf61b4521"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a6b34ca28a8c7b7bf6de46db97b36cf4a66deca7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@a6b34ca28a8c7b7bf6de46db97b36cf4a66deca7",
"title": "a6b34ca28a8c7b7bf6de46db97b36cf4a66deca7",
"url": "https://chromium.googlesource.com/chromium/src/+/a6b34ca28a8c7b7bf6de46db97b36cf4a66deca7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4bb50d008f059fcf5bf14b8b09dc2a61f6b44dbe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4bb50d008f059fcf5bf14b8b09dc2a61f6b44dbe",
"title": "4bb50d008f059fcf5bf14b8b09dc2a61f6b44dbe",
"url": "https://chromium.googlesource.com/chromium/src/+/4bb50d008f059fcf5bf14b8b09dc2a61f6b44dbe"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5b085f382ff6f203a95217e11c1b4f835110436c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5b085f382ff6f203a95217e11c1b4f835110436c",
"title": "5b085f382ff6f203a95217e11c1b4f835110436c",
"url": "https://chromium.googlesource.com/chromium/src/+/5b085f382ff6f203a95217e11c1b4f835110436c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b408b1eb0aa3d38a1f10bc32f98da041f5e0450a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b408b1eb0aa3d38a1f10bc32f98da041f5e0450a",
"title": "b408b1eb0aa3d38a1f10bc32f98da041f5e0450a",
"url": "https://chromium.googlesource.com/chromium/src/+/b408b1eb0aa3d38a1f10bc32f98da041f5e0450a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "24536379bd41370026d9d513c3227dda682ce295"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@24536379bd41370026d9d513c3227dda682ce295",
"title": "24536379bd41370026d9d513c3227dda682ce295",
"url": "https://chromium.googlesource.com/chromium/src/+/24536379bd41370026d9d513c3227dda682ce295"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ab2cb792ef4ce9f2c24246ddbe50125a567ec73a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@ab2cb792ef4ce9f2c24246ddbe50125a567ec73a",
"title": "ab2cb792ef4ce9f2c24246ddbe50125a567ec73a",
"url": "https://chromium.googlesource.com/chromium/src/+/ab2cb792ef4ce9f2c24246ddbe50125a567ec73a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a95cea99c1c4991ecac5f5f086be5ba4cb2acf6f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@a95cea99c1c4991ecac5f5f086be5ba4cb2acf6f",
"title": "a95cea99c1c4991ecac5f5f086be5ba4cb2acf6f",
"url": "https://chromium.googlesource.com/chromium/src/+/a95cea99c1c4991ecac5f5f086be5ba4cb2acf6f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f48334e458644ab163c54d9307fa9146bbaf425b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@f48334e458644ab163c54d9307fa9146bbaf425b",
"title": "f48334e458644ab163c54d9307fa9146bbaf425b",
"url": "https://chromium.googlesource.com/chromium/src/+/f48334e458644ab163c54d9307fa9146bbaf425b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "40df9ba16dcfe931a15e762d8c5657b3e1f053b8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@40df9ba16dcfe931a15e762d8c5657b3e1f053b8",
"title": "40df9ba16dcfe931a15e762d8c5657b3e1f053b8",
"url": "https://chromium.googlesource.com/chromium/src/+/40df9ba16dcfe931a15e762d8c5657b3e1f053b8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "214f0c72e92fab31c642c993d2fe0b7441f69e30"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@214f0c72e92fab31c642c993d2fe0b7441f69e30",
"title": "214f0c72e92fab31c642c993d2fe0b7441f69e30",
"url": "https://chromium.googlesource.com/chromium/src/+/214f0c72e92fab31c642c993d2fe0b7441f69e30"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "214f0c72e92fab31c642c993d2fe0b7441f69e30",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8848560291802023456"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:12:16.656] Scheduled build:
{
"id": "8683130229727431425",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"number": 135,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-30T03:12:16.106909571Z",
"updateTime": "2026-04-30T03:12:16.106909571Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "214f0c72e92fab31c642c993d2fe0b7441f69e30",
"ref": "refs/branch-heads/7778"
}
}
}
[03:12:16.656] Task URL: https://cr-buildbucket.appspot.com/build/8683130229727431425
[03:12:16.656] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:2:0) after 5m10s
[03:12:17.610] Received PubSub notification, asking Buildbucket for the build status
[03:12:17.631] Build status: SCHEDULED
[03:12:20.979] Received PubSub notification, asking Buildbucket for the build status
[03:12:21.013] Build status: STARTED
[03:17:26.671] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:2:0)
[03:17:26.718] Build status: STARTED
[03:17:26.718] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:5:0) after 9m4s
[03:26:30.918] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:5:0)
[03:26:30.990] Build status: STARTED
[03:26:30.990] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:6:0) after 1m4s
[03:27:35.002] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:6:0)
[03:27:35.201] Build status: STARTED
[03:27:35.201] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:7:0) after 3m37s
[03:31:12.221] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:7:0)
[03:31:12.239] Build status: STARTED
[03:31:12.239] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:8:0) after 8m43s
[03:39:55.394] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:8:0)
[03:39:55.408] Build status: STARTED
[03:39:55.408] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:9:0) after 3m20s
[03:43:15.425] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:9:0)
[03:43:15.505] Build status: STARTED
[03:43:15.505] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:10:0) after 7m8s
[03:50:23.522] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:10:0)
[03:50:23.585] Build status: STARTED
[03:50:23.585] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:11:0) after 8m22s
[03:58:45.662] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:11:0)
[03:58:45.691] Build status: STARTED
[03:58:45.691] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:12:0) after 9m27s
[04:08:12.709] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:12:0)
[04:08:12.731] Build status: STARTED
[04:08:12.731] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:13:0) after 4m13s
[04:12:25.800] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:13:0)
[04:12:25.818] Build status: STARTED
[04:12:25.818] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:14:0) after 1m35s
[04:14:00.998] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:14:0)
[04:14:01.019] Build status: STARTED
[04:14:01.019] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:15:0) after 6m4s
[04:20:05.064] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:15:0)
[04:20:05.084] Build status: STARTED
[04:20:05.084] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:16:0) after 6m31s
[04:26:36.249] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:16:0)
[04:26:36.271] Build status: STARTED
[04:26:36.271] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:17:0) after 8m31s
[04:35:07.274] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:17:0)
[04:35:07.355] Build status: STARTED
[04:35:07.355] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:18:0) after 7m6s
[04:42:13.539] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:18:0)
[04:42:13.557] Build status: STARTED
[04:42:13.557] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:19:0) after 5m0s
[04:47:13.565] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:19:0)
[04:47:13.594] Build status: STARTED
[04:47:13.594] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:20:0) after 9m41s
[04:56:54.569] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:20:0)
[04:56:54.599] Build status: STARTED
[04:56:54.599] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:21:0) after 6m11s
[05:03:05.664] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:21:0)
[05:03:05.854] Build status: STARTED
[05:03:05.854] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:22:0) after 5m45s
[05:08:50.901] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:22:0)
[05:08:50.929] Build status: STARTED
[05:08:50.929] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:23:0) after 1m46s
[05:10:36.954] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:23:0)
[05:10:36.969] Build status: STARTED
[05:10:36.969] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:24:0) after 5m38s
[05:16:15.026] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:24:0)
[05:16:15.115] Build status: STARTED
[05:16:15.115] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:25:0) after 7m5s
[05:23:20.169] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:25:0)
[05:23:20.196] Build status: STARTED
[05:23:20.197] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:26:0) after 9m23s
[05:32:43.237] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:26:0)
[05:32:43.636] Build status: STARTED
[05:32:43.636] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:27:0) after 5m3s
[05:37:46.652] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:27:0)
[05:37:46.679] Build status: STARTED
[05:37:46.679] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:28:0) after 7m7s
[05:44:53.693] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:28:0)
[05:44:53.723] Build status: STARTED
[05:44:53.723] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:29:0) after 5m25s
[05:50:18.801] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:29:0)
[05:50:19.565] Build status: STARTED
[05:50:19.565] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:30:0) after 7m5s
[05:57:24.622] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:30:0)
[05:57:24.655] Build status: STARTED
[05:57:24.655] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:31:0) after 5m33s
[06:02:57.930] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:31:0)
[06:02:57.946] Build status: STARTED
[06:02:57.946] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:32:0) after 8m11s
[06:11:08.995] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:32:0)
[06:11:09.030] Build status: STARTED
[06:11:09.031] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:33:0) after 6m4s
[06:17:13.044] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:33:0)
[06:17:13.077] Build status: STARTED
[06:17:13.077] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:34:0) after 7m10s
[06:24:23.190] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:34:0)
[06:24:23.256] Build status: STARTED
[06:24:23.256] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:35:0) after 8m5s
[06:32:28.406] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:35:0)
[06:32:28.432] Build status: STARTED
[06:32:28.432] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:36:0) after 5m5s
[06:37:33.453] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:36:0)
[06:37:33.472] Build status: STARTED
[06:37:33.472] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:37:0) after 1m36s
[06:39:09.646] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:37:0)
[06:39:09.664] Build status: STARTED
[06:39:09.664] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:38:0) after 1m4s
[06:40:13.713] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:38:0)
[06:40:13.734] Build status: STARTED
[06:40:13.734] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:39:0) after 8m8s
[06:48:21.870] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:39:0)
[06:48:21.890] Build status: STARTED
[06:48:21.890] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:40:0) after 2m51s
[06:51:12.908] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:40:0)
[06:51:12.929] Build status: STARTED
[06:51:12.929] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:41:0) after 9m9s
[07:00:21.945] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:41:0)
[07:00:21.962] Build status: STARTED
[07:00:21.962] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848560291802023456:42:0) after 8m19s
[07:05:18.312] Received PubSub notification, asking Buildbucket for the build status
[07:05:18.331] Build:
{
"id": "8683130229727431425",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"number": 135,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-30T03:12:16.106909571Z",
"startTime": "2026-04-30T03:12:20.805820679Z",
"endTime": "2026-04-30T07:05:17.913428737Z",
"updateTime": "2026-04-30T07:05:17.913428737Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "214f0c72e92fab31c642c993d2fe0b7441f69e30",
"ref": "refs/branch-heads/7778"
}
}
}
[07:05:18.331] Invocation finished in 3h53m3.586457799s with status SUCCEEDED