[16:39:06.919] New invocation is queued and will start shortly
[16:39:09.505] Starting the invocation (attempt 1)
[16:39:09.530] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba2fb6f66133b73bd91c05c551b0af488ec20d61"
[16:39:09.530] Popped gitiles commit info from properties and tags
[16:39:09.530] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:39:09.530] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:39:09.531] Buildbucket request:
{
"requestId": "8846154006834594080",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8846154006834594080",
"job": "chromium-m148/android-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d9b5b6da3e1e594714d82139eeb6ca925af03817"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d9b5b6da3e1e594714d82139eeb6ca925af03817",
"title": "d9b5b6da3e1e594714d82139eeb6ca925af03817",
"url": "https://chromium.googlesource.com/chromium/src/+/d9b5b6da3e1e594714d82139eeb6ca925af03817"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "286a468396f022c7f389760b337ddfbb71450adc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@286a468396f022c7f389760b337ddfbb71450adc",
"title": "286a468396f022c7f389760b337ddfbb71450adc",
"url": "https://chromium.googlesource.com/chromium/src/+/286a468396f022c7f389760b337ddfbb71450adc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3d3a89b3191db2722e1273c0dbd0bdc278d3f50e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@3d3a89b3191db2722e1273c0dbd0bdc278d3f50e",
"title": "3d3a89b3191db2722e1273c0dbd0bdc278d3f50e",
"url": "https://chromium.googlesource.com/chromium/src/+/3d3a89b3191db2722e1273c0dbd0bdc278d3f50e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08",
"title": "f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08",
"url": "https://chromium.googlesource.com/chromium/src/+/f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3",
"title": "ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3",
"url": "https://chromium.googlesource.com/chromium/src/+/ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "901f9caae8cec6c0c59f02de96b67c5e88695bcd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@901f9caae8cec6c0c59f02de96b67c5e88695bcd",
"title": "901f9caae8cec6c0c59f02de96b67c5e88695bcd",
"url": "https://chromium.googlesource.com/chromium/src/+/901f9caae8cec6c0c59f02de96b67c5e88695bcd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4336bba0289bd39f53aa652f99949a3af83f27b8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4336bba0289bd39f53aa652f99949a3af83f27b8",
"title": "4336bba0289bd39f53aa652f99949a3af83f27b8",
"url": "https://chromium.googlesource.com/chromium/src/+/4336bba0289bd39f53aa652f99949a3af83f27b8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "faa39db240026ffe6c93d4250e5ee4ed628ad925"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@faa39db240026ffe6c93d4250e5ee4ed628ad925",
"title": "faa39db240026ffe6c93d4250e5ee4ed628ad925",
"url": "https://chromium.googlesource.com/chromium/src/+/faa39db240026ffe6c93d4250e5ee4ed628ad925"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "52f2425c43f2ca0091b7b28f5aadb2cdffff25a8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@52f2425c43f2ca0091b7b28f5aadb2cdffff25a8",
"title": "52f2425c43f2ca0091b7b28f5aadb2cdffff25a8",
"url": "https://chromium.googlesource.com/chromium/src/+/52f2425c43f2ca0091b7b28f5aadb2cdffff25a8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"title": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"url": "https://chromium.googlesource.com/chromium/src/+/8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "73f3144865a5b1126ab782cf0d706437058b277f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@73f3144865a5b1126ab782cf0d706437058b277f",
"title": "73f3144865a5b1126ab782cf0d706437058b277f",
"url": "https://chromium.googlesource.com/chromium/src/+/73f3144865a5b1126ab782cf0d706437058b277f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ba2fb6f66133b73bd91c05c551b0af488ec20d61"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@ba2fb6f66133b73bd91c05c551b0af488ec20d61",
"title": "ba2fb6f66133b73bd91c05c551b0af488ec20d61",
"url": "https://chromium.googlesource.com/chromium/src/+/ba2fb6f66133b73bd91c05c551b0af488ec20d61"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ba2fb6f66133b73bd91c05c551b0af488ec20d61",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8846154006834594080"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/android-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:39:10.182] Scheduled build:
{
"id": "8680723943370349457",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-official"
},
"number": 673,
"createdBy": "project:chromium-m148",
"createTime": "2026-05-26T16:39:09.602524500Z",
"updateTime": "2026-05-26T16:39:09.602524500Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ba2fb6f66133b73bd91c05c551b0af488ec20d61",
"ref": "refs/branch-heads/7778"
}
}
}
[16:39:10.182] Task URL: https://cr-buildbucket.appspot.com/build/8680723943370349457
[16:39:10.182] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:2:0) after 9m51s
[16:39:11.092] Received PubSub notification, asking Buildbucket for the build status
[16:39:11.115] Build status: SCHEDULED
[16:39:56.583] Received PubSub notification, asking Buildbucket for the build status
[16:39:56.605] Build status: STARTED
[16:49:01.283] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:2:0)
[16:49:01.303] Build status: STARTED
[16:49:01.303] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:5:0) after 3m57s
[16:52:58.316] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:5:0)
[16:52:58.339] Build status: STARTED
[16:52:58.339] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:6:0) after 4m20s
[16:57:18.356] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:6:0)
[16:57:18.378] Build status: STARTED
[16:57:18.378] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:7:0) after 2m33s
[16:59:51.390] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:7:0)
[16:59:51.650] Build status: STARTED
[16:59:51.650] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:8:0) after 4m0s
[17:03:51.671] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:8:0)
[17:03:51.700] Build status: STARTED
[17:03:51.700] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:9:0) after 3m5s
[17:06:56.718] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:9:0)
[17:06:56.745] Build status: STARTED
[17:06:56.745] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:10:0) after 8m40s
[17:15:36.804] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:10:0)
[17:15:36.824] Build status: STARTED
[17:15:36.825] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:11:0) after 4m5s
[17:19:41.893] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:11:0)
[17:19:41.923] Build status: STARTED
[17:19:41.923] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:12:0) after 5m37s
[17:25:19.009] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:12:0)
[17:25:19.043] Build status: STARTED
[17:25:19.043] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:13:0) after 7m10s
[17:32:29.114] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:13:0)
[17:32:29.161] Build status: STARTED
[17:32:29.161] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:14:0) after 6m57s
[17:39:26.194] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:14:0)
[17:39:26.296] Build status: STARTED
[17:39:26.296] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:15:0) after 4m11s
[17:43:37.425] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:15:0)
[17:43:37.442] Build status: STARTED
[17:43:37.442] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:16:0) after 4m1s
[17:47:38.494] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:16:0)
[17:47:38.525] Build status: STARTED
[17:47:38.525] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:17:0) after 6m3s
[17:53:41.537] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:17:0)
[17:53:41.582] Build status: STARTED
[17:53:41.595] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:18:0) after 2m6s
[17:55:47.611] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:18:0)
[17:55:47.630] Build status: STARTED
[17:55:47.630] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:19:0) after 7m28s
[18:03:15.647] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:19:0)
[18:03:15.669] Build status: STARTED
[18:03:15.669] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:20:0) after 4m11s
[18:07:26.689] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:20:0)
[18:07:26.720] Build status: STARTED
[18:07:26.721] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:21:0) after 3m30s
[18:10:56.779] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:21:0)
[18:10:56.858] Build status: STARTED
[18:10:56.858] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:22:0) after 4m58s
[18:15:56.373] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:22:0)
[18:15:56.402] Build status: STARTED
[18:15:56.402] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:23:0) after 5m27s
[18:21:23.429] Handling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:23:0)
[18:21:23.452] Build status: STARTED
[18:21:23.452] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-official:8846154006834594080:24:0) after 6m53s
[18:24:12.672] Received PubSub notification, asking Buildbucket for the build status
[18:24:12.699] Build:
{
"id": "8680723943370349457",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-official"
},
"number": 673,
"createdBy": "project:chromium-m148",
"createTime": "2026-05-26T16:39:09.602524500Z",
"startTime": "2026-05-26T16:39:56.321719638Z",
"endTime": "2026-05-26T18:24:12.137036370Z",
"updateTime": "2026-05-26T18:24:12.137036370Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ba2fb6f66133b73bd91c05c551b0af488ec20d61",
"ref": "refs/branch-heads/7778"
}
}
}
[18:24:12.699] Invocation finished in 1h45m5.784539688s with status SUCCEEDED