[15:10:55.355] New invocation is queued and will start shortly
[15:10:59.105] Starting the invocation (attempt 1)
[15:10:59.133] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41335647ee8506650766cf5d06a1aa58048bd1b6"
[15:10:59.133] Popped gitiles commit info from properties and tags
[15:10:59.133] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:10:59.133] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:10:59.133] Buildbucket request:
{
"requestId": "8847790300843724304",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "android-13-x64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8847790300843724304",
"job": "chromium-m149/android-13-x64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "46eecf77f6e467f364a02ccfa0bd3f33180cd2f5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@46eecf77f6e467f364a02ccfa0bd3f33180cd2f5",
"title": "46eecf77f6e467f364a02ccfa0bd3f33180cd2f5",
"url": "https://chromium.googlesource.com/chromium/src/+/46eecf77f6e467f364a02ccfa0bd3f33180cd2f5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "73ed998e1d3e34f12dd2ab0709558ddffba82114"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@73ed998e1d3e34f12dd2ab0709558ddffba82114",
"title": "73ed998e1d3e34f12dd2ab0709558ddffba82114",
"url": "https://chromium.googlesource.com/chromium/src/+/73ed998e1d3e34f12dd2ab0709558ddffba82114"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "647e617fc6ec4e61df603775e807cbb67acb7b77"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@647e617fc6ec4e61df603775e807cbb67acb7b77",
"title": "647e617fc6ec4e61df603775e807cbb67acb7b77",
"url": "https://chromium.googlesource.com/chromium/src/+/647e617fc6ec4e61df603775e807cbb67acb7b77"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b7c7a390be5665f3d030f6d27dcba7a91930656f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@b7c7a390be5665f3d030f6d27dcba7a91930656f",
"title": "b7c7a390be5665f3d030f6d27dcba7a91930656f",
"url": "https://chromium.googlesource.com/chromium/src/+/b7c7a390be5665f3d030f6d27dcba7a91930656f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "57d583effc1b1fcdcbd6b27adf97b91f5c8e73a6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@57d583effc1b1fcdcbd6b27adf97b91f5c8e73a6",
"title": "57d583effc1b1fcdcbd6b27adf97b91f5c8e73a6",
"url": "https://chromium.googlesource.com/chromium/src/+/57d583effc1b1fcdcbd6b27adf97b91f5c8e73a6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2ac38d02982395884cb0a3c8cd18c8e91dda7023"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@2ac38d02982395884cb0a3c8cd18c8e91dda7023",
"title": "2ac38d02982395884cb0a3c8cd18c8e91dda7023",
"url": "https://chromium.googlesource.com/chromium/src/+/2ac38d02982395884cb0a3c8cd18c8e91dda7023"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "41335647ee8506650766cf5d06a1aa58048bd1b6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@41335647ee8506650766cf5d06a1aa58048bd1b6",
"title": "41335647ee8506650766cf5d06a1aa58048bd1b6",
"url": "https://chromium.googlesource.com/chromium/src/+/41335647ee8506650766cf5d06a1aa58048bd1b6"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "41335647ee8506650766cf5d06a1aa58048bd1b6",
"ref": "refs/branch-heads/7827"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8847790300843724304"
},
{
"key": "scheduler_job_id",
"value": "chromium-m149/android-13-x64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:10:59.771] Scheduled build:
{
"id": "8682360236153758977",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "android-13-x64-rel"
},
"number": 35,
"createdBy": "project:chromium-m149",
"createTime": "2026-05-08T15:10:59.201655837Z",
"updateTime": "2026-05-08T15:10:59.201655837Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "41335647ee8506650766cf5d06a1aa58048bd1b6",
"ref": "refs/branch-heads/7827"
}
}
}
[15:10:59.771] Task URL: https://cr-buildbucket.appspot.com/build/8682360236153758977
[15:10:59.771] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:2:0) after 9m18s
[15:11:00.590] Received PubSub notification, asking Buildbucket for the build status
[15:11:00.613] Build status: SCHEDULED
[15:11:08.483] Received PubSub notification, asking Buildbucket for the build status
[15:11:08.506] Build status: STARTED
[15:20:17.808] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:2:0)
[15:20:17.838] Build status: STARTED
[15:20:17.838] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:5:0) after 7m8s
[15:27:26.004] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:5:0)
[15:27:26.081] Build status: STARTED
[15:27:26.081] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:6:0) after 4m53s
[15:32:19.141] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:6:0)
[15:32:19.164] Build status: STARTED
[15:32:19.165] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:7:0) after 2m20s
[15:34:39.171] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:7:0)
[15:34:39.225] Build status: STARTED
[15:34:39.225] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:8:0) after 6m39s
[15:41:18.249] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:8:0)
[15:41:18.275] Build status: STARTED
[15:41:18.275] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:9:0) after 3m53s
[15:45:11.370] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:9:0)
[15:45:11.489] Build status: STARTED
[15:45:11.489] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:10:0) after 4m49s
[15:50:00.650] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:10:0)
[15:50:00.674] Build status: STARTED
[15:50:00.674] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:11:0) after 5m32s
[15:55:32.784] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:11:0)
[15:55:32.903] Build status: STARTED
[15:55:32.903] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:12:0) after 2m29s
[15:58:02.032] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:12:0)
[15:58:02.054] Build status: STARTED
[15:58:02.054] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:13:0) after 5m47s
[16:03:49.183] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:13:0)
[16:03:49.242] Build status: STARTED
[16:03:49.242] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:14:0) after 6m8s
[16:09:57.255] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:14:0)
[16:09:57.277] Build status: STARTED
[16:09:57.277] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:15:0) after 9m23s
[16:19:20.295] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:15:0)
[16:19:20.323] Build status: STARTED
[16:19:20.324] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:16:0) after 5m29s
[16:24:49.363] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:16:0)
[16:24:49.382] Build status: STARTED
[16:24:49.382] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:17:0) after 6m46s
[16:31:35.440] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:17:0)
[16:31:35.490] Build status: STARTED
[16:31:35.490] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:18:0) after 5m51s
[16:37:26.780] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:18:0)
[16:37:26.809] Build status: STARTED
[16:37:26.809] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:19:0) after 7m58s
[16:45:24.977] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:19:0)
[16:45:25.004] Build status: STARTED
[16:45:25.004] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:20:0) after 1m57s
[16:47:22.020] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:20:0)
[16:47:22.040] Build status: STARTED
[16:47:22.041] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:21:0) after 3m30s
[16:50:52.110] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:21:0)
[16:50:52.125] Build status: STARTED
[16:50:52.125] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:22:0) after 2m23s
[16:53:15.142] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:22:0)
[16:53:15.160] Build status: STARTED
[16:53:15.160] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:23:0) after 8m6s
[17:01:21.176] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:23:0)
[17:01:21.199] Build status: STARTED
[17:01:21.199] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:24:0) after 2m32s
[17:03:53.452] Handling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:24:0)
[17:03:53.522] Build status: STARTED
[17:03:53.522] Scheduling timer "check-buildbucket-build-status" (chromium-m149/android-13-x64-rel:8847790300843724304:25:0) after 9m15s
[17:05:25.131] Received PubSub notification, asking Buildbucket for the build status
[17:05:25.147] Build:
{
"id": "8682360236153758977",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "android-13-x64-rel"
},
"number": 35,
"createdBy": "project:chromium-m149",
"createTime": "2026-05-08T15:10:59.201655837Z",
"startTime": "2026-05-08T15:11:08.317175704Z",
"endTime": "2026-05-08T17:05:24.417456462Z",
"updateTime": "2026-05-08T17:05:24.417456462Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "41335647ee8506650766cf5d06a1aa58048bd1b6",
"ref": "refs/branch-heads/7827"
}
}
}
[17:05:25.147] Invocation finished in 1h54m29.802214238s with status SUCCEEDED