[03:50:44.322] New invocation is queued and will start shortly
[03:50:45.428] Starting the invocation (attempt 1)
[03:50:45.453] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/467097774c141bc647606c2cef8d49023b9a39ec"
[03:50:45.453] Popped gitiles commit info from properties and tags
[03:50:45.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:50:45.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:50:45.454] Buildbucket request:
{
"requestId": "8850188615436300160",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8850188615436300160",
"job": "chromium-m148/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a543bf00115fc3ce55686f988d2d4d3d01528b0d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@a543bf00115fc3ce55686f988d2d4d3d01528b0d",
"title": "a543bf00115fc3ce55686f988d2d4d3d01528b0d",
"url": "https://chromium.googlesource.com/chromium/src/+/a543bf00115fc3ce55686f988d2d4d3d01528b0d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "428c431fefd17d165ba42622fad733c300446ff0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@428c431fefd17d165ba42622fad733c300446ff0",
"title": "428c431fefd17d165ba42622fad733c300446ff0",
"url": "https://chromium.googlesource.com/chromium/src/+/428c431fefd17d165ba42622fad733c300446ff0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "dc09f51e64675bc6ad561c39f13cf145b9e2bd4f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@dc09f51e64675bc6ad561c39f13cf145b9e2bd4f",
"title": "dc09f51e64675bc6ad561c39f13cf145b9e2bd4f",
"url": "https://chromium.googlesource.com/chromium/src/+/dc09f51e64675bc6ad561c39f13cf145b9e2bd4f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5429584ff498832d6b1eddba34adf7430e660044"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5429584ff498832d6b1eddba34adf7430e660044",
"title": "5429584ff498832d6b1eddba34adf7430e660044",
"url": "https://chromium.googlesource.com/chromium/src/+/5429584ff498832d6b1eddba34adf7430e660044"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d7c61c82649e68a18342b46351423a2074d2aa58"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d7c61c82649e68a18342b46351423a2074d2aa58",
"title": "d7c61c82649e68a18342b46351423a2074d2aa58",
"url": "https://chromium.googlesource.com/chromium/src/+/d7c61c82649e68a18342b46351423a2074d2aa58"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa180fd3f639a09b4f2006b4ca2a29d06a781913"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@aa180fd3f639a09b4f2006b4ca2a29d06a781913",
"title": "aa180fd3f639a09b4f2006b4ca2a29d06a781913",
"url": "https://chromium.googlesource.com/chromium/src/+/aa180fd3f639a09b4f2006b4ca2a29d06a781913"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4770970f4307c77f7a5eb52a73a15594f2a74c79"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4770970f4307c77f7a5eb52a73a15594f2a74c79",
"title": "4770970f4307c77f7a5eb52a73a15594f2a74c79",
"url": "https://chromium.googlesource.com/chromium/src/+/4770970f4307c77f7a5eb52a73a15594f2a74c79"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d3bd0a572e75302f2829fb1588ca726bb1f30770"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d3bd0a572e75302f2829fb1588ca726bb1f30770",
"title": "d3bd0a572e75302f2829fb1588ca726bb1f30770",
"url": "https://chromium.googlesource.com/chromium/src/+/d3bd0a572e75302f2829fb1588ca726bb1f30770"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "215e98964bd8ac71040691bcb898bc3de300efce"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@215e98964bd8ac71040691bcb898bc3de300efce",
"title": "215e98964bd8ac71040691bcb898bc3de300efce",
"url": "https://chromium.googlesource.com/chromium/src/+/215e98964bd8ac71040691bcb898bc3de300efce"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "45db5b23a0eff89648587c9faa2ce17e3afbae32"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@45db5b23a0eff89648587c9faa2ce17e3afbae32",
"title": "45db5b23a0eff89648587c9faa2ce17e3afbae32",
"url": "https://chromium.googlesource.com/chromium/src/+/45db5b23a0eff89648587c9faa2ce17e3afbae32"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f9d51ae6b15caafc1bc671f56bb5997264d3620"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4f9d51ae6b15caafc1bc671f56bb5997264d3620",
"title": "4f9d51ae6b15caafc1bc671f56bb5997264d3620",
"url": "https://chromium.googlesource.com/chromium/src/+/4f9d51ae6b15caafc1bc671f56bb5997264d3620"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "467097774c141bc647606c2cef8d49023b9a39ec"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@467097774c141bc647606c2cef8d49023b9a39ec",
"title": "467097774c141bc647606c2cef8d49023b9a39ec",
"url": "https://chromium.googlesource.com/chromium/src/+/467097774c141bc647606c2cef8d49023b9a39ec"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "467097774c141bc647606c2cef8d49023b9a39ec",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8850188615436300160"
},
{
"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:50:45.916] Scheduled build:
{
"id": "8684758553532143505",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"number": 29,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-12T03:50:45.514544824Z",
"updateTime": "2026-04-12T03:50:45.514544824Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "467097774c141bc647606c2cef8d49023b9a39ec",
"ref": "refs/branch-heads/7778"
}
}
}
[03:50:45.916] Task URL: https://cr-buildbucket.appspot.com/build/8684758553532143505
[03:50:45.916] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:2:0) after 8m45s
[03:50:46.878] Received PubSub notification, asking Buildbucket for the build status
[03:50:46.921] Build status: SCHEDULED
[03:51:35.655] Received PubSub notification, asking Buildbucket for the build status
[03:51:35.674] Build status: STARTED
[03:59:31.107] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:2:0)
[03:59:31.123] Build status: STARTED
[03:59:31.123] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:5:0) after 6m43s
[04:06:14.141] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:5:0)
[04:06:14.156] Build status: STARTED
[04:06:14.156] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:6:0) after 9m20s
[04:15:34.178] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:6:0)
[04:15:34.221] Build status: STARTED
[04:15:34.221] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:7:0) after 2m46s
[04:18:20.440] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:7:0)
[04:18:20.468] Build status: STARTED
[04:18:20.468] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:8:0) after 7m12s
[04:25:32.558] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:8:0)
[04:25:32.576] Build status: STARTED
[04:25:32.576] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:9:0) after 6m43s
[04:32:15.593] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:9:0)
[04:32:15.625] Build status: STARTED
[04:32:15.625] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:10:0) after 9m21s
[04:41:36.633] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:10:0)
[04:41:36.658] Build status: STARTED
[04:41:36.658] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:11:0) after 4m56s
[04:46:32.625] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:11:0)
[04:46:32.685] Build status: STARTED
[04:46:32.685] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:12:0) after 5m23s
[04:51:55.694] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:12:0)
[04:51:55.710] Build status: STARTED
[04:51:55.710] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:13:0) after 6m20s
[04:58:15.983] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:13:0)
[04:58:16.052] Build status: STARTED
[04:58:16.052] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:14:0) after 9m13s
[05:07:29.152] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:14:0)
[05:07:29.173] Build status: STARTED
[05:07:29.173] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:15:0) after 8m48s
[05:16:17.207] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:15:0)
[05:16:17.242] Build status: STARTED
[05:16:17.242] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:16:0) after 4m48s
[05:21:05.305] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:16:0)
[05:21:05.326] Build status: STARTED
[05:21:05.326] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:17:0) after 5m34s
[05:26:39.419] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:17:0)
[05:26:39.476] Build status: STARTED
[05:26:39.476] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:18:0) after 7m36s
[05:34:15.494] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:18:0)
[05:34:15.513] Build status: STARTED
[05:34:15.513] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:19:0) after 5m32s
[05:39:47.541] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:19:0)
[05:39:47.586] Build status: STARTED
[05:39:47.586] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:20:0) after 7m47s
[05:47:34.562] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:20:0)
[05:47:34.919] Build status: STARTED
[05:47:34.919] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:21:0) after 6m14s
[05:53:48.938] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:21:0)
[05:53:48.953] Build status: STARTED
[05:53:48.953] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:22:0) after 5m3s
[05:58:51.970] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:22:0)
[05:58:52.079] Build status: STARTED
[05:58:52.079] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:23:0) after 3m17s
[06:02:09.183] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:23:0)
[06:02:09.209] Build status: STARTED
[06:02:09.209] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:24:0) after 1m3s
[06:03:12.223] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:24:0)
[06:03:12.245] Build status: STARTED
[06:03:12.245] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:25:0) after 3m33s
[06:06:45.325] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:25:0)
[06:06:45.355] Build status: STARTED
[06:06:45.355] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:26:0) after 5m14s
[06:11:59.373] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:26:0)
[06:11:59.417] Build status: STARTED
[06:11:59.417] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:27:0) after 9m4s
[06:21:03.449] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:27:0)
[06:21:03.464] Build status: STARTED
[06:21:03.464] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:28:0) after 7m36s
[06:28:39.483] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:28:0)
[06:28:39.730] Build status: STARTED
[06:28:39.731] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:29:0) after 7m54s
[06:36:33.784] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:29:0)
[06:36:33.803] Build status: STARTED
[06:36:33.803] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:30:0) after 9m54s
[06:46:27.845] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:30:0)
[06:46:27.861] Build status: STARTED
[06:46:27.861] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:31:0) after 2m27s
[06:48:54.960] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:31:0)
[06:48:54.979] Build status: STARTED
[06:48:54.979] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:32:0) after 5m28s
[06:54:22.994] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:32:0)
[06:54:23.094] Build status: STARTED
[06:54:23.094] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:33:0) after 9m23s
[07:03:46.300] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:33:0)
[07:03:46.321] Build status: STARTED
[07:03:46.321] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:34:0) after 4m15s
[07:08:01.696] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:34:0)
[07:08:01.744] Build status: STARTED
[07:08:01.744] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:35:0) after 4m21s
[07:12:22.936] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:35:0)
[07:12:22.950] Build status: STARTED
[07:12:22.950] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:36:0) after 1m16s
[07:13:38.979] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:36:0)
[07:13:38.995] Build status: STARTED
[07:13:38.995] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:37:0) after 7m35s
[07:21:14.212] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:37:0)
[07:21:14.232] Build status: STARTED
[07:21:14.232] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:38:0) after 8m57s
[07:30:11.258] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:38:0)
[07:30:11.277] Build status: STARTED
[07:30:11.277] Scheduling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:39:0) after 5m0s
[07:35:11.361] Handling timer "check-buildbucket-build-status" (chromium-m148/mac-official:8850188615436300160:39:0)
[07:35:11.380] Build:
{
"id": "8684758553532143505",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "mac-official"
},
"number": 29,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-12T03:50:45.514544824Z",
"startTime": "2026-04-12T03:51:35.489616998Z",
"endTime": "2026-04-12T07:34:24.057253930Z",
"updateTime": "2026-04-12T07:34:24.057253930Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "467097774c141bc647606c2cef8d49023b9a39ec",
"ref": "refs/branch-heads/7778"
}
}
}
[07:35:11.380] Invocation finished in 3h44m27.065459855s with status SUCCEEDED