[02:49:44.651] New invocation is queued and will start shortly
[02:49:45.723] Starting the invocation (attempt 1)
[02:49:45.753] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/520f950ba75061957f68466dbd3f290b57c6e0a5"
[02:49:45.753] Popped gitiles commit info from properties and tags
[02:49:45.753] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:49:45.755] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:49:45.755] Buildbucket request:
{
"requestId": "8845300216696509376",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8845300216696509376",
"job": "chromium-m149/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e1fdcc2062be97646e313d008b14a0d80be83cdb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@e1fdcc2062be97646e313d008b14a0d80be83cdb",
"title": "e1fdcc2062be97646e313d008b14a0d80be83cdb",
"url": "https://chromium.googlesource.com/chromium/src/+/e1fdcc2062be97646e313d008b14a0d80be83cdb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b4c15f041dd13781af414376ec412803c55b51cf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@b4c15f041dd13781af414376ec412803c55b51cf",
"title": "b4c15f041dd13781af414376ec412803c55b51cf",
"url": "https://chromium.googlesource.com/chromium/src/+/b4c15f041dd13781af414376ec412803c55b51cf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f81cfa96656c2993be5fe958fe70471e79bafdc3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@f81cfa96656c2993be5fe958fe70471e79bafdc3",
"title": "f81cfa96656c2993be5fe958fe70471e79bafdc3",
"url": "https://chromium.googlesource.com/chromium/src/+/f81cfa96656c2993be5fe958fe70471e79bafdc3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ec8fe8f5a4056fa83ef4395fa865738bade2d388"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@ec8fe8f5a4056fa83ef4395fa865738bade2d388",
"title": "ec8fe8f5a4056fa83ef4395fa865738bade2d388",
"url": "https://chromium.googlesource.com/chromium/src/+/ec8fe8f5a4056fa83ef4395fa865738bade2d388"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7aa51fd6ab9527d5afd933891967f8281bfebaa2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@7aa51fd6ab9527d5afd933891967f8281bfebaa2",
"title": "7aa51fd6ab9527d5afd933891967f8281bfebaa2",
"url": "https://chromium.googlesource.com/chromium/src/+/7aa51fd6ab9527d5afd933891967f8281bfebaa2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "20b7255c55f7cecdf0e04501ab9fc726a8cb5455"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@20b7255c55f7cecdf0e04501ab9fc726a8cb5455",
"title": "20b7255c55f7cecdf0e04501ab9fc726a8cb5455",
"url": "https://chromium.googlesource.com/chromium/src/+/20b7255c55f7cecdf0e04501ab9fc726a8cb5455"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d1913e041cc58a5c2e8a022b4054a84a4f0b19bc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@d1913e041cc58a5c2e8a022b4054a84a4f0b19bc",
"title": "d1913e041cc58a5c2e8a022b4054a84a4f0b19bc",
"url": "https://chromium.googlesource.com/chromium/src/+/d1913e041cc58a5c2e8a022b4054a84a4f0b19bc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8d0fa95a694f72492b0af37b8bfd620d4465800d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@8d0fa95a694f72492b0af37b8bfd620d4465800d",
"title": "8d0fa95a694f72492b0af37b8bfd620d4465800d",
"url": "https://chromium.googlesource.com/chromium/src/+/8d0fa95a694f72492b0af37b8bfd620d4465800d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a5030b91a60dc824d2c5658be547ac49da2055c6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@a5030b91a60dc824d2c5658be547ac49da2055c6",
"title": "a5030b91a60dc824d2c5658be547ac49da2055c6",
"url": "https://chromium.googlesource.com/chromium/src/+/a5030b91a60dc824d2c5658be547ac49da2055c6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "520f950ba75061957f68466dbd3f290b57c6e0a5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@520f950ba75061957f68466dbd3f290b57c6e0a5",
"title": "520f950ba75061957f68466dbd3f290b57c6e0a5",
"url": "https://chromium.googlesource.com/chromium/src/+/520f950ba75061957f68466dbd3f290b57c6e0a5"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "520f950ba75061957f68466dbd3f290b57c6e0a5",
"ref": "refs/branch-heads/7827"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8845300216696509376"
},
{
"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"
}
}
[02:49:46.241] Scheduled build:
{
"id": "8679870154811372193",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "mac-official"
},
"number": 181,
"createdBy": "project:chromium-m149",
"createTime": "2026-06-05T02:49:45.823151763Z",
"updateTime": "2026-06-05T02:49:45.823151763Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "520f950ba75061957f68466dbd3f290b57c6e0a5",
"ref": "refs/branch-heads/7827"
}
}
}
[02:49:46.241] Task URL: https://cr-buildbucket.appspot.com/build/8679870154811372193
[02:49:46.241] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:2:0) after 2m0s
[02:49:47.183] Received PubSub notification, asking Buildbucket for the build status
[02:49:47.250] Build status: SCHEDULED
[02:49:51.307] Received PubSub notification, asking Buildbucket for the build status
[02:49:51.330] Build status: STARTED
[02:51:46.269] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:2:0)
[02:51:46.299] Build status: STARTED
[02:51:46.299] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:5:0) after 7m26s
[02:59:12.313] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:5:0)
[02:59:12.438] Build status: STARTED
[02:59:12.438] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:6:0) after 5m43s
[03:04:55.561] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:6:0)
[03:04:55.583] Build status: STARTED
[03:04:55.583] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:7:0) after 3m30s
[03:08:25.635] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:7:0)
[03:08:25.720] Build status: STARTED
[03:08:25.720] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:8:0) after 1m16s
[03:09:41.736] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:8:0)
[03:09:41.753] Build status: STARTED
[03:09:41.753] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:9:0) after 1m14s
[03:10:55.794] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:9:0)
[03:10:55.820] Build status: STARTED
[03:10:55.820] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:10:0) after 9m30s
[03:20:25.833] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:10:0)
[03:20:25.856] Build status: STARTED
[03:20:25.856] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:11:0) after 5m43s
[03:26:08.873] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:11:0)
[03:26:08.890] Build status: STARTED
[03:26:08.890] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:12:0) after 6m26s
[03:32:34.884] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:12:0)
[03:32:34.902] Build status: STARTED
[03:32:34.902] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:13:0) after 7m40s
[03:40:14.996] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:13:0)
[03:40:15.011] Build status: STARTED
[03:40:15.011] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:14:0) after 1m5s
[03:41:20.047] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:14:0)
[03:41:20.091] Build status: STARTED
[03:41:20.091] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:15:0) after 7m13s
[03:48:33.125] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:15:0)
[03:48:33.140] Build status: STARTED
[03:48:33.140] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:16:0) after 3m36s
[03:52:09.154] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:16:0)
[03:52:09.188] Build status: STARTED
[03:52:09.188] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:17:0) after 2m32s
[03:54:41.206] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:17:0)
[03:54:41.312] Build status: STARTED
[03:54:41.312] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:18:0) after 9m6s
[04:03:47.324] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:18:0)
[04:03:47.343] Build status: STARTED
[04:03:47.343] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:19:0) after 4m42s
[04:08:29.360] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:19:0)
[04:08:29.386] Build status: STARTED
[04:08:29.386] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:20:0) after 6m20s
[04:14:49.454] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:20:0)
[04:14:49.474] Build status: STARTED
[04:14:49.474] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:21:0) after 7m37s
[04:22:26.538] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:21:0)
[04:22:26.581] Build status: STARTED
[04:22:26.581] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:22:0) after 4m39s
[04:27:05.611] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:22:0)
[04:27:05.630] Build status: STARTED
[04:27:05.630] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:23:0) after 1m51s
[04:28:56.683] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:23:0)
[04:28:56.703] Build status: STARTED
[04:28:56.703] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:24:0) after 5m38s
[04:34:34.743] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:24:0)
[04:34:34.769] Build status: STARTED
[04:34:34.769] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:25:0) after 4m36s
[04:39:10.757] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:25:0)
[04:39:10.778] Build status: STARTED
[04:39:10.778] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:26:0) after 9m21s
[04:48:31.844] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:26:0)
[04:48:31.865] Build status: STARTED
[04:48:31.865] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:27:0) after 4m55s
[04:53:26.886] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:27:0)
[04:53:27.020] Build status: STARTED
[04:53:27.020] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:28:0) after 6m24s
[04:59:51.212] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:28:0)
[04:59:51.253] Build status: STARTED
[04:59:51.253] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:29:0) after 7m33s
[05:07:24.272] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:29:0)
[05:07:24.310] Build status: STARTED
[05:07:24.310] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:30:0) after 5m53s
[05:13:17.329] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:30:0)
[05:13:17.348] Build status: STARTED
[05:13:17.348] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:31:0) after 7m45s
[05:21:02.414] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:31:0)
[05:21:02.442] Build status: STARTED
[05:21:02.442] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:32:0) after 4m18s
[05:25:20.457] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:32:0)
[05:25:20.475] Build status: STARTED
[05:25:20.475] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:33:0) after 1m37s
[05:26:57.489] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:33:0)
[05:26:57.515] Build status: STARTED
[05:26:57.515] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:34:0) after 4m12s
[05:31:09.509] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:34:0)
[05:31:09.571] Build status: STARTED
[05:31:09.571] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:35:0) after 7m29s
[05:38:38.588] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:35:0)
[05:38:38.640] Build status: STARTED
[05:38:38.640] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:36:0) after 4m24s
[05:43:02.655] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:36:0)
[05:43:02.761] Build status: STARTED
[05:43:02.761] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:37:0) after 2m33s
[05:45:35.777] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:37:0)
[05:45:35.797] Build status: STARTED
[05:45:35.797] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:38:0) after 8m35s
[05:54:10.823] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:38:0)
[05:54:10.844] Build status: STARTED
[05:54:10.844] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:39:0) after 7m43s
[06:01:53.860] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:39:0)
[06:01:53.922] Build status: STARTED
[06:01:53.922] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:40:0) after 3m37s
[06:05:30.890] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:40:0)
[06:05:30.929] Build status: STARTED
[06:05:30.929] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:41:0) after 6m24s
[06:11:54.962] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:41:0)
[06:11:54.978] Build status: STARTED
[06:11:54.978] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:42:0) after 4m6s
[06:16:00.996] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:42:0)
[06:16:01.009] Build status: STARTED
[06:16:01.009] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:43:0) after 6m21s
[06:22:22.067] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:43:0)
[06:22:22.091] Build status: STARTED
[06:22:22.091] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:44:0) after 1m49s
[06:24:11.118] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:44:0)
[06:24:11.138] Build status: STARTED
[06:24:11.138] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:45:0) after 7m27s
[06:31:38.315] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:45:0)
[06:31:38.336] Build status: STARTED
[06:31:38.336] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:46:0) after 3m4s
[06:34:42.333] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:46:0)
[06:34:42.353] Build status: STARTED
[06:34:42.353] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:47:0) after 7m20s
[06:42:02.375] Handling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:47:0)
[06:42:02.393] Build status: STARTED
[06:42:02.393] Scheduling timer "check-buildbucket-build-status" (chromium-m149/mac-official:8845300216696509376:48:0) after 8m48s
[06:43:33.038] Received PubSub notification, asking Buildbucket for the build status
[06:43:33.064] Build:
{
"id": "8679870154811372193",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "mac-official"
},
"number": 181,
"createdBy": "project:chromium-m149",
"createTime": "2026-06-05T02:49:45.823151763Z",
"startTime": "2026-06-05T02:49:51.126563323Z",
"endTime": "2026-06-05T06:43:29.933621926Z",
"updateTime": "2026-06-05T06:43:29.933621926Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "520f950ba75061957f68466dbd3f290b57c6e0a5",
"ref": "refs/branch-heads/7827"
}
}
}
[06:43:33.064] Invocation finished in 3h53m48.423197547s with status SUCCEEDED