[03:07:34.059] New invocation is queued and will start shortly
[03:07:35.108] Starting the invocation (attempt 1)
[03:07:35.128] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e627af3f45bd02dc244a30dc24d381b1ff796ecc"
[03:07:35.129] Popped gitiles commit info from properties and tags
[03:07:35.129] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:07:35.129] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:07:35.129] Buildbucket request:
{
"requestId": "8848922973991272224",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8848922973991272224",
"job": "chromium-m148/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "95d8fa0e95b2c78af921e6517f39b536af8ba976"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@95d8fa0e95b2c78af921e6517f39b536af8ba976",
"title": "95d8fa0e95b2c78af921e6517f39b536af8ba976",
"url": "https://chromium.googlesource.com/chromium/src/+/95d8fa0e95b2c78af921e6517f39b536af8ba976"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "545f22ec21f2c8f16f37a3b0f3b7132b4c1f3fc1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@545f22ec21f2c8f16f37a3b0f3b7132b4c1f3fc1",
"title": "545f22ec21f2c8f16f37a3b0f3b7132b4c1f3fc1",
"url": "https://chromium.googlesource.com/chromium/src/+/545f22ec21f2c8f16f37a3b0f3b7132b4c1f3fc1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0ff5b018a2cb5a88294a050e1cf26fe004484c4b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@0ff5b018a2cb5a88294a050e1cf26fe004484c4b",
"title": "0ff5b018a2cb5a88294a050e1cf26fe004484c4b",
"url": "https://chromium.googlesource.com/chromium/src/+/0ff5b018a2cb5a88294a050e1cf26fe004484c4b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5dd6a55a306e8a9f7def6459f663978b7898a093"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5dd6a55a306e8a9f7def6459f663978b7898a093",
"title": "5dd6a55a306e8a9f7def6459f663978b7898a093",
"url": "https://chromium.googlesource.com/chromium/src/+/5dd6a55a306e8a9f7def6459f663978b7898a093"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7832b32824a876e42a36f8c6a7d698785598049a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@7832b32824a876e42a36f8c6a7d698785598049a",
"title": "7832b32824a876e42a36f8c6a7d698785598049a",
"url": "https://chromium.googlesource.com/chromium/src/+/7832b32824a876e42a36f8c6a7d698785598049a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "281048d164374ccc5db70fe62be859e0ba0fe46f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@281048d164374ccc5db70fe62be859e0ba0fe46f",
"title": "281048d164374ccc5db70fe62be859e0ba0fe46f",
"url": "https://chromium.googlesource.com/chromium/src/+/281048d164374ccc5db70fe62be859e0ba0fe46f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "508f3f5b6d0e3d617d001cb2b1822dee182dd270"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@508f3f5b6d0e3d617d001cb2b1822dee182dd270",
"title": "508f3f5b6d0e3d617d001cb2b1822dee182dd270",
"url": "https://chromium.googlesource.com/chromium/src/+/508f3f5b6d0e3d617d001cb2b1822dee182dd270"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "526d5b7535fe6f7a6585cc304255fab697b79954"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@526d5b7535fe6f7a6585cc304255fab697b79954",
"title": "526d5b7535fe6f7a6585cc304255fab697b79954",
"url": "https://chromium.googlesource.com/chromium/src/+/526d5b7535fe6f7a6585cc304255fab697b79954"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "76fe6eb639cd380c96357509d1859e30ffb69348"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@76fe6eb639cd380c96357509d1859e30ffb69348",
"title": "76fe6eb639cd380c96357509d1859e30ffb69348",
"url": "https://chromium.googlesource.com/chromium/src/+/76fe6eb639cd380c96357509d1859e30ffb69348"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8b54c425058e6c1a38672388328b949b524a33b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@8b54c425058e6c1a38672388328b949b524a33b1",
"title": "8b54c425058e6c1a38672388328b949b524a33b1",
"url": "https://chromium.googlesource.com/chromium/src/+/8b54c425058e6c1a38672388328b949b524a33b1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e627af3f45bd02dc244a30dc24d381b1ff796ecc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@e627af3f45bd02dc244a30dc24d381b1ff796ecc",
"title": "e627af3f45bd02dc244a30dc24d381b1ff796ecc",
"url": "https://chromium.googlesource.com/chromium/src/+/e627af3f45bd02dc244a30dc24d381b1ff796ecc"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e627af3f45bd02dc244a30dc24d381b1ff796ecc",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8848922973991272224"
},
{
"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:07:35.806] Scheduled build:
{
"id": "8683492912162804321",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"number": 112,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-26T03:07:35.182644293Z",
"updateTime": "2026-04-26T03:07:35.182644293Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e627af3f45bd02dc244a30dc24d381b1ff796ecc",
"ref": "refs/branch-heads/7778"
}
}
}
[03:07:35.806] Task URL: https://cr-buildbucket.appspot.com/build/8683492912162804321
[03:07:35.806] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:2:0) after 1m22s
[03:07:36.735] Received PubSub notification, asking Buildbucket for the build status
[03:07:36.753] Build status: SCHEDULED
[03:07:40.356] Received PubSub notification, asking Buildbucket for the build status
[03:07:40.377] Build status: STARTED
[03:08:57.810] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:2:0)
[03:08:57.826] Build status: STARTED
[03:08:57.827] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:5:0) after 9m5s
[03:18:02.854] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:5:0)
[03:18:02.889] Build status: STARTED
[03:18:02.889] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:6:0) after 8m10s
[03:26:13.034] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:6:0)
[03:26:13.053] Build status: STARTED
[03:26:13.053] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:7:0) after 5m19s
[03:31:32.073] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:7:0)
[03:31:32.089] Build status: STARTED
[03:31:32.089] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:8:0) after 5m14s
[03:36:46.101] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:8:0)
[03:36:46.127] Build status: STARTED
[03:36:46.127] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:9:0) after 3m49s
[03:40:35.134] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:9:0)
[03:40:35.177] Build status: STARTED
[03:40:35.177] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:10:0) after 9m34s
[03:50:09.583] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:10:0)
[03:50:09.609] Build status: STARTED
[03:50:09.609] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:11:0) after 9m26s
[03:59:35.626] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:11:0)
[03:59:35.647] Build status: STARTED
[03:59:35.647] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:12:0) after 9m24s
[04:08:59.695] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:12:0)
[04:08:59.727] Build status: STARTED
[04:08:59.727] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:13:0) after 5m47s
[04:14:47.052] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:13:0)
[04:14:47.094] Build status: STARTED
[04:14:47.094] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:14:0) after 7m37s
[04:22:24.232] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:14:0)
[04:22:24.256] Build status: STARTED
[04:22:24.256] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:15:0) after 8m25s
[04:30:49.278] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:15:0)
[04:30:49.312] Build status: STARTED
[04:30:49.312] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:16:0) after 8m42s
[04:39:31.844] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:16:0)
[04:39:31.863] Build status: STARTED
[04:39:31.863] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:17:0) after 6m26s
[04:45:57.882] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:17:0)
[04:45:57.915] Build status: STARTED
[04:45:57.915] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:18:0) after 6m57s
[04:52:55.031] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:18:0)
[04:52:55.100] Build status: STARTED
[04:52:55.100] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:19:0) after 9m15s
[05:02:10.499] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:19:0)
[05:02:10.540] Build status: STARTED
[05:02:10.540] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:20:0) after 2m20s
[05:04:30.554] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:20:0)
[05:04:30.571] Build status: STARTED
[05:04:30.571] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:21:0) after 3m40s
[05:08:10.592] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:21:0)
[05:08:10.612] Build status: STARTED
[05:08:10.612] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:22:0) after 3m26s
[05:11:36.724] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:22:0)
[05:11:36.769] Build status: STARTED
[05:11:36.769] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:23:0) after 6m44s
[05:18:20.812] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:23:0)
[05:18:20.833] Build status: STARTED
[05:18:20.833] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:24:0) after 5m7s
[05:23:27.851] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:24:0)
[05:23:27.873] Build status: STARTED
[05:23:27.873] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:25:0) after 5m17s
[05:28:44.891] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:25:0)
[05:28:44.912] Build status: STARTED
[05:28:44.912] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:26:0) after 8m38s
[05:37:23.207] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:26:0)
[05:37:23.225] Build status: STARTED
[05:37:23.225] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:27:0) after 1m30s
[05:38:53.355] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:27:0)
[05:38:53.409] Build status: STARTED
[05:38:53.409] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:28:0) after 7m4s
[05:45:57.642] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:28:0)
[05:45:57.659] Build status: STARTED
[05:45:57.659] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:29:0) after 8m54s
[05:54:51.673] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:29:0)
[05:54:51.855] Build status: STARTED
[05:54:51.855] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:30:0) after 2m53s
[05:57:44.921] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:30:0)
[05:57:44.940] Build status: STARTED
[05:57:44.941] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:31:0) after 1m16s
[05:59:00.922] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:31:0)
[05:59:00.996] Build status: STARTED
[05:59:00.996] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:32:0) after 8m11s
[06:07:12.015] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:32:0)
[06:07:12.080] Build status: STARTED
[06:07:12.080] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:33:0) after 9m2s
[06:16:14.327] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:33:0)
[06:16:14.378] Build status: STARTED
[06:16:14.378] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:34:0) after 4m0s
[06:20:14.504] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:34:0)
[06:20:14.518] Build status: STARTED
[06:20:14.518] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:35:0) after 1m20s
[06:21:34.612] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:35:0)
[06:21:34.631] Build status: STARTED
[06:21:34.631] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:36:0) after 6m20s
[06:27:54.743] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:36:0)
[06:27:54.810] Build status: STARTED
[06:27:54.811] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:37:0) after 7m45s
[06:35:39.832] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:37:0)
[06:35:39.853] Build status: STARTED
[06:35:39.853] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:38:0) after 8m37s
[06:44:16.879] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:38:0)
[06:44:16.895] Build status: STARTED
[06:44:16.895] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8848922973991272224:39:0) after 6m45s
[06:49:30.415] Received PubSub notification, asking Buildbucket for the build status
[06:49:30.431] Build:
{
"id": "8683492912162804321",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"number": 112,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-26T03:07:35.182644293Z",
"startTime": "2026-04-26T03:07:39.419932494Z",
"endTime": "2026-04-26T06:49:30.157496489Z",
"updateTime": "2026-04-26T06:49:30.157496489Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e627af3f45bd02dc244a30dc24d381b1ff796ecc",
"ref": "refs/branch-heads/7778"
}
}
}
[06:49:30.431] Invocation finished in 3h41m56.375400472s with status SUCCEEDED