[10:48:54.866] New invocation is queued and will start shortly
[10:48:55.961] Starting the invocation (attempt 1)
[10:48:55.985] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a"
[10:48:55.985] Popped gitiles commit info from properties and tags
[10:48:55.985] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:48:55.985] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:48:55.986] Buildbucket request:
{
"requestId": "8836300970233055776",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "android-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836300970233055776",
"job": "chromium-m154/android-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d975ac68450f85f52f26245187198c87d505fc5c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@d975ac68450f85f52f26245187198c87d505fc5c",
"title": "d975ac68450f85f52f26245187198c87d505fc5c",
"url": "https://chromium.googlesource.com/chromium/src/+/d975ac68450f85f52f26245187198c87d505fc5c"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7ae1a27678f6a58ae587c4975721953d799a4a25"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@7ae1a27678f6a58ae587c4975721953d799a4a25",
"title": "7ae1a27678f6a58ae587c4975721953d799a4a25",
"url": "https://chromium.googlesource.com/chromium/src/+/7ae1a27678f6a58ae587c4975721953d799a4a25"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "30c4b686d8ef3193b3b6f435a80446fd46758c73"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@30c4b686d8ef3193b3b6f435a80446fd46758c73",
"title": "30c4b686d8ef3193b3b6f435a80446fd46758c73",
"url": "https://chromium.googlesource.com/chromium/src/+/30c4b686d8ef3193b3b6f435a80446fd46758c73"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "db205a6a2c17893e99366b9c03583325aca976f9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@db205a6a2c17893e99366b9c03583325aca976f9",
"title": "db205a6a2c17893e99366b9c03583325aca976f9",
"url": "https://chromium.googlesource.com/chromium/src/+/db205a6a2c17893e99366b9c03583325aca976f9"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0441b24d45582c3c62bf4b998f76a1482dfc6e01"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@0441b24d45582c3c62bf4b998f76a1482dfc6e01",
"title": "0441b24d45582c3c62bf4b998f76a1482dfc6e01",
"url": "https://chromium.googlesource.com/chromium/src/+/0441b24d45582c3c62bf4b998f76a1482dfc6e01"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a",
"title": "20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a",
"url": "https://chromium.googlesource.com/chromium/src/+/20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a",
"ref": "refs/branch-heads/8037"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836300970233055776"
},
{
"key": "scheduler_job_id",
"value": "chromium-m154/android-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:48:56.603] Scheduled build:
{
"id": "8670870908335917105",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "android-official"
},
"number": 147,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-12T10:48:56.053995781Z",
"updateTime": "2026-09-12T10:48:56.053995781Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a",
"ref": "refs/branch-heads/8037"
}
}
}
[10:48:56.603] Task URL: https://cr-buildbucket.appspot.com/build/8670870908335917105
[10:48:56.603] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:2:0) after 9m54s
[10:48:57.497] Received PubSub notification, asking Buildbucket for the build status
[10:48:57.522] Build status: SCHEDULED
[10:49:46.155] Received PubSub notification, asking Buildbucket for the build status
[10:49:46.193] Build status: STARTED
[10:58:50.936] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:2:0)
[10:58:50.959] Build status: STARTED
[10:58:50.959] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:5:0) after 2m1s
[11:00:51.946] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:5:0)
[11:00:51.971] Build status: STARTED
[11:00:51.971] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:6:0) after 4m42s
[11:05:33.986] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:6:0)
[11:05:34.007] Build status: STARTED
[11:05:34.007] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:7:0) after 8m27s
[11:14:01.073] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:7:0)
[11:14:01.101] Build status: STARTED
[11:14:01.101] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:8:0) after 4m44s
[11:18:45.169] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:8:0)
[11:18:45.323] Build status: STARTED
[11:18:45.323] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:9:0) after 5m5s
[11:23:50.339] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:9:0)
[11:23:50.361] Build status: STARTED
[11:23:50.361] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:10:0) after 3m18s
[11:27:08.350] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:10:0)
[11:27:08.402] Build status: STARTED
[11:27:08.402] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:11:0) after 6m52s
[11:34:00.466] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:11:0)
[11:34:00.489] Build status: STARTED
[11:34:00.490] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:12:0) after 4m55s
[11:38:55.588] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:12:0)
[11:38:55.605] Build status: STARTED
[11:38:55.605] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:13:0) after 4m43s
[11:43:38.620] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:13:0)
[11:43:38.696] Build status: STARTED
[11:43:38.696] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:14:0) after 9m57s
[11:53:35.711] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:14:0)
[11:53:35.729] Build status: STARTED
[11:53:35.729] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:15:0) after 6m33s
[12:00:09.070] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:15:0)
[12:00:09.090] Build status: STARTED
[12:00:09.090] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:16:0) after 7m1s
[12:07:10.105] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:16:0)
[12:07:10.173] Build status: STARTED
[12:07:10.173] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:17:0) after 8m16s
[12:15:26.186] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:17:0)
[12:15:26.207] Build status: STARTED
[12:15:26.207] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:18:0) after 9m59s
[12:25:25.274] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:18:0)
[12:25:25.291] Build status: STARTED
[12:25:25.291] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:19:0) after 6m14s
[12:31:39.313] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:19:0)
[12:31:39.341] Build status: STARTED
[12:31:39.341] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:20:0) after 1m58s
[12:33:37.442] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:20:0)
[12:33:37.464] Build status: STARTED
[12:33:37.465] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:21:0) after 4m53s
[12:38:30.481] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:21:0)
[12:38:30.503] Build status: STARTED
[12:38:30.503] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:22:0) after 4m28s
[12:42:58.523] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:22:0)
[12:42:58.543] Build status: STARTED
[12:42:58.543] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:23:0) after 1m51s
[12:44:49.603] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:23:0)
[12:44:49.699] Build status: STARTED
[12:44:49.699] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:24:0) after 8m10s
[12:52:59.771] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:24:0)
[12:52:59.812] Build status: STARTED
[12:52:59.812] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:25:0) after 3m40s
[12:56:39.827] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:25:0)
[12:56:39.847] Build status: STARTED
[12:56:39.847] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:26:0) after 6m45s
[13:03:24.866] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:26:0)
[13:03:25.036] Build status: STARTED
[13:03:25.036] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:27:0) after 2m19s
[13:05:44.053] Handling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:27:0)
[13:05:44.102] Build status: STARTED
[13:05:44.102] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-official:8836300970233055776:28:0) after 7m53s
[13:08:58.714] Received PubSub notification, asking Buildbucket for the build status
[13:08:58.740] Build:
{
"id": "8670870908335917105",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "android-official"
},
"number": 147,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-12T10:48:56.053995781Z",
"startTime": "2026-09-12T10:49:45.945914945Z",
"endTime": "2026-09-12T13:08:58.202881660Z",
"updateTime": "2026-09-12T13:08:58.202881660Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20a2cdd5120aaff7fd531088e3d0d17ca17e9a4a",
"ref": "refs/branch-heads/8037"
}
}
}
[13:08:58.740] Invocation finished in 2h20m3.879380639s with status SUCCEEDED