[11:57:41.173] New invocation is queued and will start shortly
[11:57:42.478] Starting the invocation (attempt 1)
[11:57:42.499] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0fd60e91afe815564f64f7eefc92ad2bb650957"
[11:57:42.499] Popped gitiles commit info from properties and tags
[11:57:42.499] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:57:42.499] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:57:42.500] Buildbucket request:
{
"requestId": "8846715294621798496",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-desktop-x64-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8846715294621798496",
"job": "chromium-m148/android-desktop-x64-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "22e8ff55cf3efb492ec417ef410486e623ab0db5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@22e8ff55cf3efb492ec417ef410486e623ab0db5",
"title": "22e8ff55cf3efb492ec417ef410486e623ab0db5",
"url": "https://chromium.googlesource.com/chromium/src/+/22e8ff55cf3efb492ec417ef410486e623ab0db5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cdbc96d51307fd7a9d1b1bbbf8fa9f9781760313"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@cdbc96d51307fd7a9d1b1bbbf8fa9f9781760313",
"title": "cdbc96d51307fd7a9d1b1bbbf8fa9f9781760313",
"url": "https://chromium.googlesource.com/chromium/src/+/cdbc96d51307fd7a9d1b1bbbf8fa9f9781760313"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0e3a655f65eef45b1146032a8431aa492a1f1d14"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@0e3a655f65eef45b1146032a8431aa492a1f1d14",
"title": "0e3a655f65eef45b1146032a8431aa492a1f1d14",
"url": "https://chromium.googlesource.com/chromium/src/+/0e3a655f65eef45b1146032a8431aa492a1f1d14"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "40faa3a9d7c1ca6b58e2628738adc3db873822b8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@40faa3a9d7c1ca6b58e2628738adc3db873822b8",
"title": "40faa3a9d7c1ca6b58e2628738adc3db873822b8",
"url": "https://chromium.googlesource.com/chromium/src/+/40faa3a9d7c1ca6b58e2628738adc3db873822b8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d60c489b22da4287fdfa09d053c923b02643de47"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d60c489b22da4287fdfa09d053c923b02643de47",
"title": "d60c489b22da4287fdfa09d053c923b02643de47",
"url": "https://chromium.googlesource.com/chromium/src/+/d60c489b22da4287fdfa09d053c923b02643de47"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92b228b9f0dfd51e1f0ec4df066132cb4decdfa2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@92b228b9f0dfd51e1f0ec4df066132cb4decdfa2",
"title": "92b228b9f0dfd51e1f0ec4df066132cb4decdfa2",
"url": "https://chromium.googlesource.com/chromium/src/+/92b228b9f0dfd51e1f0ec4df066132cb4decdfa2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e0fd60e91afe815564f64f7eefc92ad2bb650957"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@e0fd60e91afe815564f64f7eefc92ad2bb650957",
"title": "e0fd60e91afe815564f64f7eefc92ad2bb650957",
"url": "https://chromium.googlesource.com/chromium/src/+/e0fd60e91afe815564f64f7eefc92ad2bb650957"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e0fd60e91afe815564f64f7eefc92ad2bb650957",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8846715294621798496"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/android-desktop-x64-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:57:42.973] Scheduled build:
{
"id": "8681285232512777313",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-desktop-x64-official"
},
"number": 289,
"createdBy": "project:chromium-m148",
"createTime": "2026-05-20T11:57:42.563180758Z",
"updateTime": "2026-05-20T11:57:42.563180758Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e0fd60e91afe815564f64f7eefc92ad2bb650957",
"ref": "refs/branch-heads/7778"
}
}
}
[11:57:42.973] Task URL: https://cr-buildbucket.appspot.com/build/8681285232512777313
[11:57:42.973] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:2:0) after 9m18s
[11:57:43.998] Received PubSub notification, asking Buildbucket for the build status
[11:57:44.081] Build status: SCHEDULED
[11:57:47.586] Received PubSub notification, asking Buildbucket for the build status
[11:57:47.607] Build status: STARTED
[12:07:00.994] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:2:0)
[12:07:01.133] Build status: STARTED
[12:07:01.133] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:5:0) after 4m55s
[12:11:56.174] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:5:0)
[12:11:56.204] Build status: STARTED
[12:11:56.204] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:6:0) after 5m20s
[12:17:16.217] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:6:0)
[12:17:16.272] Build status: STARTED
[12:17:16.272] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:7:0) after 4m18s
[12:21:34.286] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:7:0)
[12:21:34.375] Build status: STARTED
[12:21:34.375] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:8:0) after 8m9s
[12:29:43.423] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:8:0)
[12:29:43.441] Build status: STARTED
[12:29:43.441] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:9:0) after 6m16s
[12:35:59.508] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:9:0)
[12:35:59.523] Build status: STARTED
[12:35:59.523] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:10:0) after 3m26s
[12:39:25.537] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:10:0)
[12:39:25.859] Build status: STARTED
[12:39:25.859] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:11:0) after 7m17s
[12:46:42.874] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:11:0)
[12:46:42.904] Build status: STARTED
[12:46:42.904] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:12:0) after 8m38s
[12:55:20.942] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:12:0)
[12:55:20.965] Build status: STARTED
[12:55:20.965] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:13:0) after 7m51s
[13:03:12.002] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:13:0)
[13:03:12.037] Build status: STARTED
[13:03:12.037] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:14:0) after 2m46s
[13:05:58.003] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:14:0)
[13:05:58.025] Build status: STARTED
[13:05:58.025] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:15:0) after 6m37s
[13:12:35.040] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:15:0)
[13:12:35.067] Build status: STARTED
[13:12:35.067] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:16:0) after 1m37s
[13:14:12.084] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:16:0)
[13:14:12.098] Build status: STARTED
[13:14:12.098] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:17:0) after 2m6s
[13:16:18.259] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:17:0)
[13:16:18.291] Build status: STARTED
[13:16:18.291] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:18:0) after 6m21s
[13:22:39.298] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:18:0)
[13:22:39.356] Build status: STARTED
[13:22:39.357] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:19:0) after 5m4s
[13:27:43.373] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:19:0)
[13:27:43.392] Build status: STARTED
[13:27:43.392] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:20:0) after 2m32s
[13:30:15.548] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:20:0)
[13:30:15.620] Build status: STARTED
[13:30:15.620] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:21:0) after 1m46s
[13:32:01.723] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:21:0)
[13:32:01.753] Build status: STARTED
[13:32:01.753] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:22:0) after 6m32s
[13:38:33.854] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:22:0)
[13:38:33.907] Build status: STARTED
[13:38:33.907] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:23:0) after 7m23s
[13:45:56.916] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:23:0)
[13:45:56.939] Build status: STARTED
[13:45:56.939] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:24:0) after 9m8s
[13:55:05.035] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:24:0)
[13:55:05.055] Build status: STARTED
[13:55:05.055] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:25:0) after 5m5s
[14:00:10.074] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:25:0)
[14:00:10.130] Build status: STARTED
[14:00:10.131] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:26:0) after 1m24s
[14:01:34.161] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:26:0)
[14:01:34.337] Build status: STARTED
[14:01:34.337] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:27:0) after 8m36s
[14:10:10.371] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:27:0)
[14:10:10.401] Build status: STARTED
[14:10:10.401] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:28:0) after 5m18s
[14:15:28.492] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:28:0)
[14:15:28.520] Build status: STARTED
[14:15:28.520] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:29:0) after 5m56s
[14:21:24.592] Handling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:29:0)
[14:21:24.621] Build status: STARTED
[14:21:24.621] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-desktop-x64-official:8846715294621798496:30:0) after 9m2s
[14:26:46.955] Received PubSub notification, asking Buildbucket for the build status
[14:26:47.076] Build:
{
"id": "8681285232512777313",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-desktop-x64-official"
},
"number": 289,
"createdBy": "project:chromium-m148",
"createTime": "2026-05-20T11:57:42.563180758Z",
"startTime": "2026-05-20T11:57:47.135033627Z",
"endTime": "2026-05-20T14:26:46.386242116Z",
"updateTime": "2026-05-20T14:26:46.386242116Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e0fd60e91afe815564f64f7eefc92ad2bb650957",
"ref": "refs/branch-heads/7778"
}
}
}
[14:26:47.076] Invocation finished in 2h29m5.908183268s with status SUCCEEDED