[17:38:13.199] New invocation is queued and will start shortly
[17:38:18.026] Starting the invocation (attempt 1)
[17:38:18.058] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/57cc8839dde18bae6fdcd0853bd12b4850aa14fc"
[17:38:18.058] Popped gitiles commit info from properties and tags
[17:38:18.058] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:38:18.059] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:38:18.060] Buildbucket request:
{
"requestId": "8851857897175199888",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "android-desktop-x64-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851857897175199888",
"job": "chromium-m146/android-desktop-x64-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ef7f799729a0fde7f20d7cf8bd52aecbebaa92f5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@ef7f799729a0fde7f20d7cf8bd52aecbebaa92f5",
"title": "ef7f799729a0fde7f20d7cf8bd52aecbebaa92f5",
"url": "https://chromium.googlesource.com/chromium/src/+/ef7f799729a0fde7f20d7cf8bd52aecbebaa92f5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4767b9da59c06ef988473e1738d504eced31a1de"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@4767b9da59c06ef988473e1738d504eced31a1de",
"title": "4767b9da59c06ef988473e1738d504eced31a1de",
"url": "https://chromium.googlesource.com/chromium/src/+/4767b9da59c06ef988473e1738d504eced31a1de"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f9d45f535b1f69b26f8d1d34f82737aa8d86f5b6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@f9d45f535b1f69b26f8d1d34f82737aa8d86f5b6",
"title": "f9d45f535b1f69b26f8d1d34f82737aa8d86f5b6",
"url": "https://chromium.googlesource.com/chromium/src/+/f9d45f535b1f69b26f8d1d34f82737aa8d86f5b6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8878bf91337d910dd69228a99ce0a86e1bbb0f9c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@8878bf91337d910dd69228a99ce0a86e1bbb0f9c",
"title": "8878bf91337d910dd69228a99ce0a86e1bbb0f9c",
"url": "https://chromium.googlesource.com/chromium/src/+/8878bf91337d910dd69228a99ce0a86e1bbb0f9c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f2cd2590073228070e291a05025ffe760937db77"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@f2cd2590073228070e291a05025ffe760937db77",
"title": "f2cd2590073228070e291a05025ffe760937db77",
"url": "https://chromium.googlesource.com/chromium/src/+/f2cd2590073228070e291a05025ffe760937db77"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f86b2046d1a29303a5e6ef6f06b65e945ab9420"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@4f86b2046d1a29303a5e6ef6f06b65e945ab9420",
"title": "4f86b2046d1a29303a5e6ef6f06b65e945ab9420",
"url": "https://chromium.googlesource.com/chromium/src/+/4f86b2046d1a29303a5e6ef6f06b65e945ab9420"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa7e7987b026ab8de4ec68a6e1b01a83091a5d28"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@aa7e7987b026ab8de4ec68a6e1b01a83091a5d28",
"title": "aa7e7987b026ab8de4ec68a6e1b01a83091a5d28",
"url": "https://chromium.googlesource.com/chromium/src/+/aa7e7987b026ab8de4ec68a6e1b01a83091a5d28"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1d1c729d3b6a9663f61deb36700c2e4531596e75"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@1d1c729d3b6a9663f61deb36700c2e4531596e75",
"title": "1d1c729d3b6a9663f61deb36700c2e4531596e75",
"url": "https://chromium.googlesource.com/chromium/src/+/1d1c729d3b6a9663f61deb36700c2e4531596e75"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8e1b8c9da50721036f963c70f2b47cdef630bbef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@8e1b8c9da50721036f963c70f2b47cdef630bbef",
"title": "8e1b8c9da50721036f963c70f2b47cdef630bbef",
"url": "https://chromium.googlesource.com/chromium/src/+/8e1b8c9da50721036f963c70f2b47cdef630bbef"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "57cc8839dde18bae6fdcd0853bd12b4850aa14fc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@57cc8839dde18bae6fdcd0853bd12b4850aa14fc",
"title": "57cc8839dde18bae6fdcd0853bd12b4850aa14fc",
"url": "https://chromium.googlesource.com/chromium/src/+/57cc8839dde18bae6fdcd0853bd12b4850aa14fc"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "57cc8839dde18bae6fdcd0853bd12b4850aa14fc",
"ref": "refs/branch-heads/7680"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851857897175199888"
},
{
"key": "scheduler_job_id",
"value": "chromium-m146/android-desktop-x64-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:38:18.609] Scheduled build:
{
"id": "8686427831365593041",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "android-desktop-x64-official"
},
"number": 272,
"createdBy": "project:chromium-m146",
"createTime": "2026-03-24T17:38:18.118317369Z",
"updateTime": "2026-03-24T17:38:18.118317369Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "57cc8839dde18bae6fdcd0853bd12b4850aa14fc",
"ref": "refs/branch-heads/7680"
}
},
"canary": true
}
[17:38:18.609] Task URL: https://cr-buildbucket.appspot.com/build/8686427831365593041
[17:38:18.609] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:2:0) after 3m33s
[17:38:19.518] Received PubSub notification, asking Buildbucket for the build status
[17:38:19.600] Build status: SCHEDULED
[17:39:02.646] Received PubSub notification, asking Buildbucket for the build status
[17:39:02.686] Build status: STARTED
[17:41:51.652] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:2:0)
[17:41:51.789] Build status: STARTED
[17:41:51.789] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:5:0) after 7m51s
[17:49:42.804] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:5:0)
[17:49:42.826] Build status: STARTED
[17:49:42.826] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:6:0) after 5m27s
[17:55:09.868] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:6:0)
[17:55:09.925] Build status: STARTED
[17:55:09.925] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:7:0) after 7m28s
[18:02:38.417] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:7:0)
[18:02:38.491] Build status: STARTED
[18:02:38.491] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:8:0) after 2m8s
[18:04:46.554] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:8:0)
[18:04:46.673] Build status: STARTED
[18:04:46.673] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:9:0) after 8m25s
[18:13:12.017] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:9:0)
[18:13:12.048] Build status: STARTED
[18:13:12.048] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:10:0) after 9m13s
[18:22:25.200] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:10:0)
[18:22:25.216] Build status: STARTED
[18:22:25.216] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:11:0) after 9m48s
[18:32:13.232] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:11:0)
[18:32:13.280] Build status: STARTED
[18:32:13.280] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:12:0) after 6m25s
[18:38:38.341] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:12:0)
[18:38:38.356] Build status: STARTED
[18:38:38.356] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:13:0) after 3m29s
[18:42:07.368] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:13:0)
[18:42:07.391] Build status: STARTED
[18:42:07.391] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:14:0) after 5m30s
[18:47:37.355] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:14:0)
[18:47:37.372] Build status: STARTED
[18:47:37.372] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:15:0) after 7m35s
[18:55:12.411] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:15:0)
[18:55:12.429] Build status: STARTED
[18:55:12.429] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:16:0) after 5m38s
[19:00:50.524] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:16:0)
[19:00:50.541] Build status: STARTED
[19:00:50.541] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:17:0) after 5m57s
[19:06:47.582] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:17:0)
[19:06:47.621] Build status: STARTED
[19:06:47.621] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:18:0) after 9m17s
[19:16:04.684] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:18:0)
[19:16:04.727] Build status: STARTED
[19:16:04.727] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:19:0) after 3m5s
[19:19:09.744] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:19:0)
[19:19:09.763] Build status: STARTED
[19:19:09.763] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:20:0) after 6m38s
[19:25:47.778] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:20:0)
[19:25:47.806] Build status: STARTED
[19:25:47.806] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:21:0) after 9m8s
[19:34:55.820] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:21:0)
[19:34:55.837] Build status: STARTED
[19:34:55.837] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:22:0) after 9m53s
[19:44:48.880] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:22:0)
[19:44:48.901] Build status: STARTED
[19:44:48.902] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:23:0) after 1m59s
[19:46:47.939] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:23:0)
[19:46:47.959] Build status: STARTED
[19:46:47.959] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:24:0) after 1m24s
[19:48:12.078] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:24:0)
[19:48:12.196] Build status: STARTED
[19:48:12.196] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:25:0) after 4m47s
[19:52:59.272] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:25:0)
[19:52:59.295] Build status: STARTED
[19:52:59.295] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:26:0) after 6m50s
[19:59:49.346] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:26:0)
[19:59:49.392] Build status: STARTED
[19:59:49.392] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:27:0) after 9m12s
[20:09:01.486] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:27:0)
[20:09:01.509] Build status: STARTED
[20:09:01.509] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:28:0) after 8m30s
[20:17:31.618] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:28:0)
[20:17:31.645] Build status: STARTED
[20:17:31.645] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:29:0) after 4m35s
[20:22:06.699] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:29:0)
[20:22:06.719] Build status: STARTED
[20:22:06.719] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:30:0) after 4m34s
[20:26:40.772] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:30:0)
[20:26:40.793] Build status: STARTED
[20:26:40.793] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:31:0) after 3m45s
[20:30:25.814] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:31:0)
[20:30:25.834] Build status: STARTED
[20:30:25.834] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:32:0) after 9m53s
[20:40:18.898] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:32:0)
[20:40:18.916] Build status: STARTED
[20:40:18.916] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:33:0) after 7m31s
[20:47:49.917] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:33:0)
[20:47:49.932] Build status: STARTED
[20:47:49.932] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:34:0) after 5m17s
[20:53:06.961] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:34:0)
[20:53:06.983] Build status: STARTED
[20:53:06.983] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:35:0) after 3m33s
[20:56:40.045] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:35:0)
[20:56:40.065] Build status: STARTED
[20:56:40.065] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:36:0) after 3m40s
[21:00:20.086] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:36:0)
[21:00:20.113] Build status: STARTED
[21:00:20.113] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:37:0) after 5m39s
[21:05:59.132] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:37:0)
[21:05:59.150] Build status: STARTED
[21:05:59.150] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:38:0) after 1m11s
[21:07:10.188] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:38:0)
[21:07:10.267] Build status: STARTED
[21:07:10.267] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:39:0) after 4m32s
[21:11:42.331] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:39:0)
[21:11:42.350] Build status: STARTED
[21:11:42.350] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:40:0) after 4m30s
[21:16:12.354] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:40:0)
[21:16:12.375] Build status: STARTED
[21:16:12.375] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:41:0) after 6m34s
[21:22:46.374] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:41:0)
[21:22:46.393] Build status: STARTED
[21:22:46.393] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:42:0) after 4m24s
[21:27:10.415] Handling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:42:0)
[21:27:10.433] Build status: STARTED
[21:27:10.433] Scheduling timer "check-buildbucket-build-status" (chromium-m146/android-desktop-x64-official:8851857897175199888:43:0) after 6m29s
[21:29:02.690] Received PubSub notification, asking Buildbucket for the build status
[21:29:02.712] Build:
{
"id": "8686427831365593041",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "android-desktop-x64-official"
},
"number": 272,
"createdBy": "project:chromium-m146",
"createTime": "2026-03-24T17:38:18.118317369Z",
"startTime": "2026-03-24T17:39:02.447066342Z",
"endTime": "2026-03-24T21:29:02.275755866Z",
"updateTime": "2026-03-24T21:29:02.275755866Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "57cc8839dde18bae6fdcd0853bd12b4850aa14fc",
"ref": "refs/branch-heads/7680"
}
},
"canary": true
}
[21:29:02.712] Invocation finished in 3h50m49.51828952s with status SUCCEEDED